builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0172 starttime: 1458781894.11 results: success (0) buildid: 20160323145252 builduid: 51edfbf8bcec4dc99eefaf57ef5ee958 revision: 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 18:11:34.112653) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 18:11:34.113076) ========= ========= Started set props: basedir (results: 0, elapsed: 8 secs) (at 2016-03-23 18:11:34.113368) ========= 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.VSplhcdHZb/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.lBGSHKbv7s/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005429 basedir: '/builds/slave/test' ========= master_lag: 8.41 ========= ========= Finished set props: basedir (results: 0, elapsed: 8 secs) (at 2016-03-23 18:11:42.525182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 16 secs) (at 2016-03-23 18:11:42.525538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 16 secs) (at 2016-03-23 18:11:58.546186) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 18:11:58.546782) ========= 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.VSplhcdHZb/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.lBGSHKbv7s/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005341 ========= master_lag: 0.84 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 18:11:59.389012) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 18:11:59.389306) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 18:11:59.389664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-23 18:11:59.389974) ========= 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.VSplhcdHZb/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.lBGSHKbv7s/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-23 18:12:00-- 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% 44.7M=0s 2016-03-23 18:12:00 (44.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.779925 ========= master_lag: 1.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-23 18:12:01.719045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 18:12:01.719393) ========= 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.VSplhcdHZb/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.lBGSHKbv7s/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.019116 ========= master_lag: 0.56 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 18:12:02.301352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-23 18:12:02.301717) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 --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 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VSplhcdHZb/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.lBGSHKbv7s/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-23 18:12:02,415 truncating revision to first 12 chars 2016-03-23 18:12:02,415 Setting DEBUG logging. 2016-03-23 18:12:02,415 attempt 1/10 2016-03-23 18:12:02,415 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7b0bb5c3ab01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 18:12:03,993 unpacking tar archive at: fx-team-7b0bb5c3ab01/testing/mozharness/ program finished with exit code 0 elapsedTime=2.037979 ========= master_lag: 0.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-23 18:12:04.685253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 18:12:04.685678) ========= echo 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VSplhcdHZb/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.lBGSHKbv7s/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 program finished with exit code 0 elapsedTime=0.005211 script_repo_revision: '7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1' ========= master_lag: 0.29 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 18:12:04.976826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 18:12:04.977141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 18:12:05.227050) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-03-23 18:12:05.227654) ========= /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.VSplhcdHZb/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.lBGSHKbv7s/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:12:05 INFO - MultiFileLogger online at 20160323 18:12:05 in /builds/slave/test 18:12:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:12:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:12:05 INFO - {'append_to_log': False, 18:12:05 INFO - 'base_work_dir': '/builds/slave/test', 18:12:05 INFO - 'blob_upload_branch': 'Fx-Team', 18:12:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:12:05 INFO - 'branch': 'Fx-Team', 18:12:05 INFO - 'buildbot_json_path': 'buildprops.json', 18:12:05 INFO - 'config_files': ('talos/mac_config.py',), 18:12:05 INFO - 'default_actions': ('clobber', 18:12:05 INFO - 'read-buildbot-config', 18:12:05 INFO - 'download-and-extract', 18:12:05 INFO - 'populate-webroot', 18:12:05 INFO - 'create-virtualenv', 18:12:05 INFO - 'install', 18:12:05 INFO - 'run-tests'), 18:12:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:12:05 INFO - 'download_minidump_stackwalk': True, 18:12:05 INFO - 'download_symbols': 'ondemand', 18:12:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:12:05 INFO - 'tooltool.py': '/tools/tooltool.py', 18:12:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:12:05 INFO - '/tools/misc-python/virtualenv.py')}, 18:12:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:12:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:12:05 INFO - 'installer_path': 'installer.exe', 18:12:05 INFO - 'log_level': 'info', 18:12:05 INFO - 'log_name': 'talos', 18:12:05 INFO - 'log_to_console': True, 18:12:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:12:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:12:05 INFO - 'opt_config_files': (), 18:12:05 INFO - 'pip_index': False, 18:12:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:12:05 INFO - 'cmd': ('bash', 18:12:05 INFO - '-c', 18:12:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:12:05 INFO - 'enabled': True, 18:12:05 INFO - 'halt_on_failure': False, 18:12:05 INFO - 'name': 'check_screen_resolution'},), 18:12:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:12:05 INFO - 'cmd': ('bash', 18:12:05 INFO - '-c', 18:12:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:12:05 INFO - 'enabled': True, 18:12:05 INFO - 'halt_on_failure': False, 18:12:05 INFO - 'name': 'check_screen_resolution'},), 18:12:05 INFO - 'run_cmd_checks_enabled': True, 18:12:05 INFO - 'sps_profile': False, 18:12:05 INFO - 'sps_profile_interval': 0, 18:12:05 INFO - 'suite': 'dromaeojs-e10s', 18:12:05 INFO - 'system_bits': '32', 18:12:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:12:05 INFO - 'title': 't-yosemite-r7-0172', 18:12:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:12:05 INFO - 'use_talos_json': True, 18:12:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:12:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:12:05 INFO - 'work_dir': 'build'} 18:12:05 INFO - ##### 18:12:05 INFO - ##### Running clobber step. 18:12:05 INFO - ##### 18:12:05 INFO - Running pre-action listener: _resource_record_pre_action 18:12:05 INFO - Running main action method: clobber 18:12:05 INFO - rmtree: /builds/slave/test/build 18:12:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:12:06 INFO - Running post-action listener: _resource_record_post_action 18:12:06 INFO - ##### 18:12:06 INFO - ##### Running read-buildbot-config step. 18:12:06 INFO - ##### 18:12:06 INFO - Running pre-action listener: _resource_record_pre_action 18:12:06 INFO - Running main action method: read_buildbot_config 18:12:06 INFO - Using buildbot properties: 18:12:06 INFO - { 18:12:06 INFO - "project": "", 18:12:06 INFO - "product": "firefox", 18:12:06 INFO - "script_repo_revision": "production", 18:12:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:12:06 INFO - "repository": "", 18:12:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:12:06 INFO - "buildid": "20160323145252", 18:12:06 INFO - "pgo_build": "False", 18:12:06 INFO - "basedir": "/builds/slave/test", 18:12:06 INFO - "buildnumber": 635, 18:12:06 INFO - "slavename": "t-yosemite-r7-0172", 18:12:06 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:12:06 INFO - "platform": "yosemite_r7", 18:12:06 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 18:12:06 INFO - "branch": "fx-team", 18:12:06 INFO - "repo_path": "integration/fx-team", 18:12:06 INFO - "revision": "7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1", 18:12:06 INFO - "stage_platform": "macosx64", 18:12:06 INFO - "builduid": "51edfbf8bcec4dc99eefaf57ef5ee958", 18:12:06 INFO - "slavebuilddir": "test" 18:12:06 INFO - } 18:12:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:12:06 INFO - Running post-action listener: _resource_record_post_action 18:12:06 INFO - ##### 18:12:06 INFO - ##### Running download-and-extract step. 18:12:06 INFO - ##### 18:12:06 INFO - Running pre-action listener: _resource_record_pre_action 18:12:06 INFO - Running main action method: download_and_extract 18:12:06 INFO - mkdir: /builds/slave/test/build/tests 18:12: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')]} 18:12:06 INFO - https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:12:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:12:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:12:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 18:12:08 INFO - Downloaded 1199 bytes. 18:12:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:12:08 INFO - Using the following test package requirements: 18:12:08 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:12:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:12:08 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:12:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:12:08 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:12:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:12:08 INFO - u'jsshell-mac.zip'], 18:12:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:12:08 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:12:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:12:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:12:08 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:12:08 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:12:08 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:12:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:12:08 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:12:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:12:08 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:12:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:08 INFO - https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:12:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:12:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:12:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:12:12 INFO - Downloaded 17922050 bytes. 18:12:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:12:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:12:15 INFO - Return code: 0 18:12:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:15 INFO - https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:12:18 INFO - Downloaded 17922050 bytes. 18:12:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:12:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:12:22 INFO - Return code: 0 18:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:22 INFO - https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:12:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:12:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:12:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:12:25 INFO - Downloaded 10847187 bytes. 18:12:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:12:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:12:25 INFO - Return code: 0 18:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:25 INFO - https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:12:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:12:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:12:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 18:12:29 INFO - Downloaded 111289133 bytes. 18:12:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:12:29 INFO - mkdir: /builds/slave/test/properties 18:12:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:12:29 INFO - Writing to file /builds/slave/test/properties/build_url 18:12:29 INFO - Contents: 18:12:29 INFO - build_url:https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:12:31 INFO - Running post-action listener: _resource_record_post_action 18:12:31 INFO - Running post-action listener: set_extra_try_arguments 18:12:31 INFO - ##### 18:12:31 INFO - ##### Running populate-webroot step. 18:12:31 INFO - ##### 18:12:31 INFO - Running pre-action listener: _resource_record_pre_action 18:12:31 INFO - Running main action method: populate_webroot 18:12:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:12:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:12:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:12:31 INFO - '--tppagecycles', 18:12:31 INFO - '7'], 18:12:31 INFO - 'tests': ['tsvgm']}}, 18:12:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:12:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:12:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:12:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:12:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:12:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:12:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:31 INFO - 'talos_options': ['--e10s'], 18:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:31 INFO - 'tests': ['damp', 'tps']}, 18:12:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:31 INFO - 'talos_options': ['--e10s'], 18:12:31 INFO - 'tests': ['damp', 'tps']}, 18:12:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:12:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:12:31 INFO - 'other': {'tests': ['a11yr', 18:12:31 INFO - 'ts_paint', 18:12:31 INFO - 'tpaint', 18:12:31 INFO - 'sessionrestore', 18:12:31 INFO - 'sessionrestore_no_auto_restore', 18:12:31 INFO - 'tabpaint']}, 18:12:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:12:31 INFO - 'tests': ['a11yr', 18:12:31 INFO - 'ts_paint', 18:12:31 INFO - 'tpaint', 18:12:31 INFO - 'sessionrestore', 18:12:31 INFO - 'sessionrestore_no_auto_restore', 18:12:31 INFO - 'tabpaint']}, 18:12:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:12:31 INFO - 'tests': ['a11yr', 18:12:31 INFO - 'ts_paint', 18:12:31 INFO - 'tpaint', 18:12:31 INFO - 'sessionrestore', 18:12:31 INFO - 'sessionrestore_no_auto_restore', 18:12:31 INFO - 'tabpaint']}, 18:12:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:12:31 INFO - 'tests': ['a11yr', 18:12:31 INFO - 'ts_paint', 18:12:31 INFO - 'tpaint', 18:12:31 INFO - 'sessionrestore', 18:12:31 INFO - 'sessionrestore_no_auto_restore', 18:12:31 INFO - 'tabpaint']}, 18:12:31 INFO - 'other_l64': {'tests': ['a11yr', 18:12:31 INFO - 'ts_paint', 18:12:31 INFO - 'tpaint', 18:12:31 INFO - 'sessionrestore', 18:12:31 INFO - 'sessionrestore_no_auto_restore', 18:12:31 INFO - 'tabpaint']}, 18:12:31 INFO - 'other_nol64': {'tests': ['a11yr', 18:12:31 INFO - 'ts_paint', 18:12:31 INFO - 'tpaint', 18:12:31 INFO - 'sessionrestore', 18:12:31 INFO - 'sessionrestore_no_auto_restore', 18:12:31 INFO - 'tabpaint']}, 18:12:31 INFO - 'svgr': {'tests': ['tsvgx', 18:12:31 INFO - 'tsvgr_opacity', 18:12:31 INFO - 'tart', 18:12:31 INFO - 'tscrollx', 18:12:31 INFO - 'cart']}, 18:12:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:12:31 INFO - 'tests': ['tsvgx', 18:12:31 INFO - 'tsvgr_opacity', 18:12:31 INFO - 'tart', 18:12:31 INFO - 'tscrollx', 18:12:31 INFO - 'cart']}, 18:12:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:31 INFO - 'tests': ['tp5o']}, 18:12:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:31 INFO - 'talos_options': ['--e10s'], 18:12:31 INFO - 'tests': ['tp5o']}, 18:12:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:31 INFO - 'talos_options': ['--xperf_path', 18:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:31 INFO - 'tests': ['tp5n']}, 18:12:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:31 INFO - 'talos_options': ['--e10s', 18:12:31 INFO - '--xperf_path', 18:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:31 INFO - 'tests': ['tp5n']}}, 18:12:31 INFO - 'talos.zip': {'path': '', 18:12:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:12:31 INFO - Running post-action listener: _resource_record_post_action 18:12:31 INFO - ##### 18:12:31 INFO - ##### Running create-virtualenv step. 18:12:31 INFO - ##### 18:12:31 INFO - Running pre-action listener: _resource_record_pre_action 18:12:31 INFO - Running main action method: create_virtualenv 18:12:31 INFO - Creating virtualenv /builds/slave/test/build/venv 18:12:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:12:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:12:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:12:31 INFO - Using real prefix '/tools/python27' 18:12:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:12:31 INFO - Installing distribute.............................................................................................................................................................................................done. 18:12:34 INFO - Installing pip.................done. 18:12:34 INFO - Return code: 0 18:12:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:34 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 0x1031ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfd0c77430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, '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.VSplhcdHZb/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.lBGSHKbv7s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:34 INFO - 'HOME': '/Users/cltbld', 18:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:34 INFO - 'LOGNAME': 'cltbld', 18:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:34 INFO - 'MOZ_NO_REMOTE': '1', 18:12:34 INFO - 'NO_EM_RESTART': '1', 18:12:34 INFO - 'PAGER': '/bin/cat', 18:12:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:34 INFO - 'PWD': '/builds/slave/test', 18:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:34 INFO - 'SHELL': '/bin/bash', 18:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:12:34 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:34 INFO - 'USER': 'cltbld', 18:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:34 INFO - 'XPC_FLAGS': '0x0', 18:12:34 INFO - 'XPC_SERVICE_NAME': '0', 18:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:12:34 INFO - Cleaning up... 18:12:34 INFO - Return code: 0 18:12:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:34 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 0x1031ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfd0c77430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, '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.VSplhcdHZb/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.lBGSHKbv7s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:34 INFO - 'HOME': '/Users/cltbld', 18:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:34 INFO - 'LOGNAME': 'cltbld', 18:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:34 INFO - 'MOZ_NO_REMOTE': '1', 18:12:34 INFO - 'NO_EM_RESTART': '1', 18:12:34 INFO - 'PAGER': '/bin/cat', 18:12:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:34 INFO - 'PWD': '/builds/slave/test', 18:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:34 INFO - 'SHELL': '/bin/bash', 18:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:12:34 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:34 INFO - 'USER': 'cltbld', 18:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:34 INFO - 'XPC_FLAGS': '0x0', 18:12:34 INFO - 'XPC_SERVICE_NAME': '0', 18:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:35 INFO - Downloading/unpacking psutil>=0.7.1 18:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:40 INFO - Installing collected packages: psutil 18:12:40 INFO - Running setup.py install for psutil 18:12:40 INFO - building 'psutil._psutil_osx' extension 18:12:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:12:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:12:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:12:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:12:41 INFO - building 'psutil._psutil_posix' extension 18:12:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:12:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:12:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:12:41 INFO - ^ 18:12:41 INFO - 1 warning generated. 18:12:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:12:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:41 INFO - Successfully installed psutil 18:12:41 INFO - Cleaning up... 18:12:41 INFO - Return code: 0 18:12:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1031ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfd0c77430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, '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.VSplhcdHZb/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.lBGSHKbv7s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:41 INFO - 'HOME': '/Users/cltbld', 18:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:41 INFO - 'LOGNAME': 'cltbld', 18:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:41 INFO - 'MOZ_NO_REMOTE': '1', 18:12:41 INFO - 'NO_EM_RESTART': '1', 18:12:41 INFO - 'PAGER': '/bin/cat', 18:12:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:41 INFO - 'PWD': '/builds/slave/test', 18:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:41 INFO - 'SHELL': '/bin/bash', 18:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:12:41 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:41 INFO - 'USER': 'cltbld', 18:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:41 INFO - 'XPC_FLAGS': '0x0', 18:12:41 INFO - 'XPC_SERVICE_NAME': '0', 18:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:12:45 INFO - Installing collected packages: mozsystemmonitor 18:12:45 INFO - Running setup.py install for mozsystemmonitor 18:12:45 INFO - Successfully installed mozsystemmonitor 18:12:45 INFO - Cleaning up... 18:12:46 INFO - Return code: 0 18:12:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:46 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 0x1031ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfd0c77430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, '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.VSplhcdHZb/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.lBGSHKbv7s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:46 INFO - 'HOME': '/Users/cltbld', 18:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:46 INFO - 'LOGNAME': 'cltbld', 18:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:46 INFO - 'MOZ_NO_REMOTE': '1', 18:12:46 INFO - 'NO_EM_RESTART': '1', 18:12:46 INFO - 'PAGER': '/bin/cat', 18:12:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:46 INFO - 'PWD': '/builds/slave/test', 18:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:46 INFO - 'SHELL': '/bin/bash', 18:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:12:46 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:46 INFO - 'USER': 'cltbld', 18:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:46 INFO - 'XPC_FLAGS': '0x0', 18:12:46 INFO - 'XPC_SERVICE_NAME': '0', 18:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:46 INFO - Downloading/unpacking blobuploader==1.2.4 18:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:49 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:51 INFO - Downloading docopt-0.6.1.tar.gz 18:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:51 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:51 INFO - Running setup.py install for blobuploader 18:12:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:51 INFO - Running setup.py install for requests 18:12:52 INFO - Running setup.py install for docopt 18:12:52 INFO - Successfully installed blobuploader requests docopt 18:12:52 INFO - Cleaning up... 18:12:52 INFO - Return code: 0 18:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:52 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 0x1031ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfd0c77430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, '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.VSplhcdHZb/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.lBGSHKbv7s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:12:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:52 INFO - 'HOME': '/Users/cltbld', 18:12:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:52 INFO - 'LOGNAME': 'cltbld', 18:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:52 INFO - 'MOZ_NO_REMOTE': '1', 18:12:52 INFO - 'NO_EM_RESTART': '1', 18:12:52 INFO - 'PAGER': '/bin/cat', 18:12:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:52 INFO - 'PWD': '/builds/slave/test', 18:12:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:52 INFO - 'SHELL': '/bin/bash', 18:12:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:12:52 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:12:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:52 INFO - 'USER': 'cltbld', 18:12:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:52 INFO - 'XPC_FLAGS': '0x0', 18:12:52 INFO - 'XPC_SERVICE_NAME': '0', 18:12:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:52 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-lBjiYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:52 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-n3BLgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:52 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-_LeyhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:52 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-zJekMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-QJq35E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-MX7IBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ZBnkmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-QjURBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-UksFJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-hSmVGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-eoZdwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-9hvhsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-iLw8uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:53 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-lpzTpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:54 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-AnpoBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:54 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-0aTxS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:54 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-QatvNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:54 INFO - Running setup.py install for manifestparser 18:12:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:54 INFO - Running setup.py install for mozcrash 18:12:54 INFO - Running setup.py install for mozdebug 18:12:54 INFO - Running setup.py install for mozdevice 18:12:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:54 INFO - Running setup.py install for mozfile 18:12:55 INFO - Running setup.py install for mozhttpd 18:12:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:55 INFO - Running setup.py install for mozinfo 18:12:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:55 INFO - Running setup.py install for mozInstall 18:12:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:55 INFO - Running setup.py install for mozleak 18:12:55 INFO - Running setup.py install for mozlog 18:12:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:55 INFO - Running setup.py install for moznetwork 18:12:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:56 INFO - Running setup.py install for mozprocess 18:12:56 INFO - Running setup.py install for mozprofile 18:12:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:56 INFO - Running setup.py install for mozrunner 18:12:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:56 INFO - Running setup.py install for mozscreenshot 18:12:56 INFO - Running setup.py install for moztest 18:12:56 INFO - Running setup.py install for mozversion 18:12:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:56 INFO - Cleaning up... 18:12:56 INFO - Return code: 0 18:12:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:56 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 0x1031ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfd0c77430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, '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.VSplhcdHZb/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.lBGSHKbv7s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:12:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:56 INFO - 'HOME': '/Users/cltbld', 18:12:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:56 INFO - 'LOGNAME': 'cltbld', 18:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:56 INFO - 'MOZ_NO_REMOTE': '1', 18:12:56 INFO - 'NO_EM_RESTART': '1', 18:12:56 INFO - 'PAGER': '/bin/cat', 18:12:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:56 INFO - 'PWD': '/builds/slave/test', 18:12:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:56 INFO - 'SHELL': '/bin/bash', 18:12:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:12:56 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:12:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:56 INFO - 'USER': 'cltbld', 18:12:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:56 INFO - 'XPC_FLAGS': '0x0', 18:12:56 INFO - 'XPC_SERVICE_NAME': '0', 18:12:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-8eTl0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-8CjhYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-KE1h7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Bzp0BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-P5tKMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-38Mhxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-r53rix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-kCsaGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:58 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-c9z7zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:58 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-JREKbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:58 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-wwCg_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:58 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-eKP0pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:58 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Nve11v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:58 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-VfXx2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:58 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-AKE0pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:58 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-F3IQFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:58 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-QWZHXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:02 INFO - Downloading blessings-1.6.tar.gz 18:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:13:03 INFO - Installing collected packages: blessings 18:13:03 INFO - Running setup.py install for blessings 18:13:03 INFO - Successfully installed blessings 18:13:03 INFO - Cleaning up... 18:13:03 INFO - Return code: 0 18:13:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:13:03 INFO - Reading from file tmpfile_stdout 18:13:03 INFO - Current package versions: 18:13:03 INFO - blessings == 1.6 18:13:03 INFO - blobuploader == 1.2.4 18:13:03 INFO - docopt == 0.6.1 18:13:03 INFO - manifestparser == 1.1 18:13:03 INFO - mozInstall == 1.12 18:13:03 INFO - mozcrash == 0.17 18:13:03 INFO - mozdebug == 0.1 18:13:03 INFO - mozdevice == 0.48 18:13:03 INFO - mozfile == 1.2 18:13:03 INFO - mozhttpd == 0.7 18:13:03 INFO - mozinfo == 0.9 18:13:03 INFO - mozleak == 0.1 18:13:03 INFO - mozlog == 3.1 18:13:03 INFO - moznetwork == 0.27 18:13:03 INFO - mozprocess == 0.22 18:13:03 INFO - mozprofile == 0.28 18:13:03 INFO - mozrunner == 6.11 18:13:03 INFO - mozscreenshot == 0.1 18:13:03 INFO - mozsystemmonitor == 0.0 18:13:03 INFO - moztest == 0.7 18:13:03 INFO - mozversion == 1.4 18:13:03 INFO - psutil == 3.1.1 18:13:03 INFO - requests == 1.2.3 18:13:03 INFO - wsgiref == 0.1.2 18:13:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:03 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 0x1031ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfd0c77430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, '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.VSplhcdHZb/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.lBGSHKbv7s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:13:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:13:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:03 INFO - 'HOME': '/Users/cltbld', 18:13:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:03 INFO - 'LOGNAME': 'cltbld', 18:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:03 INFO - 'MOZ_NO_REMOTE': '1', 18:13:03 INFO - 'NO_EM_RESTART': '1', 18:13:03 INFO - 'PAGER': '/bin/cat', 18:13:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:03 INFO - 'PWD': '/builds/slave/test', 18:13:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:03 INFO - 'SHELL': '/bin/bash', 18:13:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:13:03 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:13:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:03 INFO - 'USER': 'cltbld', 18:13:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:03 INFO - 'XPC_FLAGS': '0x0', 18:13:03 INFO - 'XPC_SERVICE_NAME': '0', 18:13:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:13:03 INFO - Cleaning up... 18:13:03 INFO - Return code: 0 18:13:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:03 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 0x1031ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfd0c77430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, '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.VSplhcdHZb/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.lBGSHKbv7s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:13:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:13:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:03 INFO - 'HOME': '/Users/cltbld', 18:13:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:03 INFO - 'LOGNAME': 'cltbld', 18:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:03 INFO - 'MOZ_NO_REMOTE': '1', 18:13:03 INFO - 'NO_EM_RESTART': '1', 18:13:03 INFO - 'PAGER': '/bin/cat', 18:13:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:03 INFO - 'PWD': '/builds/slave/test', 18:13:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:03 INFO - 'SHELL': '/bin/bash', 18:13:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:13:03 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:13:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:03 INFO - 'USER': 'cltbld', 18:13:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:03 INFO - 'XPC_FLAGS': '0x0', 18:13:03 INFO - 'XPC_SERVICE_NAME': '0', 18:13:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:04 INFO - Downloading/unpacking jsonschema 18:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:13:09 INFO - Downloading/unpacking functools32 (from jsonschema) 18:13: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 18:13: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 18:13: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 18:13: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 18:13: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 18:13: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 18:13:09 INFO - Downloading functools32-3.2.3-2.tar.gz 18:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:13:10 INFO - warning: no files found matching '*.txt' 18:13:10 INFO - no previously-included directories found matching 'build' 18:13:10 INFO - no previously-included directories found matching 'dist' 18:13:10 INFO - no previously-included directories found matching '.git*' 18:13:10 INFO - Installing collected packages: jsonschema, functools32 18:13:10 INFO - Running setup.py install for functools32 18:13:10 INFO - warning: no files found matching '*.txt' 18:13:10 INFO - no previously-included directories found matching 'build' 18:13:10 INFO - no previously-included directories found matching 'dist' 18:13:10 INFO - no previously-included directories found matching '.git*' 18:13:10 INFO - Successfully installed jsonschema functools32 18:13:10 INFO - Cleaning up... 18:13:10 INFO - Return code: 0 18:13:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13: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 0x1031ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfd0c77430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, '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.VSplhcdHZb/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.lBGSHKbv7s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:13: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 18:13: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 18:13:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:13:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:10 INFO - 'HOME': '/Users/cltbld', 18:13:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:10 INFO - 'LOGNAME': 'cltbld', 18:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:10 INFO - 'MOZ_NO_REMOTE': '1', 18:13:10 INFO - 'NO_EM_RESTART': '1', 18:13:10 INFO - 'PAGER': '/bin/cat', 18:13:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:10 INFO - 'PWD': '/builds/slave/test', 18:13:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:10 INFO - 'SHELL': '/bin/bash', 18:13:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:13:10 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:13:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:10 INFO - 'USER': 'cltbld', 18:13:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:10 INFO - 'XPC_FLAGS': '0x0', 18:13:10 INFO - 'XPC_SERVICE_NAME': '0', 18:13:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:11 INFO - Downloading/unpacking flake8 18:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:13:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:13: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 18:13: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 18:13: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 18:13: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 18:13: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 18:13: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 18:13:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:13:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:13: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 18:13: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 18:13: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 18:13: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 18:13: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 18:13: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 18:13:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:13: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 18:13: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 18:13: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 18:13: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 18:13: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 18:13: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 18:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:13:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:13:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:13:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:13:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:13:14 INFO - no previously-included directories found matching 'docs/_build' 18:13:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:13:14 INFO - Running setup.py install for pep8 18:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:13:15 INFO - no previously-included directories found matching 'docs/_build' 18:13:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:13:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:13:15 INFO - Cleaning up... 18:13:15 INFO - Return code: 0 18:13:15 INFO - Running post-action listener: _resource_record_post_action 18:13:15 INFO - Running post-action listener: _start_resource_monitoring 18:13:15 INFO - Starting resource monitoring. 18:13:15 INFO - ##### 18:13:15 INFO - ##### Running install step. 18:13:15 INFO - ##### 18:13:15 INFO - Running pre-action listener: _resource_record_pre_action 18:13:15 INFO - Running main action method: install 18:13:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:13:15 INFO - Reading from file tmpfile_stdout 18:13:15 INFO - Detecting whether we're running mozinstall >=1.0... 18:13:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:13:15 INFO - Reading from file tmpfile_stdout 18:13:15 INFO - Output received: 18:13:15 INFO - Usage: mozinstall [options] installer 18:13:15 INFO - Options: 18:13:15 INFO - -h, --help show this help message and exit 18:13:15 INFO - -d DEST, --destination=DEST 18:13:15 INFO - Directory to install application into. [default: 18:13:15 INFO - "/builds/slave/test"] 18:13:15 INFO - --app=APP Application being installed. [default: firefox] 18:13:15 INFO - mkdir: /builds/slave/test/build/application 18:13:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:13:49 INFO - Reading from file tmpfile_stdout 18:13:49 INFO - Output received: 18:13:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:13:49 INFO - Running post-action listener: _resource_record_post_action 18:13:49 INFO - ##### 18:13:49 INFO - ##### Running run-tests step. 18:13:49 INFO - ##### 18:13:49 INFO - Running pre-action listener: _resource_record_pre_action 18:13:49 INFO - Running main action method: run_tests 18:13:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:13:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:13:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:13:49 INFO - 2016-03-23 18:13:49.658 screenresolution[1926:14358] starting screenresolution argv=screenresolution get 18:13:49 INFO - 2016-03-23 18:13:49.661 screenresolution[1926:14358] Display 0: 1600x1200x32@60 18:13:49 INFO - 2016-03-23 18:13:49.667 screenresolution[1927:14360] starting screenresolution argv=screenresolution list 18:13:49 INFO - Available Modes on Display 0 18:13:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:13:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:13:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:13:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:13:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:13:49 INFO - Intel Iris: 18:13:49 INFO - Chipset Model: Intel Iris 18:13:49 INFO - Type: GPU 18:13:49 INFO - Bus: Built-In 18:13:49 INFO - VRAM (Dynamic, Max): 1536 MB 18:13:49 INFO - Vendor: Intel (0x8086) 18:13:49 INFO - Device ID: 0x0a2e 18:13:49 INFO - Revision ID: 0x0009 18:13:49 INFO - Displays: 18:13:49 INFO - Display: 18:13:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:13:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:13:49 INFO - Display Serial Number: 1600x1200 60 18:13:49 INFO - Main Display: Yes 18:13:49 INFO - Mirror: Off 18:13:49 INFO - Online: Yes 18:13:49 INFO - Rotation: Supported 18:13:49 INFO - Return code: 0 18:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:13:49 INFO - Python 2.7.3 18:13:49 INFO - Return code: 0 18:13:49 INFO - grabbing minidump binary from tooltool 18:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13: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 0x10304ce00>, '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 0x102eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103047b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:13: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 18:13: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 18:13:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:13:49 INFO - Return code: 0 18:13:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:13:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:13:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:13:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:13:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:13:51 INFO - Return code: 0 18:13: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/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:13: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/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0172 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:13:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VSplhcdHZb/Render', 18:13:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:51 INFO - 'HOME': '/Users/cltbld', 18:13:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:51 INFO - 'LOGNAME': 'cltbld', 18:13:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:13:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:51 INFO - 'MOZ_NO_REMOTE': '1', 18:13:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:13:51 INFO - 'NO_EM_RESTART': '1', 18:13:51 INFO - 'PAGER': '/bin/cat', 18:13:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:51 INFO - 'PWD': '/builds/slave/test', 18:13:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:13:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:51 INFO - 'SHELL': '/bin/bash', 18:13:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lBGSHKbv7s/Listeners', 18:13:51 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 18:13:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:51 INFO - 'USER': 'cltbld', 18:13:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:51 INFO - 'XPC_FLAGS': '0x0', 18:13:51 INFO - 'XPC_SERVICE_NAME': '0', 18:13:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13: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/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:13:51 INFO - mozversion application_buildid: 20160323145252 18:13:51 INFO - mozversion application_changeset: 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 18:13:51 INFO - mozversion application_display_name: Nightly 18:13:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:13:51 INFO - mozversion application_name: Firefox 18:13:51 INFO - mozversion application_remotingname: firefox 18:13:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:13:51 INFO - mozversion application_vendor: Mozilla 18:13:51 INFO - mozversion application_version: 48.0a1 18:13:51 INFO - mozversion platform_buildid: 20160323145252 18:13:51 INFO - mozversion platform_changeset: 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 18:13:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:13:51 INFO - mozversion platform_version: 48.0a1 18:13:51 INFO - using testdate: 1458782031 18:13:51 INFO - actual date: 1458782031 18:13:51 INFO - starting webserver on 'localhost:50884' 18:13:51 INFO - SUITE-START | Running 2 tests 18:13:51 INFO - TEST-START | dromaeo_css 18:13:51 INFO - operating with platform_type : mac_ 18:13:51 INFO - Initialising browser for dromaeo_css test... 18:13:51 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpngiHz0/profile http://localhost:50884/getInfo.html) 18:13:53 INFO - PROCESS | 1945 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 18:13:54 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 18:13:54 INFO - PROCESS | 1945 | colorDepth:24 18:13:54 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 18:13:54 INFO - PROCESS | 1945 | __metrics 18:13:54 ERROR - PROCESS | 1945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 18:13:55 INFO - TEST-INFO | 1945: exit 0 18:13:55 INFO - Browser initialized. 18:13:55 INFO - Running cycle 1/1 for dromaeo_css test... 18:13:55 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpngiHz0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:14:07 INFO - PROCESS | 1949 | RSS: Main: 258048000 18:14:07 INFO - PROCESS | 1949 | 18:14:56 INFO - PROCESS | 1949 | 1458782096643 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:17:07 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50884/tests/dromaeo/cssquery-ext.html) 18:17:08 INFO - PROCESS | 1949 | RSS: Main: 270135296 18:17:08 INFO - PROCESS | 1949 | 18:20:11 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-ext.html (next: http://localhost:50884/tests/dromaeo/cssquery-jquery.html) 18:20:11 INFO - PROCESS | 1949 | RSS: Main: 283029504 18:20:11 INFO - PROCESS | 1949 | 18:23:13 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50884/tests/dromaeo/cssquery-mootools.html) 18:23:13 INFO - PROCESS | 1949 | RSS: Main: 284266496 18:23:13 INFO - PROCESS | 1949 | 18:26:15 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50884/tests/dromaeo/cssquery-prototype.html) 18:26:16 INFO - PROCESS | 1949 | RSS: Main: 284569600 18:26:16 INFO - PROCESS | 1949 | 18:29:18 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50884/tests/dromaeo/cssquery-yui.html) 18:29:19 INFO - PROCESS | 1949 | RSS: Main: 287408128 18:29:19 INFO - PROCESS | 1949 | 18:32:21 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-yui.html (next: http://localhost:50884/tests/dromaeo/cssquery-dojo.html) 18:32:22 INFO - PROCESS | 1949 | RSS: Main: 290537472 18:32:22 INFO - PROCESS | 1949 | 18:32:22 INFO - PROCESS | 1949 | __start_tp_report 18:32:22 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 18:32:22 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 18:32:22 INFO - PROCESS | 1949 | |i|pagename|runs| 18:32:22 INFO - PROCESS | 1949 | |0;dojo.html;2663.480621278849;2951.4097180563886;3507.754457187997;3540.6990405815504;3571.1607772173534;4182.895427614311;4923.335349727786;5800.622959507635;5832.504237139843;5883.382244864292;5188.325517682705;5822.970885145579;5946.821595352136;5978.432048955342;5979.372165922581;4325.913481730364;5213.713245771481;5302.363716354023;5352.929414117173;5432.592555558329;5396.298481197439;5476;5497.45025497451;5573.164025396182;5595.21666966625;5206.505381988705;5414.620976531644;5466.535344495723;5477.5070243678065;5491.368492623359;5227.320448341691;5266.131088370415;5281.70950597717;5296.814611488579;5301.310829592167;5248.71132087735;5300.443453437372;5317.707526086064;5337.626366154371;5396.757145928443;4939.863831318781;5195.558377537914;5586.162075688639;5718.542516598662;5836.066229403275;6139.815805525796;6168.537359698041;6238;6239.126522286883;6242.157308763304;5690.886182276373;5878.617889837147;6256.99888017915;6258.593191442542;6261.749530018794;5781.075027995543;5878.294604647384;5991.370906054889;6002.189704389895;6011.579189456696;6401.583897046677;6402.295747467775;6415.647139407284;6418.358164183638;6426.839329016719;6212.782552610637;6238.376162383725;6244.968775156186;6252.718627661766;6265.154204182377;6121.331035925228;6193.1329613854095;6241.251049874044;6248.343923888017;6309.432151106423;6105.732692890381;6127.769884593388;6222.719977601018;6242.843928901813;6254.937450625435;6190.350013248634;6200.193974783339;6212.316645169028;6237.500999919996;6242.28213755424;4882.121218180761;4968.552830245295;5017.523335283142;5043.218301163325;5065.240213967861;4459.1973444779605;4461.910761784746;4473.865784026484;4491.146682130385;4517.728936263835;5931.822045338647;6034.7284372202475;6043.909341359883;6044.697765111727;6057.091436284504;6146.279041868284;6203.131561581382;6208.844778880564;6262.968685156637;6285.057241413733;5886.970565147232;6005.489533389624;6040.637561746309;6055;6060.909086363708;5391.81128660495;5452.672839629635;5488.4237155098135;5504.559635229172;5504.834854954358;6432.581882177644;6486.837829054217;6546.18172728409;6553.574017688835;6566;6248.718807653576;6266.498680105672;6272.027835685476;6281.560290779602;6306.810795676137;5332.600054995968;6322.936770632235;6518.152640156749;6524.4780417565535;6572.474202063919;6144.801763656044;6187.752489900534;6218.160548325918;6235.3452887446165;6280.717367718372;6188;6243.969744992026;6275.995840665471;6309.968450157719;6384.07430922523;5068.265101560327;5588.133839254922;5741.8564535886935;6041.184440100706;6169.383061693974;6122.173506576733;6123.9232566596775;6171.9691401542705;6206.503479721521;6230.470410015199;5253.23828044939;6083.148359229623;6091.406070418474;6147.44672979434;6159;6095.847603809941;6121.6054024712375;6156.569040167145;6165.260168779775;6217.844553886189;6124.326324104434;6136.079588061826;6170.598911070766;6171.290301615192;6175.073738939195 18:32:22 INFO - PROCESS | 1949 | |1;ext.html;503.79241145219794;561.9887602247952;605.8307466589486;631.8294060603637;649.7758273395679;33824.66175338246;37351.69269075583;39182.608173918255;39232.21535569287;39271;40824.79587602065;41339.966500837494;41639.58360416395;41670.791646041725;41690;8200.794980125485;8392.790180245482;9388.014258502844;9501.42991420517;9548.04519548043;9398.248140148771;9424.05759424059;9518.762030949247;9558.996305387938;9569.330146889686;9447.960724320319;9510.09654082861;9516.619335226582;9571.42571445712;9634.181094606933;9517.333786634937;9582.137607615348;9585.664501742474;9606.327557070972;9609.615615375376;9412.435253884789;9485.525723713787;9567;9592.280578956606;9593;31308.843455782575;31821.52267715986;38362.42456363157;38378;38533.807330963165;2553.476537309847;3113.7353324967403;3137.6548579656446;3256.951145732816;3392.9660703393142;22446;27045.864770676217;27362.315942101606;27626.723732762617;28102.297442563897;2661.441097369555;2690.744379283965;2708.404151086758;2737.096758069852;2781.3741908070724;378025;378690;380545;381501;382056;44496;51169.34657543142;61163.08255376173;61546.69226653838;61582.69208653928;44192.67421977346;44246.55753442489;44448.77775611101;44461.77769111134;44718.77640611776;15328.616784580252;15410.152441615819;15416.383344666312;15687.607809804846;15691.764623530657;12580.4338804754;12619.305938173306;12651.177673451197;12668.36658167088;12706.36468176606;14410;14466.85533144676;14553.85446145525;14768.483103091556;14880.553583392515;6348.936510634927;6461.353864613501;6475.417212450902;6518.1200537927725;6552.443042341359;939.9530023498797;964.363520076746;1002.9699109026741;1010.3528754662831;1072.3458690198972;29259;29838;30462.695373045986;31201.907933222683;31276.53085203724;1011.4993078426079;1061.5488417422564;1081.9949281487711;1086.2342048855537;1174.4773575758704;13698.38357273925;14245.92877035629;14393.856061439461;14636.975411721078;14720.631984200481;618113;622697;626052;631332;631977;57011.71494142503;57393.71303143458;57927.13109303364;57996.4200357991;58034.83930321455;1286.6718986658343;1432.555907668626;1458.3874772595536;1483.1546018769197;1487.5537338798533;23800;28806.567901481074;29189.41621167607;29280.82876684909;29523.55714664325;49533.752331238116;49810.50189498204;50155.74922125366;50320;50451.7296721641;389613;462569;463189;464459;464540;31730.682693173698;32787.18032049218;37838.62161378351;44355.55644443514;45369.77315113403;45087.54912450965;45562.544374557154;46974.53025469701;47559.28661070156;47811.5218847821;35860;35954.64045359513;36069.819650901576;36395.45406818953;36804.447933280484;35061.29877402489;35148.47277290792;35632;35724.46413303751;35955.82022089873;32666;34241.65758342385;35725;37863.62136378601;38288.23423531569;26972.190834275003;28441.715582844736;31487.527687084254;31951.201219968756;32749.181270468427;20159.39521814348;21108.050137743532;22694.75178865178;24306.149284774947;24994.625080623442 18:32:22 INFO - PROCESS | 1949 | |2;jquery.html;348.684440581274;348.7462572053467;358.9551306086739;361.8064335580464;374.40843467321633;18268.543286417847;19631;21501.784982150173;21513.46216344592;21605.891970540124;20679.793202067976;20988.790112098875;21097.47256318589;21218.939053047365;21235.893820530877;5835;6062.757489700407;6066.302375226861;6079.209702738638;6084.209052823149;4389.209942210401;5906.084556893667;6541.345865413445;6568.80293591193;6587.308332625077;6391.744330226786;6417;6487.61074335539;6496.54524183305;6525.771597994048;6232.563720539564;6401.551891367606;6445.613263204199;6454.515911306671;6489.221293444793;5520.503154716095;5531.363893152299;5541;5617.859553511154;5624.887502249932;12858.164219325714;13430.664233394145;25065.874670626712;25796.484070318675;25862.74137258622;1962.2445358537066;2076.179908935977;2145.0990583954776;2197.516546359798;2523.2178024812365;9429.90570094304;9826.459544725038;13623;13862.93068534661;14432.855671443362;1682.562533741224;1716.5536960390264;1726.7841519810024;1757.578181236507;1801.5316017835326;91623;97339.51330243374;98277.50861245791;98734;99812;11160.995510404102;11396.803335649638;11502;11505.367204803817;11511.769764604662;13555.322233888266;13708.24604646734;13826.930865345608;13854.86145138556;13893.4442622296;7020.297970203041;8484.19400156984;8493.745187644381;8725.389222754473;8760.167784060504;6535.444487218545;8743.431676940978;8908.376413651113;8931.910680893237;9042.502662353634;4437.955620443819;4522.977385113053;4549.044700612908;4553;4566.589006989387;1921.2603147788202;1927.4025052233853;1937.1766999025358;1937.728717979484;1965.6167047425615;867.5792240763225;925.9259259259243;992.1120597065586;995.9103680668775;1078.1751959750798;17316.653666926843;18931.62136757257;20947.63840350403;21506.46233844135;22097.005634746474;811.3752410643772;966.994325901055;984.2716389871587;1012.9442880641489;1066.2323127348297;10971.890281097247;11292.830607540893;11297.265677731086;11377.975982161644;11426.714332141762;583612;584264;615496.9225153845;623744;623759;113219;115972.42013789876;117084;117966;124249;1014.9441780702132;1080.8811030786608;1085.4355735017746;1089.6948854320804;1098.566066403782;18275.08624568793;18498.630027399646;18576.81423185751;18631.72052419242;18816.341428049953;46870.35953741603;47940.520594793605;48107;49458.25812612742;49748.50251497584;67050.66474667596;69726.65136674487;69759.65120174366;70037.64981175265;70183.59632807417;7681.078270607562;7866.095399028956;7899.881501777363;8021.879671804811;8033.3171680405485;9003.234725048444;10927.726806829893;11529.769404612029;12234.816477752664;12468.563600273947;10729.034386905216;10916.672499825017;10920.617778377718;10958.452077396258;10960.342379456939;9215.44707317563;9492.671026056496;10022.098011179029;10036.397816131055;10141.340812847142;10974.615888443866;11092.722681933015;11093.667189984313;11330.98021178098;11525.423728813694;7861.938638283758;7920.722774702857;8011.157433790145;8050.436469447082;8100.189981002089;8712.738617841474;10615.363078215332;10963.506642201279;11001.449927503752;11154 18:32:22 INFO - PROCESS | 1949 | |3;mootools.html;1589.6820635872825;1620.829812869649;1929.5754933914534;2014.9798502014976;2041.2345370486069;7939.92060079399;8687.218150366474;8706.434081784679;8867.157620026102;8909.732708018753;8707.172818582241;8718.86921696175;8726.301895848334;8822.647094116228;8825.735227943156;2476.2199907029317;2486.2292689266296;2497.8126640502037;2506.0477018732854;2512.4975004998983;2434.6469761884514;2451.3626457121186;2465.4822487277693;2503.3616427810884;2509.6988361396657;2476.8513889166707;2483.416397146669;2489.0914816092177;2489.3154382544853;2489.4025433895827;2437.2688193541867;2454.5581795276844;2494.2641920633455;2511.9748802512013;2516.263777993179;2454.3250606083293;2454.864982425966;2481.5409149307434;2509.6862892138483;2514.7108082570558;8831.77920551985;8843.380963332505;8917.242034427081;8918.063603321623;8926.285897128215;4247.8088486018205;5146.176611742141;5181.637285390024;5230.666180124044;5257.263983042339;3514.841832117561;3587.1032241939515;3611.7652352596997;3633.5821380541047;3653.561572611277;884.4295429448034;974.541965276319;1065.8081545321838;1078.3907092492716;1078.735709751116;11558.959693627614;11647.30116193031;11697.473613687405;11780.764384712258;11876.584319548861;4823.831165909176;4904.386951631046;4954.157793175169;4967.428745694291;4969.950300497021;7659.885101723478;10061.949690251502;10070.59717611302;10080.848787268196;10151.898481015243;5346.973265133727;5392.946070539323;5424.864378390493;5489;5502.477264659851;4392.297232442794;4534.841280555231;4896.167651499253;4993.7503124843615;4998.050370429607;3312.801231926092;3598.4242521196484;3853.61463853618;3996.300647386696;4074.124063326399;1337.0640551613715;1344.9731005379838;1350.824392828926;1353.3503918119359;1377.5798381493742;1043.389617074005;1060.1677683018793;1060.8726952765562;1336.0447280194708;1377.4490203918513;7950.6422211000645;8173;8180.445715314071;8187.5087494750505;8202.38482113844;508.9312942752681;512.387696702437;514.3801718928682;517.4515014085082;529.1454301303444;6217.720202590895;6255.74977000924;6361.173047503888;6369.426751592379;6371.139896113966;9526.095020972996;10649.89350106489;10678.73303167427;10689.251752377259;10801;9008.549572521479;10611.787764244671;10656.467176641137;10663.200259980533;10689.786204276026;8055.718049868226;8196.385271104691;8251.33989280844;8289.336853051742;8330.375221858385;7955.721549745731;7991.84016319682;8021.63902624395;8052;8120.675172993014;9022.278217742434;9438.38650487716;9446.574904129193;9449.763755905882;9495.572699228413;9403.670871519464;9470.763230919281;9611.663591774255;9733.610655573697;9924;6843.623600702009;7299.8540029200185;7504.962475187589;7583.810404739705;7632.084149902047;6915.550489218386;8081.636326365446;8179.959100204461;8210;8289.295409890226;7145.249748776304;7280.817979550554;7291.744788932362;7422;7485.850282994418;7180.712771489082;7238.963805180941;7264.34620884123;7284.67218975158;7287.744928927462;6457.515686323451;7627.771166865003;7736.110347310131;7846.136924938138;7864;6998.055262539696;7025.824354391181;7070.010198572307;7079.256678048937;7092.113485814273;7167.820804479929;7211.3870321023305;7216.7834964951135;7237.638118093969;7251.274872512707 18:32:22 INFO - PROCESS | 1949 | |4;prototype.html;326.15851104151284;327.95900512435946;332.1762030165192;336.789506558401;338.53282470191135;6873.965630171849;6921.238663746984;6924.376806087451;6967.233604303529;7010.298970102987;6841.657917104138;6842.931570684292;6850;6850.280720524348;6893.241743408221;4826.276058591222;4896.583790377805;5035.748212589374;5043.36957880265;5098.847034588959;5030.270610761438;5033.4329491959;5057.064443078024;5070.442251352367;5077;4382.408374869399;4974.552290293873;4978.153713868651;5015.899682006358;5029.748512574375;4051.4327994080854;5039.596832253411;5047.0915235257635;5055.266986286968;5064.316317297173;4300.397944287803;4306.504751953534;4308.009157893702;4319.935200971988;4325.134973005412;5586.742982828871;6312.179416675849;6580.80257592273;6624.27133015368;6662.400383965418;5816.563757718146;5839.299284085894;5843.590948633598;5895.498882594985;5898.351181370046;7311.926880731231;7313.195548489662;7319.451041171933;7339.6330183491145;7340.26597340267;4668.043051174535;4674.018456124218;4674.462436819741;4682.836100736492;4689.2966055091665;7388.519746216479;7710.113336966265;7735.419843511759;7767.417443691746;7782.533048017137;4545.113702827917;4600.217962946307;4682.180618391768;4706.741129237925;4715.434147902273;4781.258904869751;4789.425268967746;4791.281307803857;4792.448868380181;4813.446453657874;5654.6889921054735;5723.6851973141875;5745.569082318842;5753.280839895013;5758.798442054592;7202.063731714844;7276.199618042011;7309.195988441267;7313.232110628307;7328.267173282736;1523.405871710034;1552.8912976091792;1654.96690066198;1678.3789997700685;1682.1084825042747;886.7295474880094;1033.3696445168441;1073.1522097542854;1082.9133669306436;1084.322298563398;5548.973439913629;6439.259485159173;6650.20197576294;6800.727970881208;6821.965890170517;5349.251104845324;6174.9691251544355;7106.649736550039;7279.745208917662;7528.811779705442;6725.630090345078;6740;6758.357955994173;6761.391474767294;6805.502789386327;3960.920781584352;3990.2817492851564;4004.939925901114;4007.4189242559664;4017.372963949605;6442.645654488954;7630.198829122862;7747.147813740484;7910.644021019068;8076.3942704297415;6362.745490180433;7437.6530561247655;7923.207679232146;7980.840383192303;7997.240262175084;5695.914561281584;7013.859722805515;8067;8073.838523229385;8102.270795628304;7397.757272150942;7564;7608.809779755329;7646.923530764621;7673.424493162924;7485;7492.40060795146;7496.850062998818;7508.136564295176;7538.396928245617;7112.679929403086;7445.2182520836695;7985.2014798519685;7993.400494962785;8041.758747237593;4754.381930349033;4765.380500534909;4773.546513081252;4777.522247775195;4780.282957556395;6503.284638689645;7576.204498527575;7584.886226706714;7609.162992070978;7628.847423051397;7310.634468276671;7380.114386273467;7389.445791565761;7394.371478424394;7427.368673662799;7290.671919763729;7293;7300.306470885257;7316.122065352191;7365.085077879897;7064.611446370499;7107.644617768988;7122.216556178712;7164.176119746087;7166.211716711262;7063.187733410518;7322.340989310987;7323.8535229296185;7325.267473252845;7373.520721153108;5118.71847048401;7105.04081948951;7149.14210294768;7149.82125446868;7149.928500715135 18:32:22 INFO - PROCESS | 1949 | |5;yui.html;675.344915432031;692.9376356127948;703.061413013627;715.3740477082553;726.93457588817;14327.785083223747;14500.854991450109;14541.491047813328;14544.127352358866;14567.417303307868;11893.643190704293;13235.933820330885;13512.797308040388;13574.185548867075;13576.93211533941;757.4962649837851;921.0513171433435;930.762655522844;932.2169377722712;936.5176933879058;530.8115618955273;739.8779201431757;918.9724308270762;921.1755478846428;927.8747369105151;941.7127776028309;976.345848281653;978.2125389061803;980.5342462330372;982.135720565901;936.3585943628636;960.6541645007792;978.6819283732815;979.045430705064;983.6016413352532;663.9178139632417;696.2828286864537;723.522475166393;726.4224941171728;734.7061175529777;12272.386380681019;12735.617931461979;14004.859951400458;14233.430662773477;14426;12571.93714031424;12664.176828506117;12781.936090319581;12803;12981.41583628739;9829.754256143582;9886.505674716236;9903.05920937517;9906.257030722652;9935.602575896955;3537.0626783902285;3574.8927532174075;3603.261331427051;3614.6927511161584;3632.3280193164087;72962.54074918525;74678.62660686662;74861.50276994484;80981.78527322094;81191.18808811896;9370.437773733598;9375.953120234355;9562.904370956341;9585.329026968186;9647.035296470296;19826.50433739139;19858.1063852127;19866.70199947002;19874.70187947182;19881.502962426053;7337.41300695943;7412.332890039815;7552.584607846511;7575.356094732009;7577.696892124363;3961.1483531040963;3997.0806714455257;4141.254574176617;4142.813573389205;4146;3490.47642853574;3493.3886569850174;3553.893383198508;3602.7297952653657;3612.710983121344;648.1476857931805;656.2584279763931;662.8044726805604;663.8937769956784;671.9092922455503;511.9308893299431;530.8778980834429;557.4871118570925;560.7756897241054;575.1947273816606;7768.844623107506;8016.599170041474;8035.437519373588;8056.8388632227025;8121.634526446206;501.57366238697546;545.4000599340693;545.6862304175115;557.4425574425575;561.3684604819578;3677.6506231907924;3683.4474828775897;3721.8511259549855;3741.644543768338;3916.2559113768293;64078;84082.15917840866;85153;85192;88480.5575972116;77051.2294877044;77489.2251077482;77542;78108.60945695349;79138.20861791424;67591;67892.660536697;68037.65981170161;68305.97541036889;69036.6548167266;7156;7508.399328053852;7533.886991695239;7601.961990190235;7755.2244775521995;48705.75647121741;49261;49672.25491617701;49791.75104124456;49918.500814991385;64673;65624.34375656182;65821;66652.3336916581;66733.33266667271;7853.568053757098;9529.665846781594;9576.377535460173;9577.090176433228;9666.275029372684;10488.28738146612;10502.842457362993;10661.253712240068;10993.670189894316;11501.712457188638;9875.604975801174;9929.156021737945;9948.651797187063;10179.134773544332;10262.692119236435;9868.457234852152;10029.398236105857;10083.24375671813;10126;10145;9723.173530250007;9963.352382095141;9981.700548983543;9987.60049598008;9992.450415227233;7492.138404083382;7886.763397098096;8284.50292982423;8323.916760832315;8549.87175192385;8134.511929284262;8230.711925082593;8393.538355390512;8394.11861754507;8464.915350846413 18:32:22 INFO - PROCESS | 1949 | __end_tp_report 18:32:22 INFO - PROCESS | 1949 | __start_cc_report 18:32:22 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,369 18:32:22 INFO - PROCESS | 1949 | __end_cc_report 18:32:22 INFO - PROCESS | 1949 | __startTimestamp1458783142229__endTimestamp 18:32:22 INFO - PROCESS | 1949 | 18:32:22 INFO - PROCESS | 1949 | ------- Summary: start ------- 18:32:22 INFO - PROCESS | 1949 | Number of tests: 6 18:32:22 INFO - PROCESS | 1949 | 18:32:22 INFO - PROCESS | 1949 | [#0] dojo.html Cycles:165 Average:5782.65 Median:6060.91 stddev:687.16 (11.3%) stddev-sans-first:644.23 18:32:22 INFO - PROCESS | 1949 | Values: 2663.5 2951.4 3507.8 3540.7 3571.2 4182.9 4923.3 5800.6 5832.5 5883.4 5188.3 5823.0 5946.8 5978.4 5979.4 4325.9 5213.7 5302.4 5352.9 5432.6 5396.3 5476.0 5497.5 5573.2 5595.2 5206.5 5414.6 5466.5 5477.5 5491.4 5227.3 5266.1 5281.7 5296.8 5301.3 5248.7 5300.4 5317.7 5337.6 5396.8 4939.9 5195.6 5586.2 5718.5 5836.1 6139.8 6168.5 6238.0 6239.1 6242.2 5690.9 5878.6 6257.0 6258.6 6261.7 5781.1 5878.3 5991.4 6002.2 6011.6 6401.6 6402.3 6415.6 6418.4 6426.8 6212.8 6238.4 6245.0 6252.7 6265.2 6121.3 6193.1 6241.3 6248.3 6309.4 6105.7 6127.8 6222.7 6242.8 6254.9 6190.4 6200.2 6212.3 6237.5 6242.3 4882.1 4968.6 5017.5 5043.2 5065.2 4459.2 4461.9 4473.9 4491.1 4517.7 5931.8 6034.7 6043.9 6044.7 6057.1 6146.3 6203.1 6208.8 6263.0 6285.1 5887.0 6005.5 6040.6 6055.0 6060.9 5391.8 5452.7 5488.4 5504.6 5504.8 6432.6 6486.8 6546.2 6553.6 6566.0 6248.7 6266.5 6272.0 6281.6 6306.8 5332.6 6322.9 6518.2 6524.5 6572.5 6144.8 6187.8 6218.2 6235.3 6280.7 6188.0 6244.0 6276.0 6310.0 6384.1 5068.3 5588.1 5741.9 6041.2 6169.4 6122.2 6123.9 6172.0 6206.5 6230.5 5253.2 6083.1 6091.4 6147.4 6159.0 6095.8 6121.6 6156.6 6165.3 6217.8 6124.3 6136.1 6170.6 6171.3 6175.1 18:32:22 INFO - PROCESS | 1949 | 18:32:22 INFO - PROCESS | 1949 | [#1] ext.html Cycles:180 Average:61923.18 Median:379617.50 stddev:132546.21 (34.9%) stddev-sans-first:132837.82 18:32:22 INFO - PROCESS | 1949 | Values: 503.8 562.0 605.8 631.8 649.8 33824.7 37351.7 39182.6 39232.2 39271.0 40824.8 41340.0 41639.6 41670.8 41690.0 8200.8 8392.8 9388.0 9501.4 9548.0 9398.2 9424.1 9518.8 9559.0 9569.3 9448.0 9510.1 9516.6 9571.4 9634.2 9517.3 9582.1 9585.7 9606.3 9609.6 9412.4 9485.5 9567.0 9592.3 9593.0 31308.8 31821.5 38362.4 38378.0 38533.8 2553.5 3113.7 3137.7 3257.0 3393.0 22446.0 27045.9 27362.3 27626.7 28102.3 2661.4 2690.7 2708.4 2737.1 2781.4 378025.0 378690.0 380545.0 381501.0 382056.0 44496.0 51169.3 61163.1 61546.7 61582.7 44192.7 44246.6 44448.8 44461.8 44718.8 15328.6 15410.2 15416.4 15687.6 15691.8 12580.4 12619.3 12651.2 12668.4 12706.4 14410.0 14466.9 14553.9 14768.5 14880.6 6348.9 6461.4 6475.4 6518.1 6552.4 940.0 964.4 1003.0 1010.4 1072.3 29259.0 29838.0 30462.7 31201.9 31276.5 1011.5 1061.5 1082.0 1086.2 1174.5 13698.4 14245.9 14393.9 14637.0 14720.6 618113.0 622697.0 626052.0 631332.0 631977.0 57011.7 57393.7 57927.1 57996.4 58034.8 1286.7 1432.6 1458.4 1483.2 1487.6 23800.0 28806.6 29189.4 29280.8 29523.6 49533.8 49810.5 50155.7 50320.0 50451.7 389613.0 462569.0 463189.0 464459.0 464540.0 31730.7 32787.2 37838.6 44355.6 45369.8 45087.5 45562.5 46974.5 47559.3 47811.5 35860.0 35954.6 36069.8 36395.5 36804.4 35061.3 35148.5 35632.0 35724.5 35955.8 32666.0 34241.7 35725.0 37863.6 38288.2 26972.2 28441.7 31487.5 31951.2 32749.2 20159.4 21108.1 22694.8 24306.1 24994.6 18:32:22 INFO - PROCESS | 1949 | 18:32:22 INFO - PROCESS | 1949 | [#2] jquery.html Cycles:180 Average:33855.72 Median:25829.61 stddev:100382.65 (388.6%) stddev-sans-first:100632.72 18:32:22 INFO - PROCESS | 1949 | Values: 348.7 348.7 359.0 361.8 374.4 18268.5 19631.0 21501.8 21513.5 21605.9 20679.8 20988.8 21097.5 21218.9 21235.9 5835.0 6062.8 6066.3 6079.2 6084.2 4389.2 5906.1 6541.3 6568.8 6587.3 6391.7 6417.0 6487.6 6496.5 6525.8 6232.6 6401.6 6445.6 6454.5 6489.2 5520.5 5531.4 5541.0 5617.9 5624.9 12858.2 13430.7 25065.9 25796.5 25862.7 1962.2 2076.2 2145.1 2197.5 2523.2 9429.9 9826.5 13623.0 13862.9 14432.9 1682.6 1716.6 1726.8 1757.6 1801.5 91623.0 97339.5 98277.5 98734.0 99812.0 11161.0 11396.8 11502.0 11505.4 11511.8 13555.3 13708.2 13826.9 13854.9 13893.4 7020.3 8484.2 8493.7 8725.4 8760.2 6535.4 8743.4 8908.4 8931.9 9042.5 4438.0 4523.0 4549.0 4553.0 4566.6 1921.3 1927.4 1937.2 1937.7 1965.6 867.6 925.9 992.1 995.9 1078.2 17316.7 18931.6 20947.6 21506.5 22097.0 811.4 967.0 984.3 1012.9 1066.2 10971.9 11292.8 11297.3 11378.0 11426.7 583612.0 584264.0 615496.9 623744.0 623759.0 113219.0 115972.4 117084.0 117966.0 124249.0 1014.9 1080.9 1085.4 1089.7 1098.6 18275.1 18498.6 18576.8 18631.7 18816.3 46870.4 47940.5 48107.0 49458.3 49748.5 67050.7 69726.7 69759.7 70037.6 70183.6 7681.1 7866.1 7899.9 8021.9 8033.3 9003.2 10927.7 11529.8 12234.8 12468.6 10729.0 10916.7 10920.6 10958.5 10960.3 9215.4 9492.7 10022.1 10036.4 10141.3 10974.6 11092.7 11093.7 11331.0 11525.4 7861.9 7920.7 8011.2 8050.4 8100.2 8712.7 10615.4 10963.5 11001.4 11154.0 18:32:22 INFO - PROCESS | 1949 | 18:32:22 INFO - PROCESS | 1949 | [#3] mootools.html Cycles:180 Average:5987.99 Median:5369.96 stddev:3152.08 (58.7%) stddev-sans-first:3143.59 18:32:22 INFO - PROCESS | 1949 | Values: 1589.7 1620.8 1929.6 2015.0 2041.2 7939.9 8687.2 8706.4 8867.2 8909.7 8707.2 8718.9 8726.3 8822.6 8825.7 2476.2 2486.2 2497.8 2506.0 2512.5 2434.6 2451.4 2465.5 2503.4 2509.7 2476.9 2483.4 2489.1 2489.3 2489.4 2437.3 2454.6 2494.3 2512.0 2516.3 2454.3 2454.9 2481.5 2509.7 2514.7 8831.8 8843.4 8917.2 8918.1 8926.3 4247.8 5146.2 5181.6 5230.7 5257.3 3514.8 3587.1 3611.8 3633.6 3653.6 884.4 974.5 1065.8 1078.4 1078.7 11559.0 11647.3 11697.5 11780.8 11876.6 4823.8 4904.4 4954.2 4967.4 4970.0 7659.9 10061.9 10070.6 10080.8 10151.9 5347.0 5392.9 5424.9 5489.0 5502.5 4392.3 4534.8 4896.2 4993.8 4998.1 3312.8 3598.4 3853.6 3996.3 4074.1 1337.1 1345.0 1350.8 1353.4 1377.6 1043.4 1060.2 1060.9 1336.0 1377.4 7950.6 8173.0 8180.4 8187.5 8202.4 508.9 512.4 514.4 517.5 529.1 6217.7 6255.7 6361.2 6369.4 6371.1 9526.1 10649.9 10678.7 10689.3 10801.0 9008.5 10611.8 10656.5 10663.2 10689.8 8055.7 8196.4 8251.3 8289.3 8330.4 7955.7 7991.8 8021.6 8052.0 8120.7 9022.3 9438.4 9446.6 9449.8 9495.6 9403.7 9470.8 9611.7 9733.6 9924.0 6843.6 7299.9 7505.0 7583.8 7632.1 6915.6 8081.6 8180.0 8210.0 8289.3 7145.2 7280.8 7291.7 7422.0 7485.9 7180.7 7239.0 7264.3 7284.7 7287.7 6457.5 7627.8 7736.1 7846.1 7864.0 6998.1 7025.8 7070.0 7079.3 7092.1 7167.8 7211.4 7216.8 7237.6 7251.3 18:32:22 INFO - PROCESS | 1949 | 18:32:22 INFO - PROCESS | 1949 | [#4] prototype.html Cycles:180 Average:5899.15 Median:6749.18 stddev:1907.28 (28.3%) stddev-sans-first:1866.20 18:32:22 INFO - PROCESS | 1949 | Values: 326.2 328.0 332.2 336.8 338.5 6874.0 6921.2 6924.4 6967.2 7010.3 6841.7 6842.9 6850.0 6850.3 6893.2 4826.3 4896.6 5035.7 5043.4 5098.8 5030.3 5033.4 5057.1 5070.4 5077.0 4382.4 4974.6 4978.2 5015.9 5029.7 4051.4 5039.6 5047.1 5055.3 5064.3 4300.4 4306.5 4308.0 4319.9 4325.1 5586.7 6312.2 6580.8 6624.3 6662.4 5816.6 5839.3 5843.6 5895.5 5898.4 7311.9 7313.2 7319.5 7339.6 7340.3 4668.0 4674.0 4674.5 4682.8 4689.3 7388.5 7710.1 7735.4 7767.4 7782.5 4545.1 4600.2 4682.2 4706.7 4715.4 4781.3 4789.4 4791.3 4792.4 4813.4 5654.7 5723.7 5745.6 5753.3 5758.8 7202.1 7276.2 7309.2 7313.2 7328.3 1523.4 1552.9 1655.0 1678.4 1682.1 886.7 1033.4 1073.2 1082.9 1084.3 5549.0 6439.3 6650.2 6800.7 6822.0 5349.3 6175.0 7106.6 7279.7 7528.8 6725.6 6740.0 6758.4 6761.4 6805.5 3960.9 3990.3 4004.9 4007.4 4017.4 6442.6 7630.2 7747.1 7910.6 8076.4 6362.7 7437.7 7923.2 7980.8 7997.2 5695.9 7013.9 8067.0 8073.8 8102.3 7397.8 7564.0 7608.8 7646.9 7673.4 7485.0 7492.4 7496.9 7508.1 7538.4 7112.7 7445.2 7985.2 7993.4 8041.8 4754.4 4765.4 4773.5 4777.5 4780.3 6503.3 7576.2 7584.9 7609.2 7628.8 7310.6 7380.1 7389.4 7394.4 7427.4 7290.7 7293.0 7300.3 7316.1 7365.1 7064.6 7107.6 7122.2 7164.2 7166.2 7063.2 7322.3 7323.9 7325.3 7373.5 5118.7 7105.0 7149.1 7149.8 7149.9 18:32:22 INFO - PROCESS | 1949 | 18:32:22 INFO - PROCESS | 1949 | [#5] yui.html Cycles:180 Average:17340.26 Median:694.61 stddev:24507.23 (3528.2%) stddev-sans-first:24544.03 18:32:22 INFO - PROCESS | 1949 | Values: 675.3 692.9 703.1 715.4 726.9 14327.8 14500.9 14541.5 14544.1 14567.4 11893.6 13235.9 13512.8 13574.2 13576.9 757.5 921.1 930.8 932.2 936.5 530.8 739.9 919.0 921.2 927.9 941.7 976.3 978.2 980.5 982.1 936.4 960.7 978.7 979.0 983.6 663.9 696.3 723.5 726.4 734.7 12272.4 12735.6 14004.9 14233.4 14426.0 12571.9 12664.2 12781.9 12803.0 12981.4 9829.8 9886.5 9903.1 9906.3 9935.6 3537.1 3574.9 3603.3 3614.7 3632.3 72962.5 74678.6 74861.5 80981.8 81191.2 9370.4 9376.0 9562.9 9585.3 9647.0 19826.5 19858.1 19866.7 19874.7 19881.5 7337.4 7412.3 7552.6 7575.4 7577.7 3961.1 3997.1 4141.3 4142.8 4146.0 3490.5 3493.4 3553.9 3602.7 3612.7 648.1 656.3 662.8 663.9 671.9 511.9 530.9 557.5 560.8 575.2 7768.8 8016.6 8035.4 8056.8 8121.6 501.6 545.4 545.7 557.4 561.4 3677.7 3683.4 3721.9 3741.6 3916.3 64078.0 84082.2 85153.0 85192.0 88480.6 77051.2 77489.2 77542.0 78108.6 79138.2 67591.0 67892.7 68037.7 68306.0 69036.7 7156.0 7508.4 7533.9 7602.0 7755.2 48705.8 49261.0 49672.3 49791.8 49918.5 64673.0 65624.3 65821.0 66652.3 66733.3 7853.6 9529.7 9576.4 9577.1 9666.3 10488.3 10502.8 10661.3 10993.7 11501.7 9875.6 9929.2 9948.7 10179.1 10262.7 9868.5 10029.4 10083.2 10126.0 10145.0 9723.2 9963.4 9981.7 9987.6 9992.5 7492.1 7886.8 8284.5 8323.9 8549.9 8134.5 8230.7 8393.5 8394.1 8464.9 18:32:22 INFO - PROCESS | 1949 | -------- Summary: end -------- 18:32:22 INFO - PROCESS | 1949 | 18:32:22 INFO - TEST-INFO | 1949: exit 0 18:32:22 INFO - TEST-OK | dromaeo_css | took 1111334ms 18:32:22 INFO - TEST-START | kraken 18:32:22 INFO - operating with platform_type : mac_ 18:32:22 INFO - Initialising browser for kraken test... 18:32:22 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpW4RpgM/profile http://localhost:50884/getInfo.html) 18:32:25 INFO - PROCESS | 1956 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 18:32:25 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 18:32:25 INFO - PROCESS | 1956 | colorDepth:24 18:32:25 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 18:32:25 INFO - PROCESS | 1956 | __metrics 18:32:25 ERROR - PROCESS | 1956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 18:32:26 INFO - TEST-INFO | 1956: exit 0 18:32:26 INFO - Browser initialized. 18:32:26 INFO - Running cycle 1/1 for kraken test... 18:32:26 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpW4RpgM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:38 INFO - PROCESS | 1959 | RSS: Main: 257921024 18:32:38 INFO - PROCESS | 1959 | 18:32:41 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50884/tests/kraken/driver.html?testName=audio-beat-detection) 18:32:41 INFO - PROCESS | 1959 | RSS: Main: 268480512 18:32:41 INFO - PROCESS | 1959 | 18:32:44 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50884/tests/kraken/driver.html?testName=audio-dft) 18:32:45 INFO - PROCESS | 1959 | RSS: Main: 277671936 18:32:45 INFO - PROCESS | 1959 | 18:32:48 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50884/tests/kraken/driver.html?testName=audio-fft) 18:32:48 INFO - PROCESS | 1959 | RSS: Main: 282263552 18:32:48 INFO - PROCESS | 1959 | 18:32:51 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50884/tests/kraken/driver.html?testName=audio-oscillator) 18:32:51 INFO - PROCESS | 1959 | RSS: Main: 284102656 18:32:51 INFO - PROCESS | 1959 | 18:32:53 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:32:54 INFO - PROCESS | 1959 | RSS: Main: 284753920 18:32:54 INFO - PROCESS | 1959 | 18:32:57 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50884/tests/kraken/driver.html?testName=imaging-darkroom) 18:32:57 INFO - PROCESS | 1959 | RSS: Main: 284028928 18:32:57 INFO - PROCESS | 1959 | 18:33:01 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50884/tests/kraken/driver.html?testName=imaging-desaturate) 18:33:01 INFO - PROCESS | 1959 | RSS: Main: 283938816 18:33:01 INFO - PROCESS | 1959 | 18:33:04 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50884/tests/kraken/driver.html?testName=json-parse-financial) 18:33:05 INFO - PROCESS | 1959 | RSS: Main: 284069888 18:33:05 INFO - PROCESS | 1959 | 18:33:06 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:33:07 INFO - PROCESS | 1959 | RSS: Main: 284119040 18:33:07 INFO - PROCESS | 1959 | 18:33:09 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:33:09 INFO - PROCESS | 1959 | RSS: Main: 284274688 18:33:09 INFO - PROCESS | 1959 | 18:33:11 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:33:12 INFO - PROCESS | 1959 | RSS: Main: 284323840 18:33:12 INFO - PROCESS | 1959 | 18:33:15 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:33:15 INFO - PROCESS | 1959 | RSS: Main: 285782016 18:33:15 INFO - PROCESS | 1959 | 18:33:18 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:33:19 INFO - PROCESS | 1959 | RSS: Main: 284917760 18:33:19 INFO - PROCESS | 1959 | 18:33:20 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50884/tests/kraken/driver.html?testName=ai-astar) 18:33:21 INFO - PROCESS | 1959 | RSS: Main: 286904320 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | __start_tp_report 18:33:21 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 18:33:21 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 18:33:21 INFO - PROCESS | 1959 | |i|pagename|runs| 18:33:21 INFO - PROCESS | 1959 | |0;ai-astar;116;119;170;126;118;130;116;116;113;114 18:33:21 INFO - PROCESS | 1959 | |1;audio-beat-detection;164;120;146;157;125;149;172;131;163;119 18:33:21 INFO - PROCESS | 1959 | |2;audio-dft;192;197;218;267;246;202;196;200;199;202 18:33:21 INFO - PROCESS | 1959 | |3;audio-fft;81;84;94;125;81;81;89;87;64;76 18:33:21 INFO - PROCESS | 1959 | |4;audio-oscillator;90;111;163;77;82;79;121;80;83;119 18:33:21 INFO - PROCESS | 1959 | |5;imaging-gaussian-blur;91;88;90;88;91;87;92;100;135;87 18:33:21 INFO - PROCESS | 1959 | |6;imaging-darkroom;119;154;104;112;152;150;97;97;127;96 18:33:21 INFO - PROCESS | 1959 | |7;imaging-desaturate;147;146;96;94;93;90;90;92;100;92 18:33:21 INFO - PROCESS | 1959 | |8;json-parse-financial;78;70;56;55;57;57;55;66;59;57 18:33:21 INFO - PROCESS | 1959 | |9;json-stringify-tinderbox;67;66;67;73;78;71;70;69;66;69 18:33:21 INFO - PROCESS | 1959 | |10;stanford-crypto-aes;88;86;85;83;86;83;86;89;88;87 18:33:21 INFO - PROCESS | 1959 | |11;stanford-crypto-ccm;144;142;127;123;125;137;148;126;124;123 18:33:21 INFO - PROCESS | 1959 | |12;stanford-crypto-pbkdf2;146;147;133;176;183;184;163;156;135;168 18:33:21 INFO - PROCESS | 1959 | |13;stanford-crypto-sha256-iterative;74;94;78;61;99;88;84;60;63;60 18:33:21 INFO - PROCESS | 1959 | __end_tp_report 18:33:21 INFO - PROCESS | 1959 | __start_cc_report 18:33:21 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,945 18:33:21 INFO - PROCESS | 1959 | __end_cc_report 18:33:21 INFO - PROCESS | 1959 | __startTimestamp1458783201237__endTimestamp 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | ------- Summary: start ------- 18:33:21 INFO - PROCESS | 1959 | Number of tests: 14 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#0] ai-astar Cycles:10 Average:123.80 Median:118.50 stddev:17.09 (14.4%) stddev-sans-first:17.90 18:33:21 INFO - PROCESS | 1959 | Values: 116.0 119.0 170.0 126.0 118.0 130.0 116.0 116.0 113.0 114.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:153.00 stddev:19.64 (12.8%) stddev-sans-first:19.53 18:33:21 INFO - PROCESS | 1959 | Values: 164.0 120.0 146.0 157.0 125.0 149.0 172.0 131.0 163.0 119.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#2] audio-dft Cycles:10 Average:211.90 Median:202.00 stddev:24.97 (12.4%) stddev-sans-first:25.42 18:33:21 INFO - PROCESS | 1959 | Values: 192.0 197.0 218.0 267.0 246.0 202.0 196.0 200.0 199.0 202.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#3] audio-fft Cycles:10 Average:86.20 Median:82.50 stddev:15.84 (19.2%) stddev-sans-first:16.69 18:33:21 INFO - PROCESS | 1959 | Values: 81.0 84.0 94.0 125.0 81.0 81.0 89.0 87.0 64.0 76.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:79.50 stddev:27.83 (35.0%) stddev-sans-first:29.26 18:33:21 INFO - PROCESS | 1959 | Values: 90.0 111.0 163.0 77.0 82.0 79.0 121.0 80.0 83.0 119.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:89.00 stddev:14.59 (16.4%) stddev-sans-first:15.41 18:33:21 INFO - PROCESS | 1959 | Values: 91.0 88.0 90.0 88.0 91.0 87.0 92.0 100.0 135.0 87.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#6] imaging-darkroom Cycles:10 Average:120.80 Median:153.00 stddev:23.75 (15.5%) stddev-sans-first:25.18 18:33:21 INFO - PROCESS | 1959 | Values: 119.0 154.0 104.0 112.0 152.0 150.0 97.0 97.0 127.0 96.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#7] imaging-desaturate Cycles:10 Average:104.00 Median:92.00 stddev:22.59 (24.6%) stddev-sans-first:17.82 18:33:21 INFO - PROCESS | 1959 | Values: 147.0 146.0 96.0 94.0 93.0 90.0 90.0 92.0 100.0 92.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:58.00 stddev:7.77 (13.4%) stddev-sans-first:5.28 18:33:21 INFO - PROCESS | 1959 | Values: 78.0 70.0 56.0 55.0 57.0 57.0 55.0 66.0 59.0 57.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:3.72 (5.3%) stddev-sans-first:3.82 18:33:21 INFO - PROCESS | 1959 | Values: 67.0 66.0 67.0 73.0 78.0 71.0 70.0 69.0 66.0 69.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.50 stddev:2.02 (2.3%) stddev-sans-first:2.03 18:33:21 INFO - PROCESS | 1959 | Values: 88.0 86.0 85.0 83.0 86.0 83.0 86.0 89.0 88.0 87.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:132.00 stddev:9.78 (7.4%) stddev-sans-first:9.34 18:33:21 INFO - PROCESS | 1959 | Values: 144.0 142.0 127.0 123.0 125.0 137.0 148.0 126.0 124.0 123.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:165.50 stddev:18.74 (11.3%) stddev-sans-first:19.27 18:33:21 INFO - PROCESS | 1959 | Values: 146.0 147.0 133.0 176.0 183.0 184.0 163.0 156.0 135.0 168.0 18:33:21 INFO - PROCESS | 1959 | 18:33:21 INFO - PROCESS | 1959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:81.00 stddev:14.81 (18.3%) stddev-sans-first:15.69 18:33:21 INFO - PROCESS | 1959 | Values: 74.0 94.0 78.0 61.0 99.0 88.0 84.0 60.0 63.0 60.0 18:33:21 INFO - PROCESS | 1959 | -------- Summary: end -------- 18:33:21 INFO - PROCESS | 1959 | 18:33:22 INFO - TEST-INFO | 1959: exit 0 18:33:22 INFO - TEST-OK | kraken | took 59355ms 18:33:22 INFO - SUITE-END | took 1170s 18:33:22 INFO - Completed test suite (00:19:31) 18:33:22 INFO - javascript benchmark 18:33:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2663.480621278849, 2951.4097180563886, 3507.754457187997, 3540.6990405815504, 3571.1607772173534, 4182.895427614311, 4923.335349727786, 5800.622959507635, 5832.504237139843, 5883.382244864292, 5188.325517682705, 5822.970885145579, 5946.821595352136, 5978.432048955342, 5979.372165922581, 4325.913481730364, 5213.713245771481, 5302.363716354023, 5352.929414117173, 5432.592555558329, 5396.298481197439, 5476.0, 5497.45025497451, 5573.164025396182, 5595.21666966625, 5206.505381988705, 5414.620976531644, 5466.535344495723, 5477.5070243678065, 5491.368492623359, 5227.320448341691, 5266.131088370415, 5281.70950597717, 5296.814611488579, 5301.310829592167, 5248.71132087735, 5300.443453437372, 5317.707526086064, 5337.626366154371, 5396.757145928443, 4939.863831318781, 5195.558377537914, 5586.162075688639, 5718.542516598662, 5836.066229403275, 6139.815805525796, 6168.537359698041, 6238.0, 6239.126522286883, 6242.157308763304, 5690.886182276373, 5878.617889837147, 6256.99888017915, 6258.593191442542, 6261.749530018794, 5781.075027995543, 5878.294604647384, 5991.370906054889, 6002.189704389895, 6011.579189456696, 6401.583897046677, 6402.295747467775, 6415.647139407284, 6418.358164183638, 6426.839329016719, 6212.782552610637, 6238.376162383725, 6244.968775156186, 6252.718627661766, 6265.154204182377, 6121.331035925228, 6193.1329613854095, 6241.251049874044, 6248.343923888017, 6309.432151106423, 6105.732692890381, 6127.769884593388, 6222.719977601018, 6242.843928901813, 6254.937450625435, 6190.350013248634, 6200.193974783339, 6212.316645169028, 6237.500999919996, 6242.28213755424, 4882.121218180761, 4968.552830245295, 5017.523335283142, 5043.218301163325, 5065.240213967861, 4459.1973444779605, 4461.910761784746, 4473.865784026484, 4491.146682130385, 4517.728936263835, 5931.822045338647, 6034.7284372202475, 6043.909341359883, 6044.697765111727, 6057.091436284504, 6146.279041868284, 6203.131561581382, 6208.844778880564, 6262.968685156637, 6285.057241413733, 5886.970565147232, 6005.489533389624, 6040.637561746309, 6055.0, 6060.909086363708, 5391.81128660495, 5452.672839629635, 5488.4237155098135, 5504.559635229172, 5504.834854954358, 6432.581882177644, 6486.837829054217, 6546.18172728409, 6553.574017688835, 6566.0, 6248.718807653576, 6266.498680105672, 6272.027835685476, 6281.560290779602, 6306.810795676137, 5332.600054995968, 6322.936770632235, 6518.152640156749, 6524.4780417565535, 6572.474202063919, 6144.801763656044, 6187.752489900534, 6218.160548325918, 6235.3452887446165, 6280.717367718372, 6188.0, 6243.969744992026, 6275.995840665471, 6309.968450157719, 6384.07430922523, 5068.265101560327, 5588.133839254922, 5741.8564535886935, 6041.184440100706, 6169.383061693974, 6122.173506576733, 6123.9232566596775, 6171.9691401542705, 6206.503479721521, 6230.470410015199, 5253.23828044939, 6083.148359229623, 6091.406070418474, 6147.44672979434, 6159.0, 6095.847603809941, 6121.6054024712375, 6156.569040167145, 6165.260168779775, 6217.844553886189, 6124.326324104434, 6136.079588061826, 6170.598911070766, 6171.290301615192, 6175.073738939195], "unit": "score", "name": "dojo.html", "value": 5738.217984019227}, {"lowerIsBetter": false, "replicates": [503.79241145219794, 561.9887602247952, 605.8307466589486, 631.8294060603637, 649.7758273395679, 33824.66175338246, 37351.69269075583, 39182.608173918255, 39232.21535569287, 39271.0, 40824.79587602065, 41339.966500837494, 41639.58360416395, 41670.791646041725, 41690.0, 8200.794980125485, 8392.790180245482, 9388.014258502844, 9501.42991420517, 9548.04519548043, 9398.248140148771, 9424.05759424059, 9518.762030949247, 9558.996305387938, 9569.330146889686, 9447.960724320319, 9510.09654082861, 9516.619335226582, 9571.42571445712, 9634.181094606933, 9517.333786634937, 9582.137607615348, 9585.664501742474, 9606.327557070972, 9609.615615375376, 9412.435253884789, 9485.525723713787, 9567.0, 9592.280578956606, 9593.0, 31308.843455782575, 31821.52267715986, 38362.42456363157, 38378.0, 38533.807330963165, 2553.476537309847, 3113.7353324967403, 3137.6548579656446, 3256.951145732816, 3392.9660703393142, 22446.0, 27045.864770676217, 27362.315942101606, 27626.723732762617, 28102.297442563897, 2661.441097369555, 2690.744379283965, 2708.404151086758, 2737.096758069852, 2781.3741908070724, 378025.0, 378690.0, 380545.0, 381501.0, 382056.0, 44496.0, 51169.34657543142, 61163.08255376173, 61546.69226653838, 61582.69208653928, 44192.67421977346, 44246.55753442489, 44448.77775611101, 44461.77769111134, 44718.77640611776, 15328.616784580252, 15410.152441615819, 15416.383344666312, 15687.607809804846, 15691.764623530657, 12580.4338804754, 12619.305938173306, 12651.177673451197, 12668.36658167088, 12706.36468176606, 14410.0, 14466.85533144676, 14553.85446145525, 14768.483103091556, 14880.553583392515, 6348.936510634927, 6461.353864613501, 6475.417212450902, 6518.1200537927725, 6552.443042341359, 939.9530023498797, 964.363520076746, 1002.9699109026741, 1010.3528754662831, 1072.3458690198972, 29259.0, 29838.0, 30462.695373045986, 31201.907933222683, 31276.53085203724, 1011.4993078426079, 1061.5488417422564, 1081.9949281487711, 1086.2342048855537, 1174.4773575758704, 13698.38357273925, 14245.92877035629, 14393.856061439461, 14636.975411721078, 14720.631984200481, 618113.0, 622697.0, 626052.0, 631332.0, 631977.0, 57011.71494142503, 57393.71303143458, 57927.13109303364, 57996.4200357991, 58034.83930321455, 1286.6718986658343, 1432.555907668626, 1458.3874772595536, 1483.1546018769197, 1487.5537338798533, 23800.0, 28806.567901481074, 29189.41621167607, 29280.82876684909, 29523.55714664325, 49533.752331238116, 49810.50189498204, 50155.74922125366, 50320.0, 50451.7296721641, 389613.0, 462569.0, 463189.0, 464459.0, 464540.0, 31730.682693173698, 32787.18032049218, 37838.62161378351, 44355.55644443514, 45369.77315113403, 45087.54912450965, 45562.544374557154, 46974.53025469701, 47559.28661070156, 47811.5218847821, 35860.0, 35954.64045359513, 36069.819650901576, 36395.45406818953, 36804.447933280484, 35061.29877402489, 35148.47277290792, 35632.0, 35724.46413303751, 35955.82022089873, 32666.0, 34241.65758342385, 35725.0, 37863.62136378601, 38288.23423531569, 26972.190834275003, 28441.715582844736, 31487.527687084254, 31951.201219968756, 32749.181270468427, 20159.39521814348, 21108.050137743532, 22694.75178865178, 24306.149284774947, 24994.625080623442], "unit": "score", "name": "ext.html", "value": 18863.58845259796}, {"lowerIsBetter": false, "replicates": [348.684440581274, 348.7462572053467, 358.9551306086739, 361.8064335580464, 374.40843467321633, 18268.543286417847, 19631.0, 21501.784982150173, 21513.46216344592, 21605.891970540124, 20679.793202067976, 20988.790112098875, 21097.47256318589, 21218.939053047365, 21235.893820530877, 5835.0, 6062.757489700407, 6066.302375226861, 6079.209702738638, 6084.209052823149, 4389.209942210401, 5906.084556893667, 6541.345865413445, 6568.80293591193, 6587.308332625077, 6391.744330226786, 6417.0, 6487.61074335539, 6496.54524183305, 6525.771597994048, 6232.563720539564, 6401.551891367606, 6445.613263204199, 6454.515911306671, 6489.221293444793, 5520.503154716095, 5531.363893152299, 5541.0, 5617.859553511154, 5624.887502249932, 12858.164219325714, 13430.664233394145, 25065.874670626712, 25796.484070318675, 25862.74137258622, 1962.2445358537066, 2076.179908935977, 2145.0990583954776, 2197.516546359798, 2523.2178024812365, 9429.90570094304, 9826.459544725038, 13623.0, 13862.93068534661, 14432.855671443362, 1682.562533741224, 1716.5536960390264, 1726.7841519810024, 1757.578181236507, 1801.5316017835326, 91623.0, 97339.51330243374, 98277.50861245791, 98734.0, 99812.0, 11160.995510404102, 11396.803335649638, 11502.0, 11505.367204803817, 11511.769764604662, 13555.322233888266, 13708.24604646734, 13826.930865345608, 13854.86145138556, 13893.4442622296, 7020.297970203041, 8484.19400156984, 8493.745187644381, 8725.389222754473, 8760.167784060504, 6535.444487218545, 8743.431676940978, 8908.376413651113, 8931.910680893237, 9042.502662353634, 4437.955620443819, 4522.977385113053, 4549.044700612908, 4553.0, 4566.589006989387, 1921.2603147788202, 1927.4025052233853, 1937.1766999025358, 1937.728717979484, 1965.6167047425615, 867.5792240763225, 925.9259259259243, 992.1120597065586, 995.9103680668775, 1078.1751959750798, 17316.653666926843, 18931.62136757257, 20947.63840350403, 21506.46233844135, 22097.005634746474, 811.3752410643772, 966.994325901055, 984.2716389871587, 1012.9442880641489, 1066.2323127348297, 10971.890281097247, 11292.830607540893, 11297.265677731086, 11377.975982161644, 11426.714332141762, 583612.0, 584264.0, 615496.9225153845, 623744.0, 623759.0, 113219.0, 115972.42013789876, 117084.0, 117966.0, 124249.0, 1014.9441780702132, 1080.8811030786608, 1085.4355735017746, 1089.6948854320804, 1098.566066403782, 18275.08624568793, 18498.630027399646, 18576.81423185751, 18631.72052419242, 18816.341428049953, 46870.35953741603, 47940.520594793605, 48107.0, 49458.25812612742, 49748.50251497584, 67050.66474667596, 69726.65136674487, 69759.65120174366, 70037.64981175265, 70183.59632807417, 7681.078270607562, 7866.095399028956, 7899.881501777363, 8021.879671804811, 8033.3171680405485, 9003.234725048444, 10927.726806829893, 11529.769404612029, 12234.816477752664, 12468.563600273947, 10729.034386905216, 10916.672499825017, 10920.617778377718, 10958.452077396258, 10960.342379456939, 9215.44707317563, 9492.671026056496, 10022.098011179029, 10036.397816131055, 10141.340812847142, 10974.615888443866, 11092.722681933015, 11093.667189984313, 11330.98021178098, 11525.423728813694, 7861.938638283758, 7920.722774702857, 8011.157433790145, 8050.436469447082, 8100.189981002089, 8712.738617841474, 10615.363078215332, 10963.506642201279, 11001.449927503752, 11154.0], "unit": "score", "name": "jquery.html", "value": 9393.72659252456}, {"lowerIsBetter": false, "replicates": [1589.6820635872825, 1620.829812869649, 1929.5754933914534, 2014.9798502014976, 2041.2345370486069, 7939.92060079399, 8687.218150366474, 8706.434081784679, 8867.157620026102, 8909.732708018753, 8707.172818582241, 8718.86921696175, 8726.301895848334, 8822.647094116228, 8825.735227943156, 2476.2199907029317, 2486.2292689266296, 2497.8126640502037, 2506.0477018732854, 2512.4975004998983, 2434.6469761884514, 2451.3626457121186, 2465.4822487277693, 2503.3616427810884, 2509.6988361396657, 2476.8513889166707, 2483.416397146669, 2489.0914816092177, 2489.3154382544853, 2489.4025433895827, 2437.2688193541867, 2454.5581795276844, 2494.2641920633455, 2511.9748802512013, 2516.263777993179, 2454.3250606083293, 2454.864982425966, 2481.5409149307434, 2509.6862892138483, 2514.7108082570558, 8831.77920551985, 8843.380963332505, 8917.242034427081, 8918.063603321623, 8926.285897128215, 4247.8088486018205, 5146.176611742141, 5181.637285390024, 5230.666180124044, 5257.263983042339, 3514.841832117561, 3587.1032241939515, 3611.7652352596997, 3633.5821380541047, 3653.561572611277, 884.4295429448034, 974.541965276319, 1065.8081545321838, 1078.3907092492716, 1078.735709751116, 11558.959693627614, 11647.30116193031, 11697.473613687405, 11780.764384712258, 11876.584319548861, 4823.831165909176, 4904.386951631046, 4954.157793175169, 4967.428745694291, 4969.950300497021, 7659.885101723478, 10061.949690251502, 10070.59717611302, 10080.848787268196, 10151.898481015243, 5346.973265133727, 5392.946070539323, 5424.864378390493, 5489.0, 5502.477264659851, 4392.297232442794, 4534.841280555231, 4896.167651499253, 4993.7503124843615, 4998.050370429607, 3312.801231926092, 3598.4242521196484, 3853.61463853618, 3996.300647386696, 4074.124063326399, 1337.0640551613715, 1344.9731005379838, 1350.824392828926, 1353.3503918119359, 1377.5798381493742, 1043.389617074005, 1060.1677683018793, 1060.8726952765562, 1336.0447280194708, 1377.4490203918513, 7950.6422211000645, 8173.0, 8180.445715314071, 8187.5087494750505, 8202.38482113844, 508.9312942752681, 512.387696702437, 514.3801718928682, 517.4515014085082, 529.1454301303444, 6217.720202590895, 6255.74977000924, 6361.173047503888, 6369.426751592379, 6371.139896113966, 9526.095020972996, 10649.89350106489, 10678.73303167427, 10689.251752377259, 10801.0, 9008.549572521479, 10611.787764244671, 10656.467176641137, 10663.200259980533, 10689.786204276026, 8055.718049868226, 8196.385271104691, 8251.33989280844, 8289.336853051742, 8330.375221858385, 7955.721549745731, 7991.84016319682, 8021.63902624395, 8052.0, 8120.675172993014, 9022.278217742434, 9438.38650487716, 9446.574904129193, 9449.763755905882, 9495.572699228413, 9403.670871519464, 9470.763230919281, 9611.663591774255, 9733.610655573697, 9924.0, 6843.623600702009, 7299.8540029200185, 7504.962475187589, 7583.810404739705, 7632.084149902047, 6915.550489218386, 8081.636326365446, 8179.959100204461, 8210.0, 8289.295409890226, 7145.249748776304, 7280.817979550554, 7291.744788932362, 7422.0, 7485.850282994418, 7180.712771489082, 7238.963805180941, 7264.34620884123, 7284.67218975158, 7287.744928927462, 6457.515686323451, 7627.771166865003, 7736.110347310131, 7846.136924938138, 7864.0, 6998.055262539696, 7025.824354391181, 7070.010198572307, 7079.256678048937, 7092.113485814273, 7167.820804479929, 7211.3870321023305, 7216.7834964951135, 7237.638118093969, 7251.274872512707], "unit": "score", "name": "mootools.html", "value": 4814.981234838397}, {"lowerIsBetter": false, "replicates": [326.15851104151284, 327.95900512435946, 332.1762030165192, 336.789506558401, 338.53282470191135, 6873.965630171849, 6921.238663746984, 6924.376806087451, 6967.233604303529, 7010.298970102987, 6841.657917104138, 6842.931570684292, 6850.0, 6850.280720524348, 6893.241743408221, 4826.276058591222, 4896.583790377805, 5035.748212589374, 5043.36957880265, 5098.847034588959, 5030.270610761438, 5033.4329491959, 5057.064443078024, 5070.442251352367, 5077.0, 4382.408374869399, 4974.552290293873, 4978.153713868651, 5015.899682006358, 5029.748512574375, 4051.4327994080854, 5039.596832253411, 5047.0915235257635, 5055.266986286968, 5064.316317297173, 4300.397944287803, 4306.504751953534, 4308.009157893702, 4319.935200971988, 4325.134973005412, 5586.742982828871, 6312.179416675849, 6580.80257592273, 6624.27133015368, 6662.400383965418, 5816.563757718146, 5839.299284085894, 5843.590948633598, 5895.498882594985, 5898.351181370046, 7311.926880731231, 7313.195548489662, 7319.451041171933, 7339.6330183491145, 7340.26597340267, 4668.043051174535, 4674.018456124218, 4674.462436819741, 4682.836100736492, 4689.2966055091665, 7388.519746216479, 7710.113336966265, 7735.419843511759, 7767.417443691746, 7782.533048017137, 4545.113702827917, 4600.217962946307, 4682.180618391768, 4706.741129237925, 4715.434147902273, 4781.258904869751, 4789.425268967746, 4791.281307803857, 4792.448868380181, 4813.446453657874, 5654.6889921054735, 5723.6851973141875, 5745.569082318842, 5753.280839895013, 5758.798442054592, 7202.063731714844, 7276.199618042011, 7309.195988441267, 7313.232110628307, 7328.267173282736, 1523.405871710034, 1552.8912976091792, 1654.96690066198, 1678.3789997700685, 1682.1084825042747, 886.7295474880094, 1033.3696445168441, 1073.1522097542854, 1082.9133669306436, 1084.322298563398, 5548.973439913629, 6439.259485159173, 6650.20197576294, 6800.727970881208, 6821.965890170517, 5349.251104845324, 6174.9691251544355, 7106.649736550039, 7279.745208917662, 7528.811779705442, 6725.630090345078, 6740.0, 6758.357955994173, 6761.391474767294, 6805.502789386327, 3960.920781584352, 3990.2817492851564, 4004.939925901114, 4007.4189242559664, 4017.372963949605, 6442.645654488954, 7630.198829122862, 7747.147813740484, 7910.644021019068, 8076.3942704297415, 6362.745490180433, 7437.6530561247655, 7923.207679232146, 7980.840383192303, 7997.240262175084, 5695.914561281584, 7013.859722805515, 8067.0, 8073.838523229385, 8102.270795628304, 7397.757272150942, 7564.0, 7608.809779755329, 7646.923530764621, 7673.424493162924, 7485.0, 7492.40060795146, 7496.850062998818, 7508.136564295176, 7538.396928245617, 7112.679929403086, 7445.2182520836695, 7985.2014798519685, 7993.400494962785, 8041.758747237593, 4754.381930349033, 4765.380500534909, 4773.546513081252, 4777.522247775195, 4780.282957556395, 6503.284638689645, 7576.204498527575, 7584.886226706714, 7609.162992070978, 7628.847423051397, 7310.634468276671, 7380.114386273467, 7389.445791565761, 7394.371478424394, 7427.368673662799, 7290.671919763729, 7293.0, 7300.306470885257, 7316.122065352191, 7365.085077879897, 7064.611446370499, 7107.644617768988, 7122.216556178712, 7164.176119746087, 7166.211716711262, 7063.187733410518, 7322.340989310987, 7323.8535229296185, 7325.267473252845, 7373.520721153108, 5118.71847048401, 7105.04081948951, 7149.14210294768, 7149.82125446868, 7149.928500715135], "unit": "score", "name": "prototype.html", "value": 5257.287991229706}, {"lowerIsBetter": false, "replicates": [675.344915432031, 692.9376356127948, 703.061413013627, 715.3740477082553, 726.93457588817, 14327.785083223747, 14500.854991450109, 14541.491047813328, 14544.127352358866, 14567.417303307868, 11893.643190704293, 13235.933820330885, 13512.797308040388, 13574.185548867075, 13576.93211533941, 757.4962649837851, 921.0513171433435, 930.762655522844, 932.2169377722712, 936.5176933879058, 530.8115618955273, 739.8779201431757, 918.9724308270762, 921.1755478846428, 927.8747369105151, 941.7127776028309, 976.345848281653, 978.2125389061803, 980.5342462330372, 982.135720565901, 936.3585943628636, 960.6541645007792, 978.6819283732815, 979.045430705064, 983.6016413352532, 663.9178139632417, 696.2828286864537, 723.522475166393, 726.4224941171728, 734.7061175529777, 12272.386380681019, 12735.617931461979, 14004.859951400458, 14233.430662773477, 14426.0, 12571.93714031424, 12664.176828506117, 12781.936090319581, 12803.0, 12981.41583628739, 9829.754256143582, 9886.505674716236, 9903.05920937517, 9906.257030722652, 9935.602575896955, 3537.0626783902285, 3574.8927532174075, 3603.261331427051, 3614.6927511161584, 3632.3280193164087, 72962.54074918525, 74678.62660686662, 74861.50276994484, 80981.78527322094, 81191.18808811896, 9370.437773733598, 9375.953120234355, 9562.904370956341, 9585.329026968186, 9647.035296470296, 19826.50433739139, 19858.1063852127, 19866.70199947002, 19874.70187947182, 19881.502962426053, 7337.41300695943, 7412.332890039815, 7552.584607846511, 7575.356094732009, 7577.696892124363, 3961.1483531040963, 3997.0806714455257, 4141.254574176617, 4142.813573389205, 4146.0, 3490.47642853574, 3493.3886569850174, 3553.893383198508, 3602.7297952653657, 3612.710983121344, 648.1476857931805, 656.2584279763931, 662.8044726805604, 663.8937769956784, 671.9092922455503, 511.9308893299431, 530.8778980834429, 557.4871118570925, 560.7756897241054, 575.1947273816606, 7768.844623107506, 8016.599170041474, 8035.437519373588, 8056.8388632227025, 8121.634526446206, 501.57366238697546, 545.4000599340693, 545.6862304175115, 557.4425574425575, 561.3684604819578, 3677.6506231907924, 3683.4474828775897, 3721.8511259549855, 3741.644543768338, 3916.2559113768293, 64078.0, 84082.15917840866, 85153.0, 85192.0, 88480.5575972116, 77051.2294877044, 77489.2251077482, 77542.0, 78108.60945695349, 79138.20861791424, 67591.0, 67892.660536697, 68037.65981170161, 68305.97541036889, 69036.6548167266, 7156.0, 7508.399328053852, 7533.886991695239, 7601.961990190235, 7755.2244775521995, 48705.75647121741, 49261.0, 49672.25491617701, 49791.75104124456, 49918.500814991385, 64673.0, 65624.34375656182, 65821.0, 66652.3336916581, 66733.33266667271, 7853.568053757098, 9529.665846781594, 9576.377535460173, 9577.090176433228, 9666.275029372684, 10488.28738146612, 10502.842457362993, 10661.253712240068, 10993.670189894316, 11501.712457188638, 9875.604975801174, 9929.156021737945, 9948.651797187063, 10179.134773544332, 10262.692119236435, 9868.457234852152, 10029.398236105857, 10083.24375671813, 10126.0, 10145.0, 9723.173530250007, 9963.352382095141, 9981.700548983543, 9987.60049598008, 9992.450415227233, 7492.138404083382, 7886.763397098096, 8284.50292982423, 8323.916760832315, 8549.87175192385, 8134.511929284262, 8230.711925082593, 8393.538355390512, 8394.11861754507, 8464.915350846413], "unit": "score", "name": "yui.html", "value": 6566.662570750861}], "name": "dromaeo_css", "value": 7435.821618683595}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 119.0, 170.0, 126.0, 118.0, 130.0, 116.0, 116.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 123.8}, {"lowerIsBetter": true, "replicates": [164.0, 120.0, 146.0, 157.0, 125.0, 149.0, 172.0, 131.0, 163.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [192.0, 197.0, 218.0, 267.0, 246.0, 202.0, 196.0, 200.0, 199.0, 202.0], "unit": "score", "name": "audio-dft", "value": 211.9}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 94.0, 125.0, 81.0, 81.0, 89.0, 87.0, 64.0, 76.0], "unit": "score", "name": "audio-fft", "value": 86.2}, {"lowerIsBetter": true, "replicates": [90.0, 111.0, 163.0, 77.0, 82.0, 79.0, 121.0, 80.0, 83.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 100.5}, {"lowerIsBetter": true, "replicates": [91.0, 88.0, 90.0, 88.0, 91.0, 87.0, 92.0, 100.0, 135.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.9}, {"lowerIsBetter": true, "replicates": [119.0, 154.0, 104.0, 112.0, 152.0, 150.0, 97.0, 97.0, 127.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 120.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 96.0, 94.0, 93.0, 90.0, 90.0, 92.0, 100.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 104.0}, {"lowerIsBetter": true, "replicates": [78.0, 70.0, 56.0, 55.0, 57.0, 57.0, 55.0, 66.0, 59.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 61.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 73.0, 78.0, 71.0, 70.0, 69.0, 66.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 85.0, 83.0, 86.0, 83.0, 86.0, 89.0, 88.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [144.0, 142.0, 127.0, 123.0, 125.0, 137.0, 148.0, 126.0, 124.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 133.0, 176.0, 183.0, 184.0, 163.0, 156.0, 135.0, 168.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 159.1}, {"lowerIsBetter": true, "replicates": [74.0, 94.0, 78.0, 61.0, 99.0, 88.0, 84.0, 60.0, 63.0, 60.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.1}], "name": "kraken", "value": 1570.4999999999995}]} 18:33:22 INFO - Return code: 0 18:33:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:33:22 ERROR - # TBPL SUCCESS # 18:33:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:33:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:33:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:33:22 INFO - 2016-03-23 18:33:22.579 screenresolution[1964:16980] starting screenresolution argv=screenresolution get 18:33:22 INFO - 2016-03-23 18:33:22.582 screenresolution[1964:16980] Display 0: 1600x1200x32@60 18:33:22 INFO - 2016-03-23 18:33:22.587 screenresolution[1965:16983] starting screenresolution argv=screenresolution list 18:33:22 INFO - Available Modes on Display 0 18:33:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:33:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:33:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:33:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:33:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:33:22 INFO - Intel Iris: 18:33:22 INFO - Chipset Model: Intel Iris 18:33:22 INFO - Type: GPU 18:33:22 INFO - Bus: Built-In 18:33:22 INFO - VRAM (Dynamic, Max): 1536 MB 18:33:22 INFO - Vendor: Intel (0x8086) 18:33:22 INFO - Device ID: 0x0a2e 18:33:22 INFO - Revision ID: 0x0009 18:33:22 INFO - Displays: 18:33:22 INFO - Display: 18:33:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:33:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:33:22 INFO - Display Serial Number: 1600x1200 60 18:33:22 INFO - Main Display: Yes 18:33:22 INFO - Mirror: Off 18:33:22 INFO - Online: Yes 18:33:22 INFO - Rotation: Supported 18:33:22 INFO - Return code: 0 18:33:22 INFO - Running post-action listener: _resource_record_post_action 18:33:22 INFO - Running post-run listener: _resource_record_post_run 18:33:23 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 2981888; Write bytes: 710937088; Read time: 43; Write time: 2231 18:33:23 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 396116480; Write bytes: 391301120; Read time: 29987; Write time: 773 18:33:23 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 2981888; Write bytes: 304312832; Read time: 43; Write time: 1399 18:33:23 INFO - Running post-run listener: _upload_blobber_files 18:33:23 INFO - Blob upload gear active. 18:33:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:33:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:33:24 INFO - (blobuploader) - INFO - Open directory for files ... 18:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:33:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:25 INFO - (blobuploader) - INFO - Done attempting. 18:33:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:33:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:33:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:26 INFO - (blobuploader) - INFO - Done attempting. 18:33:26 INFO - (blobuploader) - INFO - Iteration through files over. 18:33:26 INFO - Return code: 0 18:33:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:33:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:33:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8e00df35427364bddef59047a8ed405697a07e984e0422a54311ace652d3a1998d4874ce8f977c43aa33b808f5659edcad8648f04b790c198f243b3daf1b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/113a514ccb8b0ab7105f7b7ac47c268f0e63b686becb6e4c42bd7a145bce6f8c9fa8d4671383bf72809673a6018804968ea7a138df67bef5f1a6a9e0f0bd6f33"} 18:33:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:33:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:33:26 INFO - Contents: 18:33:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8e00df35427364bddef59047a8ed405697a07e984e0422a54311ace652d3a1998d4874ce8f977c43aa33b808f5659edcad8648f04b790c198f243b3daf1b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/113a514ccb8b0ab7105f7b7ac47c268f0e63b686becb6e4c42bd7a145bce6f8c9fa8d4671383bf72809673a6018804968ea7a138df67bef5f1a6a9e0f0bd6f33"} 18:33:26 INFO - Running post-run listener: copy_logs_to_upload_dir 18:33:26 INFO - Copying logs to upload dir... 18:33:26 INFO - mkdir: /builds/slave/test/build/upload/logs 18:33:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.301263 ========= master_lag: 3.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-03-23 18:33:30.229667) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 12 secs) (at 2016-03-23 18:33:30.236859) ========= 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.VSplhcdHZb/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.lBGSHKbv7s/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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/ee8e00df35427364bddef59047a8ed405697a07e984e0422a54311ace652d3a1998d4874ce8f977c43aa33b808f5659edcad8648f04b790c198f243b3daf1b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/113a514ccb8b0ab7105f7b7ac47c268f0e63b686becb6e4c42bd7a145bce6f8c9fa8d4671383bf72809673a6018804968ea7a138df67bef5f1a6a9e0f0bd6f33"} build_url:https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/PaHe2PkxR6WkK_t2GY5hfQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8e00df35427364bddef59047a8ed405697a07e984e0422a54311ace652d3a1998d4874ce8f977c43aa33b808f5659edcad8648f04b790c198f243b3daf1b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/113a514ccb8b0ab7105f7b7ac47c268f0e63b686becb6e4c42bd7a145bce6f8c9fa8d4671383bf72809673a6018804968ea7a138df67bef5f1a6a9e0f0bd6f33"}' ========= master_lag: 12.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 12 secs) (at 2016-03-23 18:33:42.255931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-23 18:33:42.256242) ========= 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.VSplhcdHZb/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.lBGSHKbv7s/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005262 ========= master_lag: 1.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-23 18:33:43.548277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 18:33:43.548634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 18:33:43.571888) ========= ========= Total master_lag: 28.98 =========