builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0053 starttime: 1455715754.41 results: success (0) buildid: 20160217033849 builduid: aeaf16acf41a4fc8909d2878d402428b revision: 53b0b5b29776127567c8e685f270f4b1639baeaa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.413250) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.413671) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.413967) ========= 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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005739 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.435852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.436175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.451859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.452491) ========= 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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005628 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.503886) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.504200) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.504547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.504823) ========= 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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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-02-17 05:29:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 65.8M=0s 2016-02-17 05:29:14 (65.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.663681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.664219) ========= 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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.019326 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.713915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:14.714290) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 53b0b5b29776127567c8e685f270f4b1639baeaa --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 53b0b5b29776127567c8e685f270f4b1639baeaa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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-02-17 05:29:14,781 truncating revision to first 12 chars 2016-02-17 05:29:14,781 Setting DEBUG logging. 2016-02-17 05:29:14,781 attempt 1/10 2016-02-17 05:29:14,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/53b0b5b29776?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 05:29:15,211 unpacking tar archive at: fx-team-53b0b5b29776/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684733 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:15.414689) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:15.415034) ========= echo 53b0b5b29776127567c8e685f270f4b1639baeaa in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'53b0b5b29776127567c8e685f270f4b1639baeaa'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 53b0b5b29776127567c8e685f270f4b1639baeaa program finished with exit code 0 elapsedTime=0.005129 script_repo_revision: '53b0b5b29776127567c8e685f270f4b1639baeaa' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:15.464850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:15.465186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 05:29:15.478574) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-17 05:29:15.478954) ========= /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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:29:15 INFO - MultiFileLogger online at 20160217 05:29:15 in /builds/slave/test 05:29:15 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 05:29:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:15 INFO - {'append_to_log': False, 05:29:15 INFO - 'base_work_dir': '/builds/slave/test', 05:29:15 INFO - 'blob_upload_branch': 'Fx-Team', 05:29:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:15 INFO - 'branch': 'Fx-Team', 05:29:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:15 INFO - 'config_files': ('talos/mac_config.py',), 05:29:15 INFO - 'default_actions': ('clobber', 05:29:15 INFO - 'read-buildbot-config', 05:29:15 INFO - 'download-and-extract', 05:29:15 INFO - 'populate-webroot', 05:29:15 INFO - 'create-virtualenv', 05:29:15 INFO - 'install', 05:29:15 INFO - 'run-tests'), 05:29:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:15 INFO - 'download_minidump_stackwalk': True, 05:29:15 INFO - 'download_symbols': 'ondemand', 05:29:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:15 INFO - 'installer_path': 'installer.exe', 05:29:15 INFO - 'log_level': 'info', 05:29:15 INFO - 'log_name': 'talos', 05:29:15 INFO - 'log_to_console': True, 05:29:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:29:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:29:15 INFO - 'opt_config_files': (), 05:29:15 INFO - 'pip_index': False, 05:29:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:15 INFO - 'cmd': ('bash', 05:29:15 INFO - '-c', 05:29:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:15 INFO - 'enabled': True, 05:29:15 INFO - 'halt_on_failure': False, 05:29:15 INFO - 'name': 'check_screen_resolution'},), 05:29:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:15 INFO - 'cmd': ('bash', 05:29:15 INFO - '-c', 05:29:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:15 INFO - 'enabled': True, 05:29:15 INFO - 'halt_on_failure': False, 05:29:15 INFO - 'name': 'check_screen_resolution'},), 05:29:15 INFO - 'run_cmd_checks_enabled': True, 05:29:15 INFO - 'sps_profile': False, 05:29:15 INFO - 'sps_profile_interval': 0, 05:29:15 INFO - 'suite': 'dromaeojs-e10s', 05:29:15 INFO - 'system_bits': '32', 05:29:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:15 INFO - 'title': 't-yosemite-r7-0053', 05:29:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:15 INFO - 'use_talos_json': True, 05:29:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:15 INFO - 'work_dir': 'build'} 05:29:15 INFO - ##### 05:29:15 INFO - ##### Running clobber step. 05:29:15 INFO - ##### 05:29:15 INFO - Running pre-action listener: _resource_record_pre_action 05:29:15 INFO - Running main action method: clobber 05:29:15 INFO - rmtree: /builds/slave/test/build 05:29:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:17 INFO - Running post-action listener: _resource_record_post_action 05:29:17 INFO - ##### 05:29:17 INFO - ##### Running read-buildbot-config step. 05:29:17 INFO - ##### 05:29:17 INFO - Running pre-action listener: _resource_record_pre_action 05:29:17 INFO - Running main action method: read_buildbot_config 05:29:17 INFO - Using buildbot properties: 05:29:17 INFO - { 05:29:17 INFO - "project": "", 05:29:17 INFO - "product": "firefox", 05:29:17 INFO - "script_repo_revision": "production", 05:29:17 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:29:17 INFO - "repository": "", 05:29:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:29:17 INFO - "buildid": "20160217033849", 05:29:17 INFO - "pgo_build": "False", 05:29:17 INFO - "basedir": "/builds/slave/test", 05:29:17 INFO - "buildnumber": 414, 05:29:17 INFO - "slavename": "t-yosemite-r7-0053", 05:29:17 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:29:17 INFO - "platform": "yosemite_r7", 05:29:17 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:29:17 INFO - "branch": "fx-team", 05:29:17 INFO - "repo_path": "integration/fx-team", 05:29:17 INFO - "revision": "53b0b5b29776127567c8e685f270f4b1639baeaa", 05:29:17 INFO - "stage_platform": "macosx64", 05:29:17 INFO - "builduid": "aeaf16acf41a4fc8909d2878d402428b", 05:29:17 INFO - "slavebuilddir": "test" 05:29:17 INFO - } 05:29:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:29:17 INFO - Running post-action listener: _resource_record_post_action 05:29:17 INFO - ##### 05:29:17 INFO - ##### Running download-and-extract step. 05:29:17 INFO - ##### 05:29:17 INFO - Running pre-action listener: _resource_record_pre_action 05:29:17 INFO - Running main action method: download_and_extract 05:29:17 INFO - mkdir: /builds/slave/test/build/tests 05:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:17 INFO - https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:29:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/test_packages.json 05:29:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/test_packages.json 05:29:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:29:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:29:21 INFO - Downloaded 1277 bytes. 05:29:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:29:21 INFO - Using the following test package requirements: 05:29:21 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:29:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:29:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:29:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:29:21 INFO - u'jsshell-mac.zip'], 05:29:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:29:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:29:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:29:21 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:29:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:29:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:29:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:29:21 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:29:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:21 INFO - https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:29:25 INFO - Downloaded 17806413 bytes. 05:29:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:29:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:29:28 INFO - Return code: 0 05:29:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:28 INFO - https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:29:29 INFO - Downloaded 17806413 bytes. 05:29:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:29:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:29:33 INFO - Return code: 0 05:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:33 INFO - https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:29:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:29:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:29:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:29:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:29:34 INFO - Downloaded 10707015 bytes. 05:29:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:29:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:29:35 INFO - Return code: 0 05:29:35 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')]} 05:29:35 INFO - https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:29:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:29:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:29:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 05:29:40 INFO - Downloaded 111232671 bytes. 05:29:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:29:40 INFO - mkdir: /builds/slave/test/properties 05:29:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:40 INFO - Contents: 05:29:40 INFO - build_url:https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:29:40 INFO - Running post-action listener: _resource_record_post_action 05:29:40 INFO - Running post-action listener: set_extra_try_arguments 05:29:40 INFO - ##### 05:29:40 INFO - ##### Running populate-webroot step. 05:29:40 INFO - ##### 05:29:40 INFO - Running pre-action listener: _resource_record_pre_action 05:29:40 INFO - Running main action method: populate_webroot 05:29:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:29:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:29:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:29:40 INFO - '--tppagecycles', 05:29:40 INFO - '7'], 05:29:40 INFO - 'tests': ['tsvgm']}}, 05:29:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:29:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:29:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:29:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:29:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:29:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:29:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:40 INFO - 'talos_options': ['--e10s'], 05:29:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:40 INFO - 'tests': ['damp', 'tps']}, 05:29:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:40 INFO - 'talos_options': ['--e10s'], 05:29:40 INFO - 'tests': ['damp', 'tps']}, 05:29:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:29:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:29:40 INFO - 'other': {'tests': ['a11yr', 05:29:40 INFO - 'ts_paint', 05:29:40 INFO - 'tpaint', 05:29:40 INFO - 'sessionrestore', 05:29:40 INFO - 'sessionrestore_no_auto_restore']}, 05:29:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:29:40 INFO - 'tests': ['a11yr', 05:29:40 INFO - 'ts_paint', 05:29:40 INFO - 'tpaint', 05:29:40 INFO - 'sessionrestore', 05:29:40 INFO - 'sessionrestore_no_auto_restore']}, 05:29:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:29:40 INFO - 'tests': ['a11yr', 05:29:40 INFO - 'ts_paint', 05:29:40 INFO - 'tpaint', 05:29:40 INFO - 'sessionrestore', 05:29:40 INFO - 'sessionrestore_no_auto_restore']}, 05:29:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:29:40 INFO - 'tests': ['a11yr', 05:29:40 INFO - 'ts_paint', 05:29:40 INFO - 'tpaint', 05:29:40 INFO - 'sessionrestore', 05:29:40 INFO - 'sessionrestore_no_auto_restore']}, 05:29:40 INFO - 'other_l64': {'tests': ['a11yr', 05:29:40 INFO - 'ts_paint', 05:29:40 INFO - 'tpaint', 05:29:40 INFO - 'sessionrestore', 05:29:40 INFO - 'sessionrestore_no_auto_restore']}, 05:29:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:29:40 INFO - 'ts_paint', 05:29:40 INFO - 'tpaint', 05:29:40 INFO - 'sessionrestore', 05:29:40 INFO - 'sessionrestore_no_auto_restore']}, 05:29:40 INFO - 'svgr': {'tests': ['tsvgx', 05:29:40 INFO - 'tsvgr_opacity', 05:29:40 INFO - 'tart', 05:29:40 INFO - 'tscrollx', 05:29:40 INFO - 'cart']}, 05:29:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:29:40 INFO - 'tests': ['tsvgx', 05:29:40 INFO - 'tsvgr_opacity', 05:29:40 INFO - 'tart', 05:29:40 INFO - 'tscrollx', 05:29:40 INFO - 'cart']}, 05:29:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:40 INFO - 'tests': ['tp5o']}, 05:29:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:40 INFO - 'talos_options': ['--e10s'], 05:29:40 INFO - 'tests': ['tp5o']}, 05:29:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:40 INFO - 'talos_options': ['--xperf_path', 05:29:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:40 INFO - 'tests': ['tp5n']}, 05:29:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:40 INFO - 'talos_options': ['--e10s', 05:29:40 INFO - '--xperf_path', 05:29:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:40 INFO - 'tests': ['tp5n']}}, 05:29:40 INFO - 'talos.zip': {'path': '', 05:29:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:29:40 INFO - Running post-action listener: _resource_record_post_action 05:29:40 INFO - ##### 05:29:40 INFO - ##### Running create-virtualenv step. 05:29:40 INFO - ##### 05:29:40 INFO - Running pre-action listener: _resource_record_pre_action 05:29:40 INFO - Running main action method: create_virtualenv 05:29:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:29:40 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 05:29:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:29:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:29:40 INFO - Using real prefix '/tools/python27' 05:29:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:29:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:44 INFO - Installing pip.................done. 05:29:44 INFO - Return code: 0 05:29:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd01ad77740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, '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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:29: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', 'pip>=1.5'] in /builds/slave/test/build 05:29: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 pip>=1.5 05:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:44 INFO - 'HOME': '/Users/cltbld', 05:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:44 INFO - 'LOGNAME': 'cltbld', 05:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:44 INFO - 'MOZ_NO_REMOTE': '1', 05:29:44 INFO - 'NO_EM_RESTART': '1', 05:29:44 INFO - 'PAGER': '/bin/cat', 05:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:44 INFO - 'PWD': '/builds/slave/test', 05:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:44 INFO - 'SHELL': '/bin/bash', 05:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:29:44 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:44 INFO - 'USER': 'cltbld', 05:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:44 INFO - 'XPC_FLAGS': '0x0', 05:29:44 INFO - 'XPC_SERVICE_NAME': '0', 05:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:44 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 05:29:44 INFO - Cleaning up... 05:29:44 INFO - Return code: 0 05:29:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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', '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 0x10bd67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd01ad77740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, '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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:29: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:29: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 psutil>=0.7.1 05:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:44 INFO - 'HOME': '/Users/cltbld', 05:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:44 INFO - 'LOGNAME': 'cltbld', 05:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:44 INFO - 'MOZ_NO_REMOTE': '1', 05:29:44 INFO - 'NO_EM_RESTART': '1', 05:29:44 INFO - 'PAGER': '/bin/cat', 05:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:44 INFO - 'PWD': '/builds/slave/test', 05:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:44 INFO - 'SHELL': '/bin/bash', 05:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:29:44 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:44 INFO - 'USER': 'cltbld', 05:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:44 INFO - 'XPC_FLAGS': '0x0', 05:29:44 INFO - 'XPC_SERVICE_NAME': '0', 05:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:44 INFO - Downloading/unpacking psutil>=0.7.1 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:47 INFO - Installing collected packages: psutil 05:29:47 INFO - Running setup.py install for psutil 05:29:47 INFO - building 'psutil._psutil_osx' extension 05:29:47 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 05:29:47 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 05:29:47 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 05:29:47 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 05:29:47 INFO - building 'psutil._psutil_posix' extension 05:29:47 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 05:29:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:29:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:29:48 INFO - ^ 05:29:48 INFO - 1 warning generated. 05:29:48 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 05:29:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:48 INFO - Successfully installed psutil 05:29:48 INFO - Cleaning up... 05:29:48 INFO - Return code: 0 05:29:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:29:48 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')]} 05:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:48 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')]} 05:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:48 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 0x10bd67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd01ad77740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, '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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:29:48 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 05:29:48 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 05:29:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:29:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:48 INFO - 'HOME': '/Users/cltbld', 05:29:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:48 INFO - 'LOGNAME': 'cltbld', 05:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:48 INFO - 'MOZ_NO_REMOTE': '1', 05:29:48 INFO - 'NO_EM_RESTART': '1', 05:29:48 INFO - 'PAGER': '/bin/cat', 05:29:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:48 INFO - 'PWD': '/builds/slave/test', 05:29:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:48 INFO - 'SHELL': '/bin/bash', 05:29:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:29:48 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:29:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:48 INFO - 'USER': 'cltbld', 05:29:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:48 INFO - 'XPC_FLAGS': '0x0', 05:29:48 INFO - 'XPC_SERVICE_NAME': '0', 05:29:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:29:48 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 05:29:48 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 05:29:48 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 05:29:48 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 05:29:48 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 05:29:48 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 05:29:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:29:51 INFO - Installing collected packages: mozsystemmonitor 05:29:51 INFO - Running setup.py install for mozsystemmonitor 05:29:52 INFO - Successfully installed mozsystemmonitor 05:29:52 INFO - Cleaning up... 05:29:52 INFO - Return code: 0 05:29:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:29:52 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')]} 05:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:52 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')]} 05:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:52 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 0x10bd67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd01ad77740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, '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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:29:52 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 05:29:52 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 05:29:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:29:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:52 INFO - 'HOME': '/Users/cltbld', 05:29:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:52 INFO - 'LOGNAME': 'cltbld', 05:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:52 INFO - 'MOZ_NO_REMOTE': '1', 05:29:52 INFO - 'NO_EM_RESTART': '1', 05:29:52 INFO - 'PAGER': '/bin/cat', 05:29:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:52 INFO - 'PWD': '/builds/slave/test', 05:29:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:52 INFO - 'SHELL': '/bin/bash', 05:29:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:29:52 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:29:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:52 INFO - 'USER': 'cltbld', 05:29:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:52 INFO - 'XPC_FLAGS': '0x0', 05:29:52 INFO - 'XPC_SERVICE_NAME': '0', 05:29:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:29:52 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 05:29:52 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 05:29:52 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 05:29:52 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 05:29:52 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 05:29:52 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 05:29:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:29:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:29:54 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 05:29:54 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 05:29:54 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 05:29:54 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 05:29:54 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 05:29:54 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 05:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:29:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29:56 INFO - Downloading docopt-0.6.1.tar.gz 05:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:29:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:29:56 INFO - Running setup.py install for blobuploader 05:29:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:29:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:29:56 INFO - Running setup.py install for requests 05:29:56 INFO - Running setup.py install for docopt 05:29:56 INFO - Successfully installed blobuploader requests docopt 05:29:56 INFO - Cleaning up... 05:29:57 INFO - Return code: 0 05:29:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:57 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')]} 05:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:57 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')]} 05:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:57 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 0x10bd67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd01ad77740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, '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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:29:57 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 05:29:57 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 05:29:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:29:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:57 INFO - 'HOME': '/Users/cltbld', 05:29:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:57 INFO - 'LOGNAME': 'cltbld', 05:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:57 INFO - 'MOZ_NO_REMOTE': '1', 05:29:57 INFO - 'NO_EM_RESTART': '1', 05:29:57 INFO - 'PAGER': '/bin/cat', 05:29:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:57 INFO - 'PWD': '/builds/slave/test', 05:29:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:57 INFO - 'SHELL': '/bin/bash', 05:29:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:29:57 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:29:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:57 INFO - 'USER': 'cltbld', 05:29:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:57 INFO - 'XPC_FLAGS': '0x0', 05:29:57 INFO - 'XPC_SERVICE_NAME': '0', 05:29:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:57 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ms9sTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:57 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-TnKvyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:57 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-nTh21J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:57 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-eZ10rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:57 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-rN28Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:57 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-72EKSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:57 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-FCErMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ZDAgjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-uaoKAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-YXSdhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-lkdFs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-zV2SYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-mRKjwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-twVNVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-UMvxRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-tz5WEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:58 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-8C08Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:29:59 INFO - Running setup.py install for manifestparser 05:29:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:29:59 INFO - Running setup.py install for mozcrash 05:29:59 INFO - Running setup.py install for mozdebug 05:29:59 INFO - Running setup.py install for mozdevice 05:29:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:29:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:29:59 INFO - Running setup.py install for mozfile 05:29:59 INFO - Running setup.py install for mozhttpd 05:29:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:29:59 INFO - Running setup.py install for mozinfo 05:30:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:00 INFO - Running setup.py install for mozInstall 05:30:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:00 INFO - Running setup.py install for mozleak 05:30:00 INFO - Running setup.py install for mozlog 05:30:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:00 INFO - Running setup.py install for moznetwork 05:30:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:00 INFO - Running setup.py install for mozprocess 05:30:00 INFO - Running setup.py install for mozprofile 05:30:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:01 INFO - Running setup.py install for mozrunner 05:30:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:01 INFO - Running setup.py install for mozscreenshot 05:30:01 INFO - Running setup.py install for moztest 05:30:01 INFO - Running setup.py install for mozversion 05:30:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:01 INFO - Cleaning up... 05:30:01 INFO - Return code: 0 05:30:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:01 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 0x10bd67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd01ad77740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, '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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:30:01 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 05:30:01 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 05:30:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:30:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:01 INFO - 'HOME': '/Users/cltbld', 05:30:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:01 INFO - 'LOGNAME': 'cltbld', 05:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:01 INFO - 'MOZ_NO_REMOTE': '1', 05:30:01 INFO - 'NO_EM_RESTART': '1', 05:30:01 INFO - 'PAGER': '/bin/cat', 05:30:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:01 INFO - 'PWD': '/builds/slave/test', 05:30:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:01 INFO - 'SHELL': '/bin/bash', 05:30:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:30:01 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:30:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:01 INFO - 'USER': 'cltbld', 05:30:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:01 INFO - 'XPC_FLAGS': '0x0', 05:30:01 INFO - 'XPC_SERVICE_NAME': '0', 05:30:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:01 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-UZIJoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:02 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-GuVgry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-T55H1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:02 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-P2Yc2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:02 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Zu61Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:02 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-5xM3zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:02 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-jqvT_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:02 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-oLatlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:02 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ovtoKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:02 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-FHgf20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:02 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)) 05:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:02 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-_YN_MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:03 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)) 05:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:03 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-qCUrb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:03 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)) 05:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:03 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-xdBt25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:03 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)) 05:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:03 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-vxIWM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:03 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)) 05:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:03 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-DdSl68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:03 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)) 05:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:03 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-aJaGUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:03 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)) 05:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:03 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-A7CD9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:03 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)) 05:30:03 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:03 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:03 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)) 05:30:03 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)) 05:30:03 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)) 05:30:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:03 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 05:30:03 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 05:30:03 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 05:30:03 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 05:30:03 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 05:30:03 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 05:30:05 INFO - Downloading blessings-1.6.tar.gz 05:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:06 INFO - Installing collected packages: blessings 05:30:06 INFO - Running setup.py install for blessings 05:30:06 INFO - Successfully installed blessings 05:30:06 INFO - Cleaning up... 05:30:06 INFO - Return code: 0 05:30:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:06 INFO - Reading from file tmpfile_stdout 05:30:06 INFO - Current package versions: 05:30:06 INFO - blessings == 1.6 05:30:06 INFO - blobuploader == 1.2.4 05:30:06 INFO - docopt == 0.6.1 05:30:06 INFO - manifestparser == 1.1 05:30:06 INFO - mozInstall == 1.12 05:30:06 INFO - mozcrash == 0.16 05:30:06 INFO - mozdebug == 0.1 05:30:06 INFO - mozdevice == 0.48 05:30:06 INFO - mozfile == 1.2 05:30:06 INFO - mozhttpd == 0.7 05:30:06 INFO - mozinfo == 0.9 05:30:06 INFO - mozleak == 0.1 05:30:06 INFO - mozlog == 3.1 05:30:06 INFO - moznetwork == 0.27 05:30:06 INFO - mozprocess == 0.22 05:30:06 INFO - mozprofile == 0.28 05:30:06 INFO - mozrunner == 6.11 05:30:06 INFO - mozscreenshot == 0.1 05:30:06 INFO - mozsystemmonitor == 0.0 05:30:06 INFO - moztest == 0.7 05:30:06 INFO - mozversion == 1.4 05:30:06 INFO - psutil == 3.1.1 05:30:06 INFO - requests == 1.2.3 05:30:06 INFO - wsgiref == 0.1.2 05:30:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:06 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 0x10bd67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd01ad77740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, '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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:30:06 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 05:30:06 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 05:30:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:30:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:06 INFO - 'HOME': '/Users/cltbld', 05:30:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:06 INFO - 'LOGNAME': 'cltbld', 05:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:06 INFO - 'MOZ_NO_REMOTE': '1', 05:30:06 INFO - 'NO_EM_RESTART': '1', 05:30:06 INFO - 'PAGER': '/bin/cat', 05:30:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:06 INFO - 'PWD': '/builds/slave/test', 05:30:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:06 INFO - 'SHELL': '/bin/bash', 05:30:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:30:06 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:30:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:06 INFO - 'USER': 'cltbld', 05:30:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:06 INFO - 'XPC_FLAGS': '0x0', 05:30:06 INFO - 'XPC_SERVICE_NAME': '0', 05:30:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 INFO - Cleaning up... 05:30:06 INFO - Return code: 0 05:30:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd01ad77740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, '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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:30:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:30:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:06 INFO - 'HOME': '/Users/cltbld', 05:30:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:06 INFO - 'LOGNAME': 'cltbld', 05:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:06 INFO - 'MOZ_NO_REMOTE': '1', 05:30:06 INFO - 'NO_EM_RESTART': '1', 05:30:06 INFO - 'PAGER': '/bin/cat', 05:30:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:06 INFO - 'PWD': '/builds/slave/test', 05:30:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:06 INFO - 'SHELL': '/bin/bash', 05:30:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:30:06 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:30:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:06 INFO - 'USER': 'cltbld', 05:30:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:06 INFO - 'XPC_FLAGS': '0x0', 05:30:06 INFO - 'XPC_SERVICE_NAME': '0', 05:30:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:07 INFO - Downloading/unpacking jsonschema 05:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:09 INFO - warning: no files found matching '*.txt' 05:30:09 INFO - no previously-included directories found matching 'build' 05:30:09 INFO - no previously-included directories found matching 'dist' 05:30:09 INFO - no previously-included directories found matching '.git*' 05:30:09 INFO - Installing collected packages: jsonschema, functools32 05:30:09 INFO - Running setup.py install for functools32 05:30:10 INFO - warning: no files found matching '*.txt' 05:30:10 INFO - no previously-included directories found matching 'build' 05:30:10 INFO - no previously-included directories found matching 'dist' 05:30:10 INFO - no previously-included directories found matching '.git*' 05:30:10 INFO - Successfully installed jsonschema functools32 05:30:10 INFO - Cleaning up... 05:30:10 INFO - Return code: 0 05:30:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:10 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 0x10bd67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd01ad77740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, '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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:30:10 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 05:30:10 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 05:30:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:30:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:10 INFO - 'HOME': '/Users/cltbld', 05:30:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:10 INFO - 'LOGNAME': 'cltbld', 05:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:10 INFO - 'MOZ_NO_REMOTE': '1', 05:30:10 INFO - 'NO_EM_RESTART': '1', 05:30:10 INFO - 'PAGER': '/bin/cat', 05:30:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:10 INFO - 'PWD': '/builds/slave/test', 05:30:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:10 INFO - 'SHELL': '/bin/bash', 05:30:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:30:10 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:30:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:10 INFO - 'USER': 'cltbld', 05:30:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:10 INFO - 'XPC_FLAGS': '0x0', 05:30:10 INFO - 'XPC_SERVICE_NAME': '0', 05:30:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:10 INFO - Downloading/unpacking flake8 05:30:10 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 05:30:10 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 05:30:10 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 05:30:10 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 05:30:10 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 05:30:10 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 05:30:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:30:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:30:13 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 05:30:13 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 05:30:13 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 05:30:13 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 05:30:13 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 05:30:13 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 05:30:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:30:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:30:13 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 05:30:13 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 05:30:13 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 05:30:13 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 05:30:13 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 05:30:13 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 05:30:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:30:14 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 05:30:14 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 05:30:14 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 05:30:14 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 05:30:14 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 05:30:14 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 05:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:30:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:30:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:30:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:30:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:30:14 INFO - no previously-included directories found matching 'docs/_build' 05:30:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:30:14 INFO - Running setup.py install for pep8 05:30:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:30:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:30:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:30:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:30:14 INFO - no previously-included directories found matching 'docs/_build' 05:30:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:30:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:30:15 INFO - Cleaning up... 05:30:15 INFO - Return code: 0 05:30:15 INFO - Running post-action listener: _resource_record_post_action 05:30:15 INFO - Running post-action listener: _start_resource_monitoring 05:30:15 INFO - Starting resource monitoring. 05:30:15 INFO - ##### 05:30:15 INFO - ##### Running install step. 05:30:15 INFO - ##### 05:30:15 INFO - Running pre-action listener: _resource_record_pre_action 05:30:15 INFO - Running main action method: install 05:30:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:15 INFO - Reading from file tmpfile_stdout 05:30:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:15 INFO - Reading from file tmpfile_stdout 05:30:15 INFO - Output received: 05:30:15 INFO - Usage: mozinstall [options] installer 05:30:15 INFO - Options: 05:30:15 INFO - -h, --help show this help message and exit 05:30:15 INFO - -d DEST, --destination=DEST 05:30:15 INFO - Directory to install application into. [default: 05:30:15 INFO - "/builds/slave/test"] 05:30:15 INFO - --app=APP Application being installed. [default: firefox] 05:30:15 INFO - mkdir: /builds/slave/test/build/application 05:30:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:30:49 INFO - Reading from file tmpfile_stdout 05:30:49 INFO - Output received: 05:30:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:30:49 INFO - Running post-action listener: _resource_record_post_action 05:30:49 INFO - ##### 05:30:49 INFO - ##### Running run-tests step. 05:30:49 INFO - ##### 05:30:49 INFO - Running pre-action listener: _resource_record_pre_action 05:30:49 INFO - Running main action method: run_tests 05:30:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:30:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:30:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:30:49 INFO - 2016-02-17 05:30:49.424 screenresolution[2273:28165] starting screenresolution argv=screenresolution get 05:30:49 INFO - 2016-02-17 05:30:49.426 screenresolution[2273:28165] Display 0: 1600x1200x32@60 05:30:49 INFO - 2016-02-17 05:30:49.432 screenresolution[2274:28168] starting screenresolution argv=screenresolution list 05:30:49 INFO - Available Modes on Display 0 05:30:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:30:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:30:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:30:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:30:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:30:49 INFO - Intel Iris: 05:30:49 INFO - Chipset Model: Intel Iris 05:30:49 INFO - Type: GPU 05:30:49 INFO - Bus: Built-In 05:30:49 INFO - VRAM (Dynamic, Max): 1536 MB 05:30:49 INFO - Vendor: Intel (0x8086) 05:30:49 INFO - Device ID: 0x0a2e 05:30:49 INFO - Revision ID: 0x0009 05:30:49 INFO - Displays: 05:30:49 INFO - Display: 05:30:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:30:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:30:49 INFO - Display Serial Number: 1600x1200 60 05:30:49 INFO - Main Display: Yes 05:30:49 INFO - Mirror: Off 05:30:49 INFO - Online: Yes 05:30:49 INFO - Rotation: Supported 05:30:49 INFO - Return code: 0 05:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:49 INFO - Python 2.7.3 05:30:49 INFO - Return code: 0 05:30:49 INFO - grabbing minidump binary from tooltool 05:30: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')]} 05:30:49 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 0x10bc0bd30>, '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 0x10ba2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc02b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:49 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 05:30:49 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 05:30:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:49 INFO - Return code: 0 05:30:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:30:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:30:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:30:51 INFO - Return code: 0 05:30:51 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/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--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 05:30:51 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/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0053 --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 05:30:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NCYGJ2AUKg/Render', 05:30:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:51 INFO - 'HOME': '/Users/cltbld', 05:30:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:51 INFO - 'LOGNAME': 'cltbld', 05:30:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:51 INFO - 'MOZ_NO_REMOTE': '1', 05:30:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:51 INFO - 'NO_EM_RESTART': '1', 05:30:51 INFO - 'PAGER': '/bin/cat', 05:30:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:51 INFO - 'PWD': '/builds/slave/test', 05:30:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:51 INFO - 'SHELL': '/bin/bash', 05:30:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EtnvHB9YXj/Listeners', 05:30:51 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:30:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:51 INFO - 'USER': 'cltbld', 05:30:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:51 INFO - 'XPC_FLAGS': '0x0', 05:30:51 INFO - 'XPC_SERVICE_NAME': '0', 05:30:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:51 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/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--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 05:30:51 INFO - mozversion application_buildid: 20160217033849 05:30:51 INFO - mozversion application_changeset: 53b0b5b29776127567c8e685f270f4b1639baeaa 05:30:51 INFO - mozversion application_display_name: Nightly 05:30:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:51 INFO - mozversion application_name: Firefox 05:30:51 INFO - mozversion application_remotingname: firefox 05:30:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:30:51 INFO - mozversion application_vendor: Mozilla 05:30:51 INFO - mozversion application_version: 47.0a1 05:30:51 INFO - mozversion platform_buildid: 20160217033849 05:30:51 INFO - mozversion platform_changeset: 53b0b5b29776127567c8e685f270f4b1639baeaa 05:30:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:30:51 INFO - mozversion platform_version: 47.0a1 05:30:51 INFO - using testdate: 1455715851 05:30:51 INFO - actual date: 1455715851 05:30:51 INFO - starting webserver on 'localhost:52188' 05:30:51 INFO - SUITE-START | Running 2 tests 05:30:51 INFO - TEST-START | dromaeo_css 05:30:51 INFO - operating with platform_type : mac_ 05:30:51 INFO - Initialising browser for dromaeo_css test... 05:30:51 INFO - TEST-INFO | started process 2292 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpQ2QBTc/profile http://localhost:52188/getInfo.html) 05:30:54 INFO - PROCESS | 2292 | __metrics Screen width/height:1600/1200 05:30:54 INFO - PROCESS | 2292 | colorDepth:24 05:30:54 INFO - PROCESS | 2292 | Browser inner width/height: 1024/689 05:30:54 INFO - PROCESS | 2292 | __metrics 05:30:54 ERROR - PROCESS | 2292 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 05:30:55 INFO - TEST-INFO | 2292: exit 0 05:30:55 INFO - Browser initialized. 05:30:55 INFO - Running cycle 1/1 for dromaeo_css test... 05:30:55 INFO - TEST-INFO | started process 2296 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpQ2QBTc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:07 INFO - PROCESS | 2296 | RSS: Main: 255528960 05:31:07 INFO - PROCESS | 2296 | 05:31:56 INFO - PROCESS | 2296 | 1455715916745 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] 05:34:07 INFO - PROCESS | 2296 | Cycle 1(1): loaded http://localhost:52188/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52188/tests/dromaeo/cssquery-ext.html) 05:34:08 INFO - PROCESS | 2296 | RSS: Main: 269516800 05:34:08 INFO - PROCESS | 2296 | 05:37:10 INFO - PROCESS | 2296 | Cycle 1(1): loaded http://localhost:52188/tests/dromaeo/cssquery-ext.html (next: http://localhost:52188/tests/dromaeo/cssquery-jquery.html) 05:37:11 INFO - PROCESS | 2296 | RSS: Main: 281268224 05:37:11 INFO - PROCESS | 2296 | 05:40:12 INFO - PROCESS | 2296 | Cycle 1(1): loaded http://localhost:52188/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52188/tests/dromaeo/cssquery-mootools.html) 05:40:13 INFO - PROCESS | 2296 | RSS: Main: 282791936 05:40:13 INFO - PROCESS | 2296 | 05:43:15 INFO - PROCESS | 2296 | Cycle 1(1): loaded http://localhost:52188/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52188/tests/dromaeo/cssquery-prototype.html) 05:43:15 INFO - PROCESS | 2296 | RSS: Main: 284798976 05:43:15 INFO - PROCESS | 2296 | 05:46:18 INFO - PROCESS | 2296 | Cycle 1(1): loaded http://localhost:52188/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52188/tests/dromaeo/cssquery-yui.html) 05:46:18 INFO - PROCESS | 2296 | RSS: Main: 286859264 05:46:18 INFO - PROCESS | 2296 | 05:49:21 INFO - PROCESS | 2296 | Cycle 1(1): loaded http://localhost:52188/tests/dromaeo/cssquery-yui.html (next: http://localhost:52188/tests/dromaeo/cssquery-dojo.html) 05:49:21 INFO - PROCESS | 2296 | RSS: Main: 289579008 05:49:21 INFO - PROCESS | 2296 | 05:49:21 INFO - PROCESS | 2296 | __start_tp_report 05:49:21 INFO - PROCESS | 2296 | _x_x_mozilla_page_load 05:49:21 INFO - PROCESS | 2296 | _x_x_mozilla_page_load_details 05:49:21 INFO - PROCESS | 2296 | |i|pagename|runs| 05:49:21 INFO - PROCESS | 2296 | |0;dojo.html;3409.9318013639727;3537.0273174876907;3593.8562457501703;3596.6403359664037;3599.6040435552095;4418.2268103082;5715.885682286362;5764.798232061873;5820;5828.766849326027;5697.287839020122;5786.334571524276;5803.738831752571;5885.470307672319;5895.764169433228;5213.765380557875;5266.210068489719;5295.761690723926;5298.841034768944;5302.1781623848365;5289.920651190235;5311.937612477501;5358.089124848766;5374.838754837361;5378.596605254602;5156.767945442464;5176.145935920568;5309.044372013036;5309.681419114827;5341.7596208170335;5293.417724050351;5302.761375738062;5314.202869569557;5332.253484512172;5386.811461598825;5159.458256883011;5211.452797456251;5274.129768588178;5296.09966305729;5321.281626980347;4733.905321893543;5202.219667049935;5717;5754.625949313281;5757.856053598652;6259.436650701413;6294.496440284766;6297.055441683784;6319.020551814476;6328.557001009931;6204.720787564571;6220.911340515437;6250.96874515629;6280.309165991737;6296.181496405484;5938;5968.045112781934;5970.34326224115;5981.37195594465;6052.636841789506;6252.468540174136;6398.488120950313;6445.484361251089;6452.1289625900845;6457.225132984072;6178.165947597106;6299.464545513591;6320.968395157995;6323.36766323364;6327.810165695037;5169.560587350042;6256.37334293087;6314.273858506239;6317.7157027932935;6324.936750632527;6128.014278093809;6179.196704428396;6287.654179020106;6314.747410103636;6329.145565348619;4965.379327584052;6284.874302513924;6297.685115744286;6317.4946004319545;6342.619442833445;4880.145974454527;5011.337188976433;5012.1980483122525;5021.698698078127;5023.974880125576;4397.450318710161;4434.401355816988;4482.013956929471;4482.9775851121185;4484.708493947948;5933.9406605934255;5949.196858424144;5975.492083172979;6003;6029.457348838626;6234.251889773256;6245.250569931637;6324.177856878577;6341.556091073673;6344.270408903035;5933;5957.404259574095;5972.552058595623;5992.520598352121;5992.910106348409;5460.017196904595;5481.75332110056;5488.670679759227;5498.1752737089755;5513.669179849142;6010.9699451502465;6373.999999999907;6396.488280937514;6470.708818103197;6517.250516190509;6284.780032698834;6302.086197501245;6315.084312774714;6318.747250109944;6330.52521060913;6491.318411566717;6522.804315870531;6532.444742196966;6534.607923524603;6551.80344589663;6135.538906164888;6166.506679465721;6326.588771729823;6335.619862808247;6335.841603959938;6221.782237621662;6253.78111766086;6283.96858015707;6317.684115794284;6332.683365831782;6109.95128740435;6174.073888916699;6288.182536270256;6298.842528936813;6308.621482711052;5062.898742025212;6125.938740612537;6245.594036387621;6305;6326.462250708557;6048.848778780566;6153.753849845956;6162.568620196544;6167.84580385494;6172.321044684992;6112.959454150325;6159.538034647509;6221.688915554114;6247.562670613013;6275.152854364603;6119.602225855305;6150.938490615036;6159.4456498915315;6188.907166392418;6193.349698281796 05:49:21 INFO - PROCESS | 2296 | |1;ext.html;463.24722326219893;482.77550938813465;486.9975650121749;499.291006770386;566.9773209071636;33206;33935.15162120948;34880.65119348812;38990.80504597477;39091.80454097729;39866;40321.39517907234;40485;40562;40767;9435.38669986452;9622.134007939285;9650.083242092025;9658.74436323277;9723.659671911484;8201.876971845428;9561.521923903812;9645.421274723503;9656.275779316544;9683.951580242088;9554;9592.904070959306;9625.37435066722;9632.855507167398;9669.12977831995;8393.412461127755;9465.148136667663;9669.854952175689;9697.6605818796;9707.077827606367;8248.298894593907;9462.243020558408;9539.952300238454;9587.808243835154;9640.614375424975;37489.43765843487;37538.249235015144;37694.43458348127;37769.43345849815;37851.053723656856;2572.4340645058246;2735.534959056965;3019.698030196963;3674.3018826422895;4016.638502534786;24375;24832.875835620707;24850.254492365257;25115.62326565103;25134.371640708945;2768.1280396674983;2778.6248856404327;2814.6059551662784;2857.8713957871737;2921.0360581008217;352745.2362738196;353329;354187;354204;577923.1103844496;58829.70585147047;59279;59375.70312148412;59399.81200375968;59490.70254648785;59874.70062649746;59982.40017599768;60994;60997.69501152466;60998;15813.762793558106;15846.207689615474;15873.206339682969;16126.919365403333;16134.677306453805;11999.220050696851;12305.138640295272;12309;12537.310447925453;12582.37088145589;18604.627907441776;18657.160427780782;18661.626767464575;18694.252229910922;18742.718859217122;7209.89185162223;8322.50064996102;8490.533020683799;8552.786180345542;8562.400631955703;934.556085859225;961.33667769239;1112.477135746198;1137.4312843578211;1153.325304696745;28003.579946300822;29061.85469072641;29481.410371792444;29622.630189584783;29650.406991860473;930.5626355612851;983.4050399508337;995.2784231432154;1123.3035517978742;1210.2012671636678;13745.175289482662;13834.515791947233;13975;14026.85973140276;14065;550244;551164;556209;556215;559289;53493.46506534963;53784.46215537873;53827;53929.46070539244;54138;1428.2002078835678;1451.535508637226;1452.5424491285212;1462.6855226126434;1593.139704559525;25267.241982740547;26688.332791680365;28104.437911241253;28159.43681126325;28672.42655146927;48327.27509087437;48710;48843.51156488532;48993.265101024226;49052;451971;524975;527072;527219;527437;31725.682743173194;32005;32980.67019329776;33022.33955320928;33150.005499835046;30801.845990769903;40576.59423405728;41164.794176028925;41303.7934810324;42353.364699530146;29949.700502994692;33768;34477.31045379129;34620.961371158905;41412.792936035126;31868;34775.47836782501;37003.704870329406;37580.624193758806;39193.41209881911;37674.81162594169;38405;38906.221875561765;39228.215435691694;39243;30890.227744306572;37268.813655931546;37738.62261377461;39390.60609393984;39548.209035819695;26464;26949.3262668427;26953.0566430174;27018.729812701622;27300.180994570193 05:49:21 INFO - PROCESS | 2296 | |2;jquery.html;360.54751287134644;364.19149488136327;364.61168855169245;369.6672994305125;370.50722539023104;15427.6070879039;19128.617427651458;19138.71291930622;19605.607887842252;20341.694874576893;11602.07183425326;13303;19065.760725552864;19183;19401.708974365396;3804.4673745675627;4417.801198946047;5403.405625381205;5415.53967912726;5416.404195538487;5712.257406537145;5992.460678538931;5997.88004239915;6004.219451471325;6044.455998960093;5687.630304030225;5898.852528686795;5901.5278777697895;5907.5864689471755;5972;5835.183074369592;5888.087346461305;5894.793682221145;5934.465898069173;6523.086767852505;5727.3699893011735;5747.971260143672;5748.97125514374;5760.855978600526;5771.480566748971;19063.618727625508;23992.760072399225;24108.156214532406;24347.026118955222;24379.756202438104;2004.7794742578305;2076.9169233230655;2121.819645330149;2192.967105493403;2222.75549689534;8114.837703245961;9653.806923861554;9849.359791613522;9927.553260103312;10151;1731.6709825133184;1769.672610567049;1789.6599646067205;1821.5355084453513;1822.6810308196145;92954.0704592959;98596.52105218428;98696.50651746767;98816;101107;11127.777444451065;11357.659270221906;11370.829437558443;11386.829197562043;11513.597024104116;13483.921286297269;13603.863961360457;13604.591862243951;13617.659558511117;13659.317034148253;8555.743327700178;8627.051024387312;8652.956735216283;8664.48013119215;8675.219230269306;7005.439564834801;7795.4543181976715;8725.389222754346;8739.737807865775;8811.339149563808;3274.787138835968;4266.807993640232;4407.889802754957;4426.84506042287;4440.533743956838;1511.3878879054;1856.7493388392395;1887.5658598522143;1887.8489720822301;1901.990490047541;911.7948461596088;966.6036924860914;976.770458942148;1007.6120693532896;1047.4657924458581;13888.791668124986;15182.013169144191;16814.90703104294;16874.662506750043;21217.363479095653;898.3576742629051;955.1594596754811;958.247775496246;1019.8623185869961;1037.5797801890246;7301.707931682779;9423.19902808269;10488.632897848538;11027.283226590245;11149.442527873574;688281;719881;732061;761023;784285;111842.44078779554;111894.44052779685;112763;113534;114622;1128.8588926384202;1181.4919584578713;1182.3319824299244;1188.0495603517152;1189.7025743564109;18202.81797182064;18802.811971880106;18804.623907521498;19000.714989274897;19103.52241193981;48366.19605647345;49350;49931.50068499269;50039;50148.74925625348;68471;70307.64846175736;72229.6388518054;72434.18914527178;72515.37423128718;7507.887381689388;7551.848963020599;7574.166841647525;7845.803854903673;7891.64487598071;11997.340146292037;12571.371431428575;12629.3685315732;12760.229720028448;12865;10632.362058276529;10832.241743078224;10953.61662341846;11095.611653592085;11098.667039988813;6379.947308694013;8282.50304981703;10769.9461502692;10959.01368876805;11106.888931110585;10939.945300273766;11074.612388566362;11090.611828585961;11142.27575207609;11481.712957176138;7557.659905304165;7794.142644309235;7857.332126769289;7958.243966823143;7967.32277756374;8508.489490630582;10872.728181795519;10884.891151088388;10907.727306817393;11087.168462365193 05:49:21 INFO - PROCESS | 2296 | |3;mootools.html;1536.815582130144;1553.7669349597556;1788.5081602559294;1897.7627796525435;1903.9428817135474;7783.3384162346265;8348.791280217998;8486.787830304238;8591.570421478933;8624.91375086249;8412.158784121584;8511;8578.871316930252;8609.827803443928;8611.741647750561;2111.788821117884;2451.84063035903;2476.3437689012426;2477.2320580619976;2480.193936970492;2435.2694191742494;2460.458699086207;2477.182529765173;2478.033566908907;2487.328421326241;2169.858959167657;2389.1637926725593;2457.1522824625563;2474.604063349864;2476.962845557318;1856.5637075287298;2132.3922682035545;2363.7872591466767;2367.6093444581625;2404.9077302746637;2107.947301317464;2250.17868478006;2428.1258746851117;2438.085717855804;2446.0949448703914;8553.828923421497;8587;8598.527081010541;8625.956870215608;8642.827143457158;5256.106461901448;5395.29861118056;5405.864853378657;5416.187571864252;5521.1442226454965;3555.1604267391153;3556.6621170988715;3598.9100272493133;3657.359962006665;3661.048127486846;965.1554889471712;966.7679756858304;1041.1462600667455;1057.4395570347729;1075.7095584192225;11652.184347095706;11661.0088142508;11675.708107297301;11679;11737.237079589799;4084.673226141961;4838.104950584153;4905.141600219948;4922.827701030518;4941.950580494149;9862.211023118134;9960.302778805413;9978.351407158656;9978.750531236778;10036.949815250877;5371.704556249444;5426.321709786277;5436.592255580847;5445.891082178334;5449;4076.286649836326;4905.435874874363;4943.406791185081;4944.406671199479;4963.726995015237;3696.2237930034457;3725.012871589031;3746.157114649182;3781.489498917666;3781.905452363713;1162.9584309512004;1165.242592315002;1170.5727409495644;1173.6948393417772;1180.2682336951145;1023.7952409517977;1118.2060736876908;1139.4986206069468;1238.2013601227159;1335.5392389625563;7713.961430192813;7758.107817600935;7843.294103530709;7855.960720196363;7939.166387529342;1196.4496331687521;1200.4897918384652;1204.0909113619161;1210.4673943464848;1234.4259919137464;6086.847828804227;6118.449339559461;6142.692865356804;6146.661933593696;6192.752289908443;10031.347962382422;10314.690559283234;10326.328788628714;10333.328333658439;10395.16838652906;9929.851052234222;10176.389416634878;10300;10307;10334.224933130045;7985.321247693895;8071.9506464159285;8129.8374032520205;8203.9745031871;8234.464759790715;7925.167857374892;7943.642536086006;7995.400344974034;8038.63826127814;8107.1892810718455;8083.514989100673;9312.534373281173;9390.696005740232;9414.2468602513;9487;8157.6329065193395;8272.545010024507;9626.566804493674;9835.213182945205;9890.901090989286;6422.454091402283;7204.207537171012;7436.665350059152;7453.478256521991;7489.101307843093;7926.326262267772;7999.480033797785;8032.919670803217;8073.717419890276;8120.350371970347;5556.583256255716;7680.116786569616;7758.107817600822;7820.413468989735;7842.607869606611;7260.056192694916;7313.049303590499;7386.667599958122;7400.333969942731;7491.288327608869;7604.315611594983;7669.693212271447;7672.38620910337;7679.961600192187;7692;6911.861762764817;6942.097527321416;6949.235584085847;6956;6985.301469852974;5828.70856457167;6997.440204783503;7009.684564194521;7032.12098487689;7109.360157585842 05:49:21 INFO - PROCESS | 2296 | |4;prototype.html;279.876854184159;326.14549879316195;329.39227125952607;330.5933701547099;331.8937939859243;6717.764878229263;6881.827954301139;6910.75812346568;6993.930060699391;7009.859802803947;6935.930640693604;6940.548864323815;6968.1986571544285;6993.580385176893;7008.159020917497;5117.565006974393;5125.513076257749;5128.640995130342;5148.768305426255;5162.974185129069;4809.206480930642;5100.158473851829;5131.512506311913;5141.511556402154;5144.151215049513;4919.434265059528;4923.950760492385;4936.481669424713;4944.085344211315;4948.653594248404;4914.729689867056;4919.237518184687;4970.552650261494;4988.625853061035;4988.7505624718615;3734.9626503734885;3982.064214909494;4146.792660366999;4182.456280683522;4213.599708027732;5180.222966555009;5239.528442440161;6457.709403076873;6559.737610495575;6573.737050517973;5871.794487192928;5890.322612899528;5900.822975310747;5911.349751527328;5945.137954996501;5907.763689452459;7157.785266442015;7352.1326682593835;7394.223606521292;7403.925960740377;4677.438707355105;4678.578927896506;4682.391289132425;4691.554302341272;4705.200115980291;7825.491343062683;7851.8037049073655;7857.8035549111155;7889.96055019727;7920.881186782145;3709.703223742094;4661.376745820229;4738.431388233434;4752.7623618818925;4761.904761904742;4846.660733748674;4849.781759820817;4850.151223535938;4857.53853383928;4867.756612169377;5812.534997200299;5830.795922142789;5840.5035571976005;5846.386129456346;5853.619514731528;6448.645324507103;7400.148982866932;7419.258074192646;7428.071491063617;7443.144038435649;1621.6108134047743;1663.3512929957326;1686.0473832284965;1686.9072201029062;1690.560454281871;858.6436628799104;1058.3015209961388;1069.417167643636;1069.6951368859993;1084.9728756781144;4949.678270912379;5316.83029733458;6600.372964568358;6692.531522793358;6911.89632155508;6073.544484163705;6857.451403887677;7638.923610763822;7649.38804895607;7656.234376562299;6739.898901516482;6889.896651550231;6897.62063086525;6899.689513971884;6921.550099243533;2969.3319003224533;3427.8114703691535;3441.6214216436174;4070.2063097695664;4138.503379594468;8083.83832323362;8195.63978768702;8211.507309561446;8213.753587392268;8220.136885627042;6730.32696730323;7854.567998760123;8045.637946292314;8066.193380661887;8077;7962.56205908669;8116;8172;8183.468074575134;8192.508449493049;7060.223375428596;7788.065432148179;7817.609119544114;7826.373890088893;7844.372450204084;7372.815679608053;7649.579273140031;7652.387808975157;7673.155952845294;7692.653830577526;6158.0147176451555;7028.4728645352825;7198.604076775828;7345.485815993043;7621.580813055335;4786.282057691375;4809.591184749195;4816.494268101799;4819.542143496362;4826;7431.219721929119;7732.30409263169;7765.495242809199;7769.53382797034;7786.26030527099;7431.331180193809;7442.665080071301;7443.292887175926;7443.702251910079;7445.813854653677;7435.591042492715;7459.589722565094;7493.812654683677;7521.548707077593;7550.509216900884;7104.893426598708;7357.668904899186;7363.558186508827;7370.926290737239;7376.225496322809;6126.203593532812;7495.901147678659;7512.586807725627;7538.736144234926;7542.358899493385;7142.892856607051;7338.853222935618;7380.188179300165;7380.483366164317;7421.851562968818 05:49:21 INFO - PROCESS | 2296 | |5;yui.html;665.0921492163197;704.27459716492;713.5754226235391;715.3168723868706;732.857092866891;13166.288382510273;14964.476243331486;14972.775408368856;15072;15112.319945602447;12094.576689815858;13693.972952028587;14329.92835035826;14489.130652160879;14518.564443066698;703.3388614702163;833.7748807821885;846.7840700621333;867;872.3108744092191;720.7297263526177;861.9569021548898;862.0259107208876;873.5326600268858;878.0999475537593;899.7615631857562;901.3600343755941;913.954302284883;915.0483497162976;916.715818096389;890.8351954888367;894.1058941058941;900.7072701372015;901.6393442622938;901.9774505637346;669.1602039440471;670.6244503078292;671.9529632925697;673.9663016849187;674.6188403551978;15178;15222.238888055554;15276.618084547865;15281.235938203157;15313.61715957099;12812.29532375719;12965.935170324088;12999.025073119554;13084.345782710827;13124.6718832029;10040.89959100407;10144.797104057878;10180.541875615616;10261.384316941007;10545;3574.4102223133414;3582.6596473335253;3586.085548185196;3590.6409359064146;3709.9443508347395;87395.25209495838;88494;89284.10715892822;90741.54629226877;90942.54528727314;9441.622335106656;9670.903290967;9834.508274586242;9858.802823943624;10202.693919182437;21610.45973850635;21905.890470547547;21926.671099933516;21942.122315107536;21956.341309760734;6502;7278.526895751759;7644.617769111522;7694.345980591713;7736.303732663975;4093.283675356801;4121.5878412158545;4151.294279972412;4160.583941605815;4166.895827604334;2893.2911436698146;3038.893638722678;3338.582677165354;3500.7222363837527;3516.40221162403;630.1555915073732;636.1697984130661;640.5132099604334;660.1253339325413;662.4766434516774;528.8783579776673;558.7792821835352;612.0941007309208;620.0420350558308;622.2346513787976;8045.9597702011115;8117.95941020303;8257.091719910804;8504.617292221865;8619.310455163572;534.161366654349;549.6372394219795;605.0984033789622;612.2622240200548;625.1217040058634;3973.1060511385285;3975.9662487753394;3986.60133986599;3994.420808982681;4036.233115708006;91927.62108568377;93613;93905;94613;94796;83345.16654833495;83969.74045389325;84017.15982840216;84204;85115.5744221275;71832.64083679549;73402;73728;73835;74262.6286868573;6839.863202736017;7191.849304111317;8072.919270807217;8233.382496312921;8293.585320733819;50365.74817125891;53215.46784532105;53488.197677035656;53804.730976344865;54932.450675492735;68473.65763171153;68608;68800.6559967197;73643.52712945604;73920.52158956684;9893.702386495417;9918;9939.503024848584;9943.801123977335;10127.949360253151;10833.945830270799;10898.455077246264;10996.395198263852;11513.424328783694;11811.468483918072;9675.758106047406;10037.397756134655;10591.788164236517;10653.627123050655;10658.307210031324;10556.84164737545;10629.25595208328;10642.84035739449;10753.569857205937;10763.838542422027;10110.292279540361;10275.177985761271;10393.480325983823;10491.527881245514;10519.94740026295;8808.0311165773;8903;8974.775630609287;9174.954125229331;9256.444613323221;8610.65557377698;8779.385443018928;9002.414843035443;9170.312226582899;9179.265658747418 05:49:21 INFO - PROCESS | 2296 | __end_tp_report 05:49:21 INFO - PROCESS | 2296 | __start_cc_report 05:49:21 INFO - PROCESS | 2296 | _x_x_mozilla_cycle_collect,358 05:49:21 INFO - PROCESS | 2296 | __end_cc_report 05:49:21 INFO - PROCESS | 2296 | __startTimestamp1455716961614__endTimestamp 05:49:21 INFO - PROCESS | 2296 | 05:49:21 INFO - PROCESS | 2296 | ------- Summary: start ------- 05:49:21 INFO - PROCESS | 2296 | Number of tests: 6 05:49:21 INFO - PROCESS | 2296 | 05:49:21 INFO - PROCESS | 2296 | [#0] dojo.html Cycles:165 Average:5818.71 Median:6119.60 stddev:661.60 (10.8%) stddev-sans-first:636.07 05:49:21 INFO - PROCESS | 2296 | Values: 3409.9 3537.0 3593.9 3596.6 3599.6 4418.2 5715.9 5764.8 5820.0 5828.8 5697.3 5786.3 5803.7 5885.5 5895.8 5213.8 5266.2 5295.8 5298.8 5302.2 5289.9 5311.9 5358.1 5374.8 5378.6 5156.8 5176.1 5309.0 5309.7 5341.8 5293.4 5302.8 5314.2 5332.3 5386.8 5159.5 5211.5 5274.1 5296.1 5321.3 4733.9 5202.2 5717.0 5754.6 5757.9 6259.4 6294.5 6297.1 6319.0 6328.6 6204.7 6220.9 6251.0 6280.3 6296.2 5938.0 5968.0 5970.3 5981.4 6052.6 6252.5 6398.5 6445.5 6452.1 6457.2 6178.2 6299.5 6321.0 6323.4 6327.8 5169.6 6256.4 6314.3 6317.7 6324.9 6128.0 6179.2 6287.7 6314.7 6329.1 4965.4 6284.9 6297.7 6317.5 6342.6 4880.1 5011.3 5012.2 5021.7 5024.0 4397.5 4434.4 4482.0 4483.0 4484.7 5933.9 5949.2 5975.5 6003.0 6029.5 6234.3 6245.3 6324.2 6341.6 6344.3 5933.0 5957.4 5972.6 5992.5 5992.9 5460.0 5481.8 5488.7 5498.2 5513.7 6011.0 6374.0 6396.5 6470.7 6517.3 6284.8 6302.1 6315.1 6318.7 6330.5 6491.3 6522.8 6532.4 6534.6 6551.8 6135.5 6166.5 6326.6 6335.6 6335.8 6221.8 6253.8 6284.0 6317.7 6332.7 6110.0 6174.1 6288.2 6298.8 6308.6 5062.9 6125.9 6245.6 6305.0 6326.5 6048.8 6153.8 6162.6 6167.8 6172.3 6113.0 6159.5 6221.7 6247.6 6275.2 6119.6 6150.9 6159.4 6188.9 6193.3 05:49:21 INFO - PROCESS | 2296 | 05:49:21 INFO - PROCESS | 2296 | [#1] ext.html Cycles:180 Average:62629.28 Median:38948.51 stddev:132160.17 (339.3%) stddev-sans-first:132448.49 05:49:21 INFO - PROCESS | 2296 | Values: 463.2 482.8 487.0 499.3 567.0 33206.0 33935.2 34880.7 38990.8 39091.8 39866.0 40321.4 40485.0 40562.0 40767.0 9435.4 9622.1 9650.1 9658.7 9723.7 8201.9 9561.5 9645.4 9656.3 9684.0 9554.0 9592.9 9625.4 9632.9 9669.1 8393.4 9465.1 9669.9 9697.7 9707.1 8248.3 9462.2 9540.0 9587.8 9640.6 37489.4 37538.2 37694.4 37769.4 37851.1 2572.4 2735.5 3019.7 3674.3 4016.6 24375.0 24832.9 24850.3 25115.6 25134.4 2768.1 2778.6 2814.6 2857.9 2921.0 352745.2 353329.0 354187.0 354204.0 577923.1 58829.7 59279.0 59375.7 59399.8 59490.7 59874.7 59982.4 60994.0 60997.7 60998.0 15813.8 15846.2 15873.2 16126.9 16134.7 11999.2 12305.1 12309.0 12537.3 12582.4 18604.6 18657.2 18661.6 18694.3 18742.7 7209.9 8322.5 8490.5 8552.8 8562.4 934.6 961.3 1112.5 1137.4 1153.3 28003.6 29061.9 29481.4 29622.6 29650.4 930.6 983.4 995.3 1123.3 1210.2 13745.2 13834.5 13975.0 14026.9 14065.0 550244.0 551164.0 556209.0 556215.0 559289.0 53493.5 53784.5 53827.0 53929.5 54138.0 1428.2 1451.5 1452.5 1462.7 1593.1 25267.2 26688.3 28104.4 28159.4 28672.4 48327.3 48710.0 48843.5 48993.3 49052.0 451971.0 524975.0 527072.0 527219.0 527437.0 31725.7 32005.0 32980.7 33022.3 33150.0 30801.8 40576.6 41164.8 41303.8 42353.4 29949.7 33768.0 34477.3 34621.0 41412.8 31868.0 34775.5 37003.7 37580.6 39193.4 37674.8 38405.0 38906.2 39228.2 39243.0 30890.2 37268.8 37738.6 39390.6 39548.2 26464.0 26949.3 26953.1 27018.7 27300.2 05:49:21 INFO - PROCESS | 2296 | 05:49:21 INFO - PROCESS | 2296 | [#2] jquery.html Cycles:180 Average:37110.74 Median:13827.27 stddev:121459.51 (878.4%) stddev-sans-first:121768.88 05:49:21 INFO - PROCESS | 2296 | Values: 360.5 364.2 364.6 369.7 370.5 15427.6 19128.6 19138.7 19605.6 20341.7 11602.1 13303.0 19065.8 19183.0 19401.7 3804.5 4417.8 5403.4 5415.5 5416.4 5712.3 5992.5 5997.9 6004.2 6044.5 5687.6 5898.9 5901.5 5907.6 5972.0 5835.2 5888.1 5894.8 5934.5 6523.1 5727.4 5748.0 5749.0 5760.9 5771.5 19063.6 23992.8 24108.2 24347.0 24379.8 2004.8 2076.9 2121.8 2193.0 2222.8 8114.8 9653.8 9849.4 9927.6 10151.0 1731.7 1769.7 1789.7 1821.5 1822.7 92954.1 98596.5 98696.5 98816.0 101107.0 11127.8 11357.7 11370.8 11386.8 11513.6 13483.9 13603.9 13604.6 13617.7 13659.3 8555.7 8627.1 8653.0 8664.5 8675.2 7005.4 7795.5 8725.4 8739.7 8811.3 3274.8 4266.8 4407.9 4426.8 4440.5 1511.4 1856.7 1887.6 1887.8 1902.0 911.8 966.6 976.8 1007.6 1047.5 13888.8 15182.0 16814.9 16874.7 21217.4 898.4 955.2 958.2 1019.9 1037.6 7301.7 9423.2 10488.6 11027.3 11149.4 688281.0 719881.0 732061.0 761023.0 784285.0 111842.4 111894.4 112763.0 113534.0 114622.0 1128.9 1181.5 1182.3 1188.0 1189.7 18202.8 18802.8 18804.6 19000.7 19103.5 48366.2 49350.0 49931.5 50039.0 50148.7 68471.0 70307.6 72229.6 72434.2 72515.4 7507.9 7551.8 7574.2 7845.8 7891.6 11997.3 12571.4 12629.4 12760.2 12865.0 10632.4 10832.2 10953.6 11095.6 11098.7 6379.9 8282.5 10769.9 10959.0 11106.9 10939.9 11074.6 11090.6 11142.3 11481.7 7557.7 7794.1 7857.3 7958.2 7967.3 8508.5 10872.7 10884.9 10907.7 11087.2 05:49:21 INFO - PROCESS | 2296 | 05:49:21 INFO - PROCESS | 2296 | [#3] mootools.html Cycles:180 Average:5921.66 Median:5447.45 stddev:3098.80 (56.9%) stddev-sans-first:3089.96 05:49:21 INFO - PROCESS | 2296 | Values: 1536.8 1553.8 1788.5 1897.8 1903.9 7783.3 8348.8 8486.8 8591.6 8624.9 8412.2 8511.0 8578.9 8609.8 8611.7 2111.8 2451.8 2476.3 2477.2 2480.2 2435.3 2460.5 2477.2 2478.0 2487.3 2169.9 2389.2 2457.2 2474.6 2477.0 1856.6 2132.4 2363.8 2367.6 2404.9 2107.9 2250.2 2428.1 2438.1 2446.1 8553.8 8587.0 8598.5 8626.0 8642.8 5256.1 5395.3 5405.9 5416.2 5521.1 3555.2 3556.7 3598.9 3657.4 3661.0 965.2 966.8 1041.1 1057.4 1075.7 11652.2 11661.0 11675.7 11679.0 11737.2 4084.7 4838.1 4905.1 4922.8 4942.0 9862.2 9960.3 9978.4 9978.8 10036.9 5371.7 5426.3 5436.6 5445.9 5449.0 4076.3 4905.4 4943.4 4944.4 4963.7 3696.2 3725.0 3746.2 3781.5 3781.9 1163.0 1165.2 1170.6 1173.7 1180.3 1023.8 1118.2 1139.5 1238.2 1335.5 7714.0 7758.1 7843.3 7856.0 7939.2 1196.4 1200.5 1204.1 1210.5 1234.4 6086.8 6118.4 6142.7 6146.7 6192.8 10031.3 10314.7 10326.3 10333.3 10395.2 9929.9 10176.4 10300.0 10307.0 10334.2 7985.3 8072.0 8129.8 8204.0 8234.5 7925.2 7943.6 7995.4 8038.6 8107.2 8083.5 9312.5 9390.7 9414.2 9487.0 8157.6 8272.5 9626.6 9835.2 9890.9 6422.5 7204.2 7436.7 7453.5 7489.1 7926.3 7999.5 8032.9 8073.7 8120.4 5556.6 7680.1 7758.1 7820.4 7842.6 7260.1 7313.0 7386.7 7400.3 7491.3 7604.3 7669.7 7672.4 7680.0 7692.0 6911.9 6942.1 6949.2 6956.0 6985.3 5828.7 6997.4 7009.7 7032.1 7109.4 05:49:21 INFO - PROCESS | 2296 | 05:49:21 INFO - PROCESS | 2296 | [#4] prototype.html Cycles:180 Average:5957.67 Median:6798.68 stddev:1978.60 (29.1%) stddev-sans-first:1937.72 05:49:21 INFO - PROCESS | 2296 | Values: 279.9 326.1 329.4 330.6 331.9 6717.8 6881.8 6910.8 6993.9 7009.9 6935.9 6940.5 6968.2 6993.6 7008.2 5117.6 5125.5 5128.6 5148.8 5163.0 4809.2 5100.2 5131.5 5141.5 5144.2 4919.4 4924.0 4936.5 4944.1 4948.7 4914.7 4919.2 4970.6 4988.6 4988.8 3735.0 3982.1 4146.8 4182.5 4213.6 5180.2 5239.5 6457.7 6559.7 6573.7 5871.8 5890.3 5900.8 5911.3 5945.1 5907.8 7157.8 7352.1 7394.2 7403.9 4677.4 4678.6 4682.4 4691.6 4705.2 7825.5 7851.8 7857.8 7890.0 7920.9 3709.7 4661.4 4738.4 4752.8 4761.9 4846.7 4849.8 4850.2 4857.5 4867.8 5812.5 5830.8 5840.5 5846.4 5853.6 6448.6 7400.1 7419.3 7428.1 7443.1 1621.6 1663.4 1686.0 1686.9 1690.6 858.6 1058.3 1069.4 1069.7 1085.0 4949.7 5316.8 6600.4 6692.5 6911.9 6073.5 6857.5 7638.9 7649.4 7656.2 6739.9 6889.9 6897.6 6899.7 6921.6 2969.3 3427.8 3441.6 4070.2 4138.5 8083.8 8195.6 8211.5 8213.8 8220.1 6730.3 7854.6 8045.6 8066.2 8077.0 7962.6 8116.0 8172.0 8183.5 8192.5 7060.2 7788.1 7817.6 7826.4 7844.4 7372.8 7649.6 7652.4 7673.2 7692.7 6158.0 7028.5 7198.6 7345.5 7621.6 4786.3 4809.6 4816.5 4819.5 4826.0 7431.2 7732.3 7765.5 7769.5 7786.3 7431.3 7442.7 7443.3 7443.7 7445.8 7435.6 7459.6 7493.8 7521.5 7550.5 7104.9 7357.7 7363.6 7370.9 7376.2 6126.2 7495.9 7512.6 7538.7 7542.4 7142.9 7338.9 7380.2 7380.5 7421.9 05:49:21 INFO - PROCESS | 2296 | 05:49:21 INFO - PROCESS | 2296 | [#5] yui.html Cycles:180 Average:18854.06 Median:661.30 stddev:27327.08 (4132.3%) stddev-sans-first:27369.61 05:49:21 INFO - PROCESS | 2296 | Values: 665.1 704.3 713.6 715.3 732.9 13166.3 14964.5 14972.8 15072.0 15112.3 12094.6 13694.0 14329.9 14489.1 14518.6 703.3 833.8 846.8 867.0 872.3 720.7 862.0 862.0 873.5 878.1 899.8 901.4 914.0 915.0 916.7 890.8 894.1 900.7 901.6 902.0 669.2 670.6 672.0 674.0 674.6 15178.0 15222.2 15276.6 15281.2 15313.6 12812.3 12965.9 12999.0 13084.3 13124.7 10040.9 10144.8 10180.5 10261.4 10545.0 3574.4 3582.7 3586.1 3590.6 3709.9 87395.3 88494.0 89284.1 90741.5 90942.5 9441.6 9670.9 9834.5 9858.8 10202.7 21610.5 21905.9 21926.7 21942.1 21956.3 6502.0 7278.5 7644.6 7694.3 7736.3 4093.3 4121.6 4151.3 4160.6 4166.9 2893.3 3038.9 3338.6 3500.7 3516.4 630.2 636.2 640.5 660.1 662.5 528.9 558.8 612.1 620.0 622.2 8046.0 8118.0 8257.1 8504.6 8619.3 534.2 549.6 605.1 612.3 625.1 3973.1 3976.0 3986.6 3994.4 4036.2 91927.6 93613.0 93905.0 94613.0 94796.0 83345.2 83969.7 84017.2 84204.0 85115.6 71832.6 73402.0 73728.0 73835.0 74262.6 6839.9 7191.8 8072.9 8233.4 8293.6 50365.7 53215.5 53488.2 53804.7 54932.5 68473.7 68608.0 68800.7 73643.5 73920.5 9893.7 9918.0 9939.5 9943.8 10127.9 10833.9 10898.5 10996.4 11513.4 11811.5 9675.8 10037.4 10591.8 10653.6 10658.3 10556.8 10629.3 10642.8 10753.6 10763.8 10110.3 10275.2 10393.5 10491.5 10519.9 8808.0 8903.0 8974.8 9175.0 9256.4 8610.7 8779.4 9002.4 9170.3 9179.3 05:49:21 INFO - PROCESS | 2296 | -------- Summary: end -------- 05:49:21 INFO - PROCESS | 2296 | 05:49:22 INFO - TEST-INFO | 2296: exit 0 05:49:22 INFO - TEST-OK | dromaeo_css | took 1110516ms 05:49:22 INFO - TEST-START | kraken 05:49:22 INFO - operating with platform_type : mac_ 05:49:22 INFO - Initialising browser for kraken test... 05:49:22 INFO - TEST-INFO | started process 2301 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmp4BOVU8/profile http://localhost:52188/getInfo.html) 05:49:24 INFO - PROCESS | 2301 | __metrics Screen width/height:1600/1200 05:49:24 INFO - PROCESS | 2301 | colorDepth:24 05:49:24 INFO - PROCESS | 2301 | Browser inner width/height: 1024/689 05:49:24 INFO - PROCESS | 2301 | __metrics 05:49:24 ERROR - PROCESS | 2301 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 05:49:25 INFO - TEST-INFO | 2301: exit 0 05:49:25 INFO - Browser initialized. 05:49:25 INFO - Running cycle 1/1 for kraken test... 05:49:25 INFO - TEST-INFO | started process 2304 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmp4BOVU8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:37 INFO - PROCESS | 2304 | RSS: Main: 255356928 05:49:37 INFO - PROCESS | 2304 | 05:49:40 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52188/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:40 INFO - PROCESS | 2304 | RSS: Main: 268783616 05:49:40 INFO - PROCESS | 2304 | 05:49:43 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52188/tests/kraken/driver.html?testName=audio-dft) 05:49:44 INFO - PROCESS | 2304 | RSS: Main: 276393984 05:49:44 INFO - PROCESS | 2304 | 05:49:47 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52188/tests/kraken/driver.html?testName=audio-fft) 05:49:47 INFO - PROCESS | 2304 | RSS: Main: 281169920 05:49:47 INFO - PROCESS | 2304 | 05:49:55 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52188/tests/kraken/driver.html?testName=audio-oscillator) 05:49:56 INFO - PROCESS | 2304 | RSS: Main: 280915968 05:49:56 INFO - PROCESS | 2304 | 05:49:58 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52188/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:59 INFO - PROCESS | 2304 | RSS: Main: 282689536 05:49:59 INFO - PROCESS | 2304 | 05:50:01 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52188/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:02 INFO - PROCESS | 2304 | RSS: Main: 283799552 05:50:02 INFO - PROCESS | 2304 | 05:50:05 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52188/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:05 INFO - PROCESS | 2304 | RSS: Main: 282931200 05:50:05 INFO - PROCESS | 2304 | 05:50:08 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52188/tests/kraken/driver.html?testName=json-parse-financial) 05:50:09 INFO - PROCESS | 2304 | RSS: Main: 283119616 05:50:09 INFO - PROCESS | 2304 | 05:50:10 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52188/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:11 INFO - PROCESS | 2304 | RSS: Main: 283004928 05:50:11 INFO - PROCESS | 2304 | 05:50:13 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52188/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:14 INFO - PROCESS | 2304 | RSS: Main: 283664384 05:50:14 INFO - PROCESS | 2304 | 05:50:16 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52188/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:16 INFO - PROCESS | 2304 | RSS: Main: 283926528 05:50:16 INFO - PROCESS | 2304 | 05:50:19 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:19 INFO - PROCESS | 2304 | RSS: Main: 283234304 05:50:19 INFO - PROCESS | 2304 | 05:50:22 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:23 INFO - PROCESS | 2304 | RSS: Main: 283459584 05:50:23 INFO - PROCESS | 2304 | 05:50:24 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:52188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52188/tests/kraken/driver.html?testName=ai-astar) 05:50:25 INFO - PROCESS | 2304 | RSS: Main: 285085696 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | __start_tp_report 05:50:25 INFO - PROCESS | 2304 | _x_x_mozilla_page_load 05:50:25 INFO - PROCESS | 2304 | _x_x_mozilla_page_load_details 05:50:25 INFO - PROCESS | 2304 | |i|pagename|runs| 05:50:25 INFO - PROCESS | 2304 | |0;ai-astar;115;111;115;117;115;127;116;115;117;116 05:50:25 INFO - PROCESS | 2304 | |1;audio-beat-detection;155;121;149;155;122;144;143;117;158;137 05:50:25 INFO - PROCESS | 2304 | |2;audio-dft;193;201;203;204;209;226;197;200;202;200 05:50:25 INFO - PROCESS | 2304 | |3;audio-fft;73;66;74;110;57;58;68;58;110;58 05:50:25 INFO - PROCESS | 2304 | |4;audio-oscillator;78;82;117;79;81;85;121;100;80;116 05:50:25 INFO - PROCESS | 2304 | |5;imaging-gaussian-blur;88;112;130;93;87;92;87;91;86;109 05:50:25 INFO - PROCESS | 2304 | |6;imaging-darkroom;96;97;98;96;96;96;96;95;103;94 05:50:25 INFO - PROCESS | 2304 | |7;imaging-desaturate;153;147;90;93;92;90;97;92;88;93 05:50:25 INFO - PROCESS | 2304 | |8;json-parse-financial;56;57;57;55;57;57;59;76;70;55 05:50:25 INFO - PROCESS | 2304 | |9;json-stringify-tinderbox;69;65;71;71;82;73;69;79;100;68 05:50:25 INFO - PROCESS | 2304 | |10;stanford-crypto-aes;84;88;85;83;84;85;86;86;89;83 05:50:25 INFO - PROCESS | 2304 | |11;stanford-crypto-ccm;135;132;136;130;143;138;131;145;135;132 05:50:25 INFO - PROCESS | 2304 | |12;stanford-crypto-pbkdf2;137;140;143;142;143;146;141;143;139;152 05:50:25 INFO - PROCESS | 2304 | |13;stanford-crypto-sha256-iterative;68;67;88;92;93;75;68;70;101;99 05:50:25 INFO - PROCESS | 2304 | __end_tp_report 05:50:25 INFO - PROCESS | 2304 | __start_cc_report 05:50:25 INFO - PROCESS | 2304 | _x_x_mozilla_cycle_collect,881 05:50:25 INFO - PROCESS | 2304 | __end_cc_report 05:50:25 INFO - PROCESS | 2304 | __startTimestamp1455717025167__endTimestamp 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | ------- Summary: start ------- 05:50:25 INFO - PROCESS | 2304 | Number of tests: 14 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.00 stddev:4.09 (3.5%) stddev-sans-first:4.30 05:50:25 INFO - PROCESS | 2304 | Values: 115.0 111.0 115.0 117.0 115.0 127.0 116.0 115.0 117.0 116.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:146.50 stddev:15.29 (10.4%) stddev-sans-first:15.23 05:50:25 INFO - PROCESS | 2304 | Values: 155.0 121.0 149.0 155.0 122.0 144.0 143.0 117.0 158.0 137.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#2] audio-dft Cycles:10 Average:203.50 Median:202.50 stddev:8.96 (4.4%) stddev-sans-first:8.66 05:50:25 INFO - PROCESS | 2304 | Values: 193.0 201.0 203.0 204.0 209.0 226.0 197.0 200.0 202.0 200.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#3] audio-fft Cycles:10 Average:73.20 Median:62.00 stddev:20.39 (32.9%) stddev-sans-first:21.63 05:50:25 INFO - PROCESS | 2304 | Values: 73.0 66.0 74.0 110.0 57.0 58.0 68.0 58.0 110.0 58.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:79.50 stddev:17.79 (22.4%) stddev-sans-first:17.92 05:50:25 INFO - PROCESS | 2304 | Values: 78.0 82.0 117.0 79.0 81.0 85.0 121.0 100.0 80.0 116.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:87.50 stddev:14.66 (16.8%) stddev-sans-first:15.14 05:50:25 INFO - PROCESS | 2304 | Values: 88.0 112.0 130.0 93.0 87.0 92.0 87.0 91.0 86.0 109.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:96.00 stddev:2.45 (2.6%) stddev-sans-first:2.59 05:50:25 INFO - PROCESS | 2304 | Values: 96.0 97.0 98.0 96.0 96.0 96.0 96.0 95.0 103.0 94.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#7] imaging-desaturate Cycles:10 Average:103.50 Median:92.00 stddev:24.66 (26.8%) stddev-sans-first:18.55 05:50:25 INFO - PROCESS | 2304 | Values: 153.0 147.0 90.0 93.0 92.0 90.0 97.0 92.0 88.0 93.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:57.00 stddev:7.14 (12.5%) stddev-sans-first:7.43 05:50:25 INFO - PROCESS | 2304 | Values: 56.0 57.0 57.0 55.0 57.0 57.0 59.0 76.0 70.0 55.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#9] json-stringify-tinderbox Cycles:10 Average:74.70 Median:71.00 stddev:10.25 (14.4%) stddev-sans-first:10.67 05:50:25 INFO - PROCESS | 2304 | Values: 69.0 65.0 71.0 71.0 82.0 73.0 69.0 79.0 100.0 68.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:2.00 (2.3%) stddev-sans-first:2.07 05:50:25 INFO - PROCESS | 2304 | Values: 84.0 88.0 85.0 83.0 84.0 85.0 86.0 86.0 89.0 83.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:135.50 stddev:5.03 (3.7%) stddev-sans-first:5.33 05:50:25 INFO - PROCESS | 2304 | Values: 135.0 132.0 136.0 130.0 143.0 138.0 131.0 145.0 135.0 132.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:143.00 stddev:4.14 (2.9%) stddev-sans-first:3.87 05:50:25 INFO - PROCESS | 2304 | Values: 137.0 140.0 143.0 142.0 143.0 146.0 141.0 143.0 139.0 152.0 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - PROCESS | 2304 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.10 Median:81.50 stddev:13.81 (16.9%) stddev-sans-first:13.67 05:50:25 INFO - PROCESS | 2304 | Values: 68.0 67.0 88.0 92.0 93.0 75.0 68.0 70.0 101.0 99.0 05:50:25 INFO - PROCESS | 2304 | -------- Summary: end -------- 05:50:25 INFO - PROCESS | 2304 | 05:50:25 INFO - TEST-INFO | 2304: exit 0 05:50:25 INFO - TEST-OK | kraken | took 63835ms 05:50:25 INFO - SUITE-END | took 1174s 05:50:26 INFO - Completed test suite (00:19:34) 05:50:26 INFO - Working with test: dromaeo_css 05:50:26 INFO - Generating results file: dromaeo_css 05:50:26 INFO - Working with test: kraken 05:50:26 INFO - Generating results file: kraken 05:50:26 INFO - javascript benchmark 05:50:26 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 05:50:26 INFO - process_Request line: dromaeo_css 7494.78 graph.html#tests=[[72,64,61]] 05:50:26 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:26 INFO - process_Request line: kraken 1505.10 graph.html#tests=[[232,64,61]] 05:50:26 INFO - RETURN: dromaeo_css: 7494.78 05:50:26 INFO - RETURN: kraken: 1505.10 05:50:26 INFO - javascript benchmark 05:50:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3409.9318013639727, 3537.0273174876907, 3593.8562457501703, 3596.6403359664037, 3599.6040435552095, 4418.2268103082, 5715.885682286362, 5764.798232061873, 5820.0, 5828.766849326027, 5697.287839020122, 5786.334571524276, 5803.738831752571, 5885.470307672319, 5895.764169433228, 5213.765380557875, 5266.210068489719, 5295.761690723926, 5298.841034768944, 5302.1781623848365, 5289.920651190235, 5311.937612477501, 5358.089124848766, 5374.838754837361, 5378.596605254602, 5156.767945442464, 5176.145935920568, 5309.044372013036, 5309.681419114827, 5341.7596208170335, 5293.417724050351, 5302.761375738062, 5314.202869569557, 5332.253484512172, 5386.811461598825, 5159.458256883011, 5211.452797456251, 5274.129768588178, 5296.09966305729, 5321.281626980347, 4733.905321893543, 5202.219667049935, 5717.0, 5754.625949313281, 5757.856053598652, 6259.436650701413, 6294.496440284766, 6297.055441683784, 6319.020551814476, 6328.557001009931, 6204.720787564571, 6220.911340515437, 6250.96874515629, 6280.309165991737, 6296.181496405484, 5938.0, 5968.045112781934, 5970.34326224115, 5981.37195594465, 6052.636841789506, 6252.468540174136, 6398.488120950313, 6445.484361251089, 6452.1289625900845, 6457.225132984072, 6178.165947597106, 6299.464545513591, 6320.968395157995, 6323.36766323364, 6327.810165695037, 5169.560587350042, 6256.37334293087, 6314.273858506239, 6317.7157027932935, 6324.936750632527, 6128.014278093809, 6179.196704428396, 6287.654179020106, 6314.747410103636, 6329.145565348619, 4965.379327584052, 6284.874302513924, 6297.685115744286, 6317.4946004319545, 6342.619442833445, 4880.145974454527, 5011.337188976433, 5012.1980483122525, 5021.698698078127, 5023.974880125576, 4397.450318710161, 4434.401355816988, 4482.013956929471, 4482.9775851121185, 4484.708493947948, 5933.9406605934255, 5949.196858424144, 5975.492083172979, 6003.0, 6029.457348838626, 6234.251889773256, 6245.250569931637, 6324.177856878577, 6341.556091073673, 6344.270408903035, 5933.0, 5957.404259574095, 5972.552058595623, 5992.520598352121, 5992.910106348409, 5460.017196904595, 5481.75332110056, 5488.670679759227, 5498.1752737089755, 5513.669179849142, 6010.9699451502465, 6373.999999999907, 6396.488280937514, 6470.708818103197, 6517.250516190509, 6284.780032698834, 6302.086197501245, 6315.084312774714, 6318.747250109944, 6330.52521060913, 6491.318411566717, 6522.804315870531, 6532.444742196966, 6534.607923524603, 6551.80344589663, 6135.538906164888, 6166.506679465721, 6326.588771729823, 6335.619862808247, 6335.841603959938, 6221.782237621662, 6253.78111766086, 6283.96858015707, 6317.684115794284, 6332.683365831782, 6109.95128740435, 6174.073888916699, 6288.182536270256, 6298.842528936813, 6308.621482711052, 5062.898742025212, 6125.938740612537, 6245.594036387621, 6305.0, 6326.462250708557, 6048.848778780566, 6153.753849845956, 6162.568620196544, 6167.84580385494, 6172.321044684992, 6112.959454150325, 6159.538034647509, 6221.688915554114, 6247.562670613013, 6275.152854364603, 6119.602225855305, 6150.938490615036, 6159.4456498915315, 6188.907166392418, 6193.349698281796], "unit": "score", "name": "dojo.html", "value": 5778.960378815899}, {"lowerIsBetter": false, "replicates": [463.24722326219893, 482.77550938813465, 486.9975650121749, 499.291006770386, 566.9773209071636, 33206.0, 33935.15162120948, 34880.65119348812, 38990.80504597477, 39091.80454097729, 39866.0, 40321.39517907234, 40485.0, 40562.0, 40767.0, 9435.38669986452, 9622.134007939285, 9650.083242092025, 9658.74436323277, 9723.659671911484, 8201.876971845428, 9561.521923903812, 9645.421274723503, 9656.275779316544, 9683.951580242088, 9554.0, 9592.904070959306, 9625.37435066722, 9632.855507167398, 9669.12977831995, 8393.412461127755, 9465.148136667663, 9669.854952175689, 9697.6605818796, 9707.077827606367, 8248.298894593907, 9462.243020558408, 9539.952300238454, 9587.808243835154, 9640.614375424975, 37489.43765843487, 37538.249235015144, 37694.43458348127, 37769.43345849815, 37851.053723656856, 2572.4340645058246, 2735.534959056965, 3019.698030196963, 3674.3018826422895, 4016.638502534786, 24375.0, 24832.875835620707, 24850.254492365257, 25115.62326565103, 25134.371640708945, 2768.1280396674983, 2778.6248856404327, 2814.6059551662784, 2857.8713957871737, 2921.0360581008217, 352745.2362738196, 353329.0, 354187.0, 354204.0, 577923.1103844496, 58829.70585147047, 59279.0, 59375.70312148412, 59399.81200375968, 59490.70254648785, 59874.70062649746, 59982.40017599768, 60994.0, 60997.69501152466, 60998.0, 15813.762793558106, 15846.207689615474, 15873.206339682969, 16126.919365403333, 16134.677306453805, 11999.220050696851, 12305.138640295272, 12309.0, 12537.310447925453, 12582.37088145589, 18604.627907441776, 18657.160427780782, 18661.626767464575, 18694.252229910922, 18742.718859217122, 7209.89185162223, 8322.50064996102, 8490.533020683799, 8552.786180345542, 8562.400631955703, 934.556085859225, 961.33667769239, 1112.477135746198, 1137.4312843578211, 1153.325304696745, 28003.579946300822, 29061.85469072641, 29481.410371792444, 29622.630189584783, 29650.406991860473, 930.5626355612851, 983.4050399508337, 995.2784231432154, 1123.3035517978742, 1210.2012671636678, 13745.175289482662, 13834.515791947233, 13975.0, 14026.85973140276, 14065.0, 550244.0, 551164.0, 556209.0, 556215.0, 559289.0, 53493.46506534963, 53784.46215537873, 53827.0, 53929.46070539244, 54138.0, 1428.2002078835678, 1451.535508637226, 1452.5424491285212, 1462.6855226126434, 1593.139704559525, 25267.241982740547, 26688.332791680365, 28104.437911241253, 28159.43681126325, 28672.42655146927, 48327.27509087437, 48710.0, 48843.51156488532, 48993.265101024226, 49052.0, 451971.0, 524975.0, 527072.0, 527219.0, 527437.0, 31725.682743173194, 32005.0, 32980.67019329776, 33022.33955320928, 33150.005499835046, 30801.845990769903, 40576.59423405728, 41164.794176028925, 41303.7934810324, 42353.364699530146, 29949.700502994692, 33768.0, 34477.31045379129, 34620.961371158905, 41412.792936035126, 31868.0, 34775.47836782501, 37003.704870329406, 37580.624193758806, 39193.41209881911, 37674.81162594169, 38405.0, 38906.221875561765, 39228.215435691694, 39243.0, 30890.227744306572, 37268.813655931546, 37738.62261377461, 39390.60609393984, 39548.209035819695, 26464.0, 26949.3262668427, 26953.0566430174, 27018.729812701622, 27300.180994570193], "unit": "score", "name": "ext.html", "value": 19241.40704230094}, {"lowerIsBetter": false, "replicates": [360.54751287134644, 364.19149488136327, 364.61168855169245, 369.6672994305125, 370.50722539023104, 15427.6070879039, 19128.617427651458, 19138.71291930622, 19605.607887842252, 20341.694874576893, 11602.07183425326, 13303.0, 19065.760725552864, 19183.0, 19401.708974365396, 3804.4673745675627, 4417.801198946047, 5403.405625381205, 5415.53967912726, 5416.404195538487, 5712.257406537145, 5992.460678538931, 5997.88004239915, 6004.219451471325, 6044.455998960093, 5687.630304030225, 5898.852528686795, 5901.5278777697895, 5907.5864689471755, 5972.0, 5835.183074369592, 5888.087346461305, 5894.793682221145, 5934.465898069173, 6523.086767852505, 5727.3699893011735, 5747.971260143672, 5748.97125514374, 5760.855978600526, 5771.480566748971, 19063.618727625508, 23992.760072399225, 24108.156214532406, 24347.026118955222, 24379.756202438104, 2004.7794742578305, 2076.9169233230655, 2121.819645330149, 2192.967105493403, 2222.75549689534, 8114.837703245961, 9653.806923861554, 9849.359791613522, 9927.553260103312, 10151.0, 1731.6709825133184, 1769.672610567049, 1789.6599646067205, 1821.5355084453513, 1822.6810308196145, 92954.0704592959, 98596.52105218428, 98696.50651746767, 98816.0, 101107.0, 11127.777444451065, 11357.659270221906, 11370.829437558443, 11386.829197562043, 11513.597024104116, 13483.921286297269, 13603.863961360457, 13604.591862243951, 13617.659558511117, 13659.317034148253, 8555.743327700178, 8627.051024387312, 8652.956735216283, 8664.48013119215, 8675.219230269306, 7005.439564834801, 7795.4543181976715, 8725.389222754346, 8739.737807865775, 8811.339149563808, 3274.787138835968, 4266.807993640232, 4407.889802754957, 4426.84506042287, 4440.533743956838, 1511.3878879054, 1856.7493388392395, 1887.5658598522143, 1887.8489720822301, 1901.990490047541, 911.7948461596088, 966.6036924860914, 976.770458942148, 1007.6120693532896, 1047.4657924458581, 13888.791668124986, 15182.013169144191, 16814.90703104294, 16874.662506750043, 21217.363479095653, 898.3576742629051, 955.1594596754811, 958.247775496246, 1019.8623185869961, 1037.5797801890246, 7301.707931682779, 9423.19902808269, 10488.632897848538, 11027.283226590245, 11149.442527873574, 688281.0, 719881.0, 732061.0, 761023.0, 784285.0, 111842.44078779554, 111894.44052779685, 112763.0, 113534.0, 114622.0, 1128.8588926384202, 1181.4919584578713, 1182.3319824299244, 1188.0495603517152, 1189.7025743564109, 18202.81797182064, 18802.811971880106, 18804.623907521498, 19000.714989274897, 19103.52241193981, 48366.19605647345, 49350.0, 49931.50068499269, 50039.0, 50148.74925625348, 68471.0, 70307.64846175736, 72229.6388518054, 72434.18914527178, 72515.37423128718, 7507.887381689388, 7551.848963020599, 7574.166841647525, 7845.803854903673, 7891.64487598071, 11997.340146292037, 12571.371431428575, 12629.3685315732, 12760.229720028448, 12865.0, 10632.362058276529, 10832.241743078224, 10953.61662341846, 11095.611653592085, 11098.667039988813, 6379.947308694013, 8282.50304981703, 10769.9461502692, 10959.01368876805, 11106.888931110585, 10939.945300273766, 11074.612388566362, 11090.611828585961, 11142.27575207609, 11481.712957176138, 7557.659905304165, 7794.142644309235, 7857.332126769289, 7958.243966823143, 7967.32277756374, 8508.489490630582, 10872.728181795519, 10884.891151088388, 10907.727306817393, 11087.168462365193], "unit": "score", "name": "jquery.html", "value": 9161.996408564612}, {"lowerIsBetter": false, "replicates": [1536.815582130144, 1553.7669349597556, 1788.5081602559294, 1897.7627796525435, 1903.9428817135474, 7783.3384162346265, 8348.791280217998, 8486.787830304238, 8591.570421478933, 8624.91375086249, 8412.158784121584, 8511.0, 8578.871316930252, 8609.827803443928, 8611.741647750561, 2111.788821117884, 2451.84063035903, 2476.3437689012426, 2477.2320580619976, 2480.193936970492, 2435.2694191742494, 2460.458699086207, 2477.182529765173, 2478.033566908907, 2487.328421326241, 2169.858959167657, 2389.1637926725593, 2457.1522824625563, 2474.604063349864, 2476.962845557318, 1856.5637075287298, 2132.3922682035545, 2363.7872591466767, 2367.6093444581625, 2404.9077302746637, 2107.947301317464, 2250.17868478006, 2428.1258746851117, 2438.085717855804, 2446.0949448703914, 8553.828923421497, 8587.0, 8598.527081010541, 8625.956870215608, 8642.827143457158, 5256.106461901448, 5395.29861118056, 5405.864853378657, 5416.187571864252, 5521.1442226454965, 3555.1604267391153, 3556.6621170988715, 3598.9100272493133, 3657.359962006665, 3661.048127486846, 965.1554889471712, 966.7679756858304, 1041.1462600667455, 1057.4395570347729, 1075.7095584192225, 11652.184347095706, 11661.0088142508, 11675.708107297301, 11679.0, 11737.237079589799, 4084.673226141961, 4838.104950584153, 4905.141600219948, 4922.827701030518, 4941.950580494149, 9862.211023118134, 9960.302778805413, 9978.351407158656, 9978.750531236778, 10036.949815250877, 5371.704556249444, 5426.321709786277, 5436.592255580847, 5445.891082178334, 5449.0, 4076.286649836326, 4905.435874874363, 4943.406791185081, 4944.406671199479, 4963.726995015237, 3696.2237930034457, 3725.012871589031, 3746.157114649182, 3781.489498917666, 3781.905452363713, 1162.9584309512004, 1165.242592315002, 1170.5727409495644, 1173.6948393417772, 1180.2682336951145, 1023.7952409517977, 1118.2060736876908, 1139.4986206069468, 1238.2013601227159, 1335.5392389625563, 7713.961430192813, 7758.107817600935, 7843.294103530709, 7855.960720196363, 7939.166387529342, 1196.4496331687521, 1200.4897918384652, 1204.0909113619161, 1210.4673943464848, 1234.4259919137464, 6086.847828804227, 6118.449339559461, 6142.692865356804, 6146.661933593696, 6192.752289908443, 10031.347962382422, 10314.690559283234, 10326.328788628714, 10333.328333658439, 10395.16838652906, 9929.851052234222, 10176.389416634878, 10300.0, 10307.0, 10334.224933130045, 7985.321247693895, 8071.9506464159285, 8129.8374032520205, 8203.9745031871, 8234.464759790715, 7925.167857374892, 7943.642536086006, 7995.400344974034, 8038.63826127814, 8107.1892810718455, 8083.514989100673, 9312.534373281173, 9390.696005740232, 9414.2468602513, 9487.0, 8157.6329065193395, 8272.545010024507, 9626.566804493674, 9835.213182945205, 9890.901090989286, 6422.454091402283, 7204.207537171012, 7436.665350059152, 7453.478256521991, 7489.101307843093, 7926.326262267772, 7999.480033797785, 8032.919670803217, 8073.717419890276, 8120.350371970347, 5556.583256255716, 7680.116786569616, 7758.107817600822, 7820.413468989735, 7842.607869606611, 7260.056192694916, 7313.049303590499, 7386.667599958122, 7400.333969942731, 7491.288327608869, 7604.315611594983, 7669.693212271447, 7672.38620910337, 7679.961600192187, 7692.0, 6911.861762764817, 6942.097527321416, 6949.235584085847, 6956.0, 6985.301469852974, 5828.70856457167, 6997.440204783503, 7009.684564194521, 7032.12098487689, 7109.360157585842], "unit": "score", "name": "mootools.html", "value": 4833.511253566283}, {"lowerIsBetter": false, "replicates": [279.876854184159, 326.14549879316195, 329.39227125952607, 330.5933701547099, 331.8937939859243, 6717.764878229263, 6881.827954301139, 6910.75812346568, 6993.930060699391, 7009.859802803947, 6935.930640693604, 6940.548864323815, 6968.1986571544285, 6993.580385176893, 7008.159020917497, 5117.565006974393, 5125.513076257749, 5128.640995130342, 5148.768305426255, 5162.974185129069, 4809.206480930642, 5100.158473851829, 5131.512506311913, 5141.511556402154, 5144.151215049513, 4919.434265059528, 4923.950760492385, 4936.481669424713, 4944.085344211315, 4948.653594248404, 4914.729689867056, 4919.237518184687, 4970.552650261494, 4988.625853061035, 4988.7505624718615, 3734.9626503734885, 3982.064214909494, 4146.792660366999, 4182.456280683522, 4213.599708027732, 5180.222966555009, 5239.528442440161, 6457.709403076873, 6559.737610495575, 6573.737050517973, 5871.794487192928, 5890.322612899528, 5900.822975310747, 5911.349751527328, 5945.137954996501, 5907.763689452459, 7157.785266442015, 7352.1326682593835, 7394.223606521292, 7403.925960740377, 4677.438707355105, 4678.578927896506, 4682.391289132425, 4691.554302341272, 4705.200115980291, 7825.491343062683, 7851.8037049073655, 7857.8035549111155, 7889.96055019727, 7920.881186782145, 3709.703223742094, 4661.376745820229, 4738.431388233434, 4752.7623618818925, 4761.904761904742, 4846.660733748674, 4849.781759820817, 4850.151223535938, 4857.53853383928, 4867.756612169377, 5812.534997200299, 5830.795922142789, 5840.5035571976005, 5846.386129456346, 5853.619514731528, 6448.645324507103, 7400.148982866932, 7419.258074192646, 7428.071491063617, 7443.144038435649, 1621.6108134047743, 1663.3512929957326, 1686.0473832284965, 1686.9072201029062, 1690.560454281871, 858.6436628799104, 1058.3015209961388, 1069.417167643636, 1069.6951368859993, 1084.9728756781144, 4949.678270912379, 5316.83029733458, 6600.372964568358, 6692.531522793358, 6911.89632155508, 6073.544484163705, 6857.451403887677, 7638.923610763822, 7649.38804895607, 7656.234376562299, 6739.898901516482, 6889.896651550231, 6897.62063086525, 6899.689513971884, 6921.550099243533, 2969.3319003224533, 3427.8114703691535, 3441.6214216436174, 4070.2063097695664, 4138.503379594468, 8083.83832323362, 8195.63978768702, 8211.507309561446, 8213.753587392268, 8220.136885627042, 6730.32696730323, 7854.567998760123, 8045.637946292314, 8066.193380661887, 8077.0, 7962.56205908669, 8116.0, 8172.0, 8183.468074575134, 8192.508449493049, 7060.223375428596, 7788.065432148179, 7817.609119544114, 7826.373890088893, 7844.372450204084, 7372.815679608053, 7649.579273140031, 7652.387808975157, 7673.155952845294, 7692.653830577526, 6158.0147176451555, 7028.4728645352825, 7198.604076775828, 7345.485815993043, 7621.580813055335, 4786.282057691375, 4809.591184749195, 4816.494268101799, 4819.542143496362, 4826.0, 7431.219721929119, 7732.30409263169, 7765.495242809199, 7769.53382797034, 7786.26030527099, 7431.331180193809, 7442.665080071301, 7443.292887175926, 7443.702251910079, 7445.813854653677, 7435.591042492715, 7459.589722565094, 7493.812654683677, 7521.548707077593, 7550.509216900884, 7104.893426598708, 7357.668904899186, 7363.558186508827, 7370.926290737239, 7376.225496322809, 6126.203593532812, 7495.901147678659, 7512.586807725627, 7538.736144234926, 7542.358899493385, 7142.892856607051, 7338.853222935618, 7380.188179300165, 7380.483366164317, 7421.851562968818], "unit": "score", "name": "prototype.html", "value": 5285.96074798275}, {"lowerIsBetter": false, "replicates": [665.0921492163197, 704.27459716492, 713.5754226235391, 715.3168723868706, 732.857092866891, 13166.288382510273, 14964.476243331486, 14972.775408368856, 15072.0, 15112.319945602447, 12094.576689815858, 13693.972952028587, 14329.92835035826, 14489.130652160879, 14518.564443066698, 703.3388614702163, 833.7748807821885, 846.7840700621333, 867.0, 872.3108744092191, 720.7297263526177, 861.9569021548898, 862.0259107208876, 873.5326600268858, 878.0999475537593, 899.7615631857562, 901.3600343755941, 913.954302284883, 915.0483497162976, 916.715818096389, 890.8351954888367, 894.1058941058941, 900.7072701372015, 901.6393442622938, 901.9774505637346, 669.1602039440471, 670.6244503078292, 671.9529632925697, 673.9663016849187, 674.6188403551978, 15178.0, 15222.238888055554, 15276.618084547865, 15281.235938203157, 15313.61715957099, 12812.29532375719, 12965.935170324088, 12999.025073119554, 13084.345782710827, 13124.6718832029, 10040.89959100407, 10144.797104057878, 10180.541875615616, 10261.384316941007, 10545.0, 3574.4102223133414, 3582.6596473335253, 3586.085548185196, 3590.6409359064146, 3709.9443508347395, 87395.25209495838, 88494.0, 89284.10715892822, 90741.54629226877, 90942.54528727314, 9441.622335106656, 9670.903290967, 9834.508274586242, 9858.802823943624, 10202.693919182437, 21610.45973850635, 21905.890470547547, 21926.671099933516, 21942.122315107536, 21956.341309760734, 6502.0, 7278.526895751759, 7644.617769111522, 7694.345980591713, 7736.303732663975, 4093.283675356801, 4121.5878412158545, 4151.294279972412, 4160.583941605815, 4166.895827604334, 2893.2911436698146, 3038.893638722678, 3338.582677165354, 3500.7222363837527, 3516.40221162403, 630.1555915073732, 636.1697984130661, 640.5132099604334, 660.1253339325413, 662.4766434516774, 528.8783579776673, 558.7792821835352, 612.0941007309208, 620.0420350558308, 622.2346513787976, 8045.9597702011115, 8117.95941020303, 8257.091719910804, 8504.617292221865, 8619.310455163572, 534.161366654349, 549.6372394219795, 605.0984033789622, 612.2622240200548, 625.1217040058634, 3973.1060511385285, 3975.9662487753394, 3986.60133986599, 3994.420808982681, 4036.233115708006, 91927.62108568377, 93613.0, 93905.0, 94613.0, 94796.0, 83345.16654833495, 83969.74045389325, 84017.15982840216, 84204.0, 85115.5744221275, 71832.64083679549, 73402.0, 73728.0, 73835.0, 74262.6286868573, 6839.863202736017, 7191.849304111317, 8072.919270807217, 8233.382496312921, 8293.585320733819, 50365.74817125891, 53215.46784532105, 53488.197677035656, 53804.730976344865, 54932.450675492735, 68473.65763171153, 68608.0, 68800.6559967197, 73643.52712945604, 73920.52158956684, 9893.702386495417, 9918.0, 9939.503024848584, 9943.801123977335, 10127.949360253151, 10833.945830270799, 10898.455077246264, 10996.395198263852, 11513.424328783694, 11811.468483918072, 9675.758106047406, 10037.397756134655, 10591.788164236517, 10653.627123050655, 10658.307210031324, 10556.84164737545, 10629.25595208328, 10642.84035739449, 10753.569857205937, 10763.838542422027, 10110.292279540361, 10275.177985761271, 10393.480325983823, 10491.527881245514, 10519.94740026295, 8808.0311165773, 8903.0, 8974.775630609287, 9174.954125229331, 9256.444613323221, 8610.65557377698, 8779.385443018928, 9002.414843035443, 9170.312226582899, 9179.265658747418], "unit": "score", "name": "yui.html", "value": 6808.572118297166}], "name": "dromaeo_css", "value": 7494.77790211287}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 115.0, 117.0, 115.0, 127.0, 116.0, 115.0, 117.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 149.0, 155.0, 122.0, 144.0, 143.0, 117.0, 158.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 140.1}, {"lowerIsBetter": true, "replicates": [193.0, 201.0, 203.0, 204.0, 209.0, 226.0, 197.0, 200.0, 202.0, 200.0], "unit": "score", "name": "audio-dft", "value": 203.5}, {"lowerIsBetter": true, "replicates": [73.0, 66.0, 74.0, 110.0, 57.0, 58.0, 68.0, 58.0, 110.0, 58.0], "unit": "score", "name": "audio-fft", "value": 73.2}, {"lowerIsBetter": true, "replicates": [78.0, 82.0, 117.0, 79.0, 81.0, 85.0, 121.0, 100.0, 80.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 93.9}, {"lowerIsBetter": true, "replicates": [88.0, 112.0, 130.0, 93.0, 87.0, 92.0, 87.0, 91.0, 86.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 95.0, 103.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 96.7}, {"lowerIsBetter": true, "replicates": [153.0, 147.0, 90.0, 93.0, 92.0, 90.0, 97.0, 92.0, 88.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 103.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 55.0, 57.0, 57.0, 59.0, 76.0, 70.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [69.0, 65.0, 71.0, 71.0, 82.0, 73.0, 69.0, 79.0, 100.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 74.7}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 85.0, 83.0, 84.0, 85.0, 86.0, 86.0, 89.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [135.0, 132.0, 136.0, 130.0, 143.0, 138.0, 131.0, 145.0, 135.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.7}, {"lowerIsBetter": true, "replicates": [137.0, 140.0, 143.0, 142.0, 143.0, 146.0, 141.0, 143.0, 139.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 88.0, 92.0, 93.0, 75.0, 68.0, 70.0, 101.0, 99.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 82.1}], "name": "kraken", "value": 1505.1}]} 05:50:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1505.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7494.78"}}} 05:50:26 INFO - Return code: 0 05:50:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:50:26 ERROR - # TBPL SUCCESS # 05:50:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:50:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:50:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:50:26 INFO - 2016-02-17 05:50:26.850 screenresolution[2309:30749] starting screenresolution argv=screenresolution get 05:50:26 INFO - 2016-02-17 05:50:26.853 screenresolution[2309:30749] Display 0: 1600x1200x32@60 05:50:26 INFO - 2016-02-17 05:50:26.859 screenresolution[2310:30752] starting screenresolution argv=screenresolution list 05:50:26 INFO - Available Modes on Display 0 05:50:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:50:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:50:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:50:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:50:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:50:27 INFO - Intel Iris: 05:50:27 INFO - Chipset Model: Intel Iris 05:50:27 INFO - Type: GPU 05:50:27 INFO - Bus: Built-In 05:50:27 INFO - VRAM (Dynamic, Max): 1536 MB 05:50:27 INFO - Vendor: Intel (0x8086) 05:50:27 INFO - Device ID: 0x0a2e 05:50:27 INFO - Revision ID: 0x0009 05:50:27 INFO - Displays: 05:50:27 INFO - Display: 05:50:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:50:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:50:27 INFO - Display Serial Number: 1600x1200 60 05:50:27 INFO - Main Display: Yes 05:50:27 INFO - Mirror: Off 05:50:27 INFO - Online: Yes 05:50:27 INFO - Rotation: Supported 05:50:27 INFO - Return code: 0 05:50:27 INFO - Running post-action listener: _resource_record_post_action 05:50:27 INFO - Running post-run listener: _resource_record_post_run 05:50:28 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 0; Write bytes: 710249472; Read time: 0; Write time: 2223 05:50:28 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403513856; Write bytes: 397952512; Read time: 30174; Write time: 659 05:50:28 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 0; Write bytes: 302831104; Read time: 0; Write time: 1536 05:50:28 INFO - Running post-run listener: _upload_blobber_files 05:50:28 INFO - Blob upload gear active. 05:50:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:50:28 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 05:50:28 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'] 05:50:28 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 05:50:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:50:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:50:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:50:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:29 INFO - (blobuploader) - INFO - Done attempting. 05:50:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:50:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:50:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:31 INFO - (blobuploader) - INFO - Done attempting. 05:50:31 INFO - (blobuploader) - INFO - Iteration through files over. 05:50:31 INFO - Return code: 0 05:50:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:50:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:50:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd8369196a489dd09990b61410885666bb89611fc9c17aed5b8bf3b7e8bfe0a2b8930118152e667788c74b13307311d1d336dd1227a91768861840737aec734e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/310006520e523fa12b0d938525bda46202768c8a936fcc6ed91c8f8bfe380c1804ee7ac4ccd62077ffd2b80fdc86f74755e8cc73e79ab62793c801b5fb34a31a"} 05:50:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:50:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:50:31 INFO - Contents: 05:50:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd8369196a489dd09990b61410885666bb89611fc9c17aed5b8bf3b7e8bfe0a2b8930118152e667788c74b13307311d1d336dd1227a91768861840737aec734e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/310006520e523fa12b0d938525bda46202768c8a936fcc6ed91c8f8bfe380c1804ee7ac4ccd62077ffd2b80fdc86f74755e8cc73e79ab62793c801b5fb34a31a"} 05:50:31 INFO - Running post-run listener: copy_logs_to_upload_dir 05:50:31 INFO - Copying logs to upload dir... 05:50:31 INFO - mkdir: /builds/slave/test/build/upload/logs 05:50:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.681406 ========= master_lag: 4.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-17 05:50:35.519024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 05:50:35.522690) ========= 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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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/fd8369196a489dd09990b61410885666bb89611fc9c17aed5b8bf3b7e8bfe0a2b8930118152e667788c74b13307311d1d336dd1227a91768861840737aec734e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/310006520e523fa12b0d938525bda46202768c8a936fcc6ed91c8f8bfe380c1804ee7ac4ccd62077ffd2b80fdc86f74755e8cc73e79ab62793c801b5fb34a31a"} build_url:https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011788 build_url: 'https://queue.taskcluster.net/v1/task/C5-gXQYDQNSBP_1TIqEvAg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd8369196a489dd09990b61410885666bb89611fc9c17aed5b8bf3b7e8bfe0a2b8930118152e667788c74b13307311d1d336dd1227a91768861840737aec734e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/310006520e523fa12b0d938525bda46202768c8a936fcc6ed91c8f8bfe380c1804ee7ac4ccd62077ffd2b80fdc86f74755e8cc73e79ab62793c801b5fb34a31a"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 05:50:35.573881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:50:35.574401) ========= 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.NCYGJ2AUKg/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.EtnvHB9YXj/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005559 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:50:35.638744) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 05:50:35.639058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 05:50:35.639522) ========= ========= Total master_lag: 4.63 =========