builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0143 starttime: 1459810263.48 results: success (0) buildid: 20160404144745 builduid: af7f5d5206354c529799cab62718dcda revision: 8649e83a43b9c1fc271d43e50ade50966c7e94b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.481743) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.482186) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.482476) ========= 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.E5D4ye9oOB/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.91a7VZFpuS/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005619 basedir: '/builds/slave/test' ========= master_lag: 0.19 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.680008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.680306) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.745704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.746019) ========= 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.E5D4ye9oOB/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.91a7VZFpuS/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005488 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.809454) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.809716) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.810036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:03.810330) ========= 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.E5D4ye9oOB/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.91a7VZFpuS/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-04 15:51:03-- 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% 43.5M=0s 2016-04-04 15:51:04 (43.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.637671 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:04.541773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:04.542111) ========= 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.E5D4ye9oOB/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.91a7VZFpuS/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.026914 ========= master_lag: 0.50 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:05.065578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 15:51:05.065885) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8649e83a43b9c1fc271d43e50ade50966c7e94b9 --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 8649e83a43b9c1fc271d43e50ade50966c7e94b9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E5D4ye9oOB/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.91a7VZFpuS/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-04 15:51:05,048 truncating revision to first 12 chars 2016-04-04 15:51:05,048 Setting DEBUG logging. 2016-04-04 15:51:05,049 attempt 1/10 2016-04-04 15:51:05,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8649e83a43b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 15:51:05,736 unpacking tar archive at: fx-team-8649e83a43b9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.039623 ========= master_lag: 0.81 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 15:51:06.915892) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:06.916230) ========= echo 8649e83a43b9c1fc271d43e50ade50966c7e94b9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8649e83a43b9c1fc271d43e50ade50966c7e94b9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E5D4ye9oOB/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.91a7VZFpuS/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 8649e83a43b9c1fc271d43e50ade50966c7e94b9 program finished with exit code 0 elapsedTime=0.006025 script_repo_revision: '8649e83a43b9c1fc271d43e50ade50966c7e94b9' ========= master_lag: 0.24 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 15:51:07.160996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-04-04 15:51:07.161380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-04-04 15:51:16.072940) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-04 15:51:16.073215) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E5D4ye9oOB/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.91a7VZFpuS/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:51:16 INFO - MultiFileLogger online at 20160404 15:51:16 in /builds/slave/test 15:51:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:51:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:16 INFO - {'append_to_log': False, 15:51:16 INFO - 'base_work_dir': '/builds/slave/test', 15:51:16 INFO - 'blob_upload_branch': 'Fx-Team', 15:51:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:16 INFO - 'branch': 'Fx-Team', 15:51:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:16 INFO - 'config_files': ('talos/mac_config.py',), 15:51:16 INFO - 'default_actions': ('clobber', 15:51:16 INFO - 'read-buildbot-config', 15:51:16 INFO - 'download-and-extract', 15:51:16 INFO - 'populate-webroot', 15:51:16 INFO - 'create-virtualenv', 15:51:16 INFO - 'install', 15:51:16 INFO - 'run-tests'), 15:51:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:16 INFO - 'download_minidump_stackwalk': True, 15:51:16 INFO - 'download_symbols': 'ondemand', 15:51:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:16 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:16 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:16 INFO - 'installer_path': 'installer.exe', 15:51:16 INFO - 'log_level': 'info', 15:51:16 INFO - 'log_name': 'talos', 15:51:16 INFO - 'log_to_console': True, 15:51:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:51:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:51:16 INFO - 'opt_config_files': (), 15:51:16 INFO - 'pip_index': False, 15:51:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:51:16 INFO - 'cmd': ('bash', 15:51:16 INFO - '-c', 15:51:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:51:16 INFO - 'enabled': True, 15:51:16 INFO - 'halt_on_failure': False, 15:51:16 INFO - 'name': 'check_screen_resolution'},), 15:51:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:51:16 INFO - 'cmd': ('bash', 15:51:16 INFO - '-c', 15:51:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:51:16 INFO - 'enabled': True, 15:51:16 INFO - 'halt_on_failure': False, 15:51:16 INFO - 'name': 'check_screen_resolution'},), 15:51:16 INFO - 'run_cmd_checks_enabled': True, 15:51:16 INFO - 'sps_profile': False, 15:51:16 INFO - 'sps_profile_interval': 0, 15:51:16 INFO - 'suite': 'dromaeojs', 15:51:16 INFO - 'system_bits': '32', 15:51:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:16 INFO - 'title': 't-yosemite-r7-0143', 15:51:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:16 INFO - 'use_talos_json': True, 15:51:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:16 INFO - 'work_dir': 'build'} 15:51:16 INFO - ##### 15:51:16 INFO - ##### Running clobber step. 15:51:16 INFO - ##### 15:51:16 INFO - Running pre-action listener: _resource_record_pre_action 15:51:16 INFO - Running main action method: clobber 15:51:16 INFO - rmtree: /builds/slave/test/build 15:51:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:17 INFO - Running post-action listener: _resource_record_post_action 15:51:17 INFO - ##### 15:51:17 INFO - ##### Running read-buildbot-config step. 15:51:17 INFO - ##### 15:51:17 INFO - Running pre-action listener: _resource_record_pre_action 15:51:17 INFO - Running main action method: read_buildbot_config 15:51:17 INFO - Using buildbot properties: 15:51:17 INFO - { 15:51:17 INFO - "project": "", 15:51:17 INFO - "product": "firefox", 15:51:17 INFO - "script_repo_revision": "production", 15:51:17 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:51:17 INFO - "repository": "", 15:51:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:51:17 INFO - "buildid": "20160404144745", 15:51:17 INFO - "pgo_build": "False", 15:51:17 INFO - "basedir": "/builds/slave/test", 15:51:17 INFO - "buildnumber": 608, 15:51:17 INFO - "slavename": "t-yosemite-r7-0143", 15:51:17 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:51:17 INFO - "platform": "yosemite_r7", 15:51:17 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:51:17 INFO - "branch": "fx-team", 15:51:17 INFO - "repo_path": "integration/fx-team", 15:51:17 INFO - "revision": "8649e83a43b9c1fc271d43e50ade50966c7e94b9", 15:51:17 INFO - "stage_platform": "macosx64", 15:51:17 INFO - "builduid": "af7f5d5206354c529799cab62718dcda", 15:51:17 INFO - "slavebuilddir": "test" 15:51:17 INFO - } 15:51:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 15:51:17 INFO - Running post-action listener: _resource_record_post_action 15:51:17 INFO - ##### 15:51:17 INFO - ##### Running download-and-extract step. 15:51:17 INFO - ##### 15:51:17 INFO - Running pre-action listener: _resource_record_pre_action 15:51:17 INFO - Running main action method: download_and_extract 15:51:17 INFO - mkdir: /builds/slave/test/build/tests 15:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:17 INFO - https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/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 15:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/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 15:51:23 INFO - Downloaded 1199 bytes. 15:51:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:51:23 INFO - Using the following test package requirements: 15:51:23 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:51:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:51:23 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 15:51:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:51:23 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 15:51:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:51:23 INFO - u'jsshell-mac.zip'], 15:51:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:51:23 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 15:51:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:51:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:51:23 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 15:51:23 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:51:23 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 15:51:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:51:23 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 15:51:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:51:23 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 15:51:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:23 INFO - https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/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 15:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/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 15:51:31 INFO - Downloaded 17959557 bytes. 15:51:31 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'] 15:51:31 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 15:51:34 INFO - Return code: 0 15:51:34 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 15:51: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')]} 15:51:34 INFO - https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:51:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:51:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:51:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/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 15:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/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 15:51:36 INFO - Downloaded 17959557 bytes. 15:51:36 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'] 15:51:36 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 15:51:39 INFO - Return code: 0 15:51:39 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')]} 15:51:39 INFO - https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/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 15:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/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 15:51:40 INFO - Downloaded 10847584 bytes. 15:51:40 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'] 15:51:40 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 15:51:41 INFO - Return code: 0 15:51: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')]} 15:51:41 INFO - https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 15:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/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 15:51:44 INFO - Downloaded 111242026 bytes. 15:51:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:51:44 INFO - mkdir: /builds/slave/test/properties 15:51:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:44 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:44 INFO - Contents: 15:51:44 INFO - build_url:https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:51:46 INFO - Running post-action listener: _resource_record_post_action 15:51:46 INFO - Running post-action listener: set_extra_try_arguments 15:51:46 INFO - ##### 15:51:46 INFO - ##### Running populate-webroot step. 15:51:46 INFO - ##### 15:51:46 INFO - Running pre-action listener: _resource_record_pre_action 15:51:46 INFO - Running main action method: populate_webroot 15:51:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:46 INFO - '--tppagecycles', 15:51:46 INFO - '7'], 15:51:46 INFO - 'tests': ['tsvgm']}}, 15:51:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:51:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:51:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:46 INFO - 'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:46 INFO - 'tests': ['damp', 'tps']}, 15:51:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:46 INFO - 'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['damp', 'tps']}, 15:51:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:51:46 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['dromaeo_dom']}, 15:51:46 INFO - 'other': {'tests': ['a11yr', 15:51:46 INFO - 'ts_paint', 15:51:46 INFO - 'tpaint', 15:51:46 INFO - 'sessionrestore', 15:51:46 INFO - 'sessionrestore_no_auto_restore', 15:51:46 INFO - 'tabpaint']}, 15:51:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['a11yr', 15:51:46 INFO - 'ts_paint', 15:51:46 INFO - 'tpaint', 15:51:46 INFO - 'sessionrestore', 15:51:46 INFO - 'sessionrestore_no_auto_restore', 15:51:46 INFO - 'tabpaint']}, 15:51:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['a11yr', 15:51:46 INFO - 'ts_paint', 15:51:46 INFO - 'tpaint', 15:51:46 INFO - 'sessionrestore', 15:51:46 INFO - 'sessionrestore_no_auto_restore', 15:51:46 INFO - 'tabpaint']}, 15:51:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['a11yr', 15:51:46 INFO - 'ts_paint', 15:51:46 INFO - 'tpaint', 15:51:46 INFO - 'sessionrestore', 15:51:46 INFO - 'sessionrestore_no_auto_restore', 15:51:46 INFO - 'tabpaint']}, 15:51:46 INFO - 'other_l64': {'tests': ['a11yr', 15:51:46 INFO - 'ts_paint', 15:51:46 INFO - 'tpaint', 15:51:46 INFO - 'sessionrestore', 15:51:46 INFO - 'sessionrestore_no_auto_restore', 15:51:46 INFO - 'tabpaint']}, 15:51:46 INFO - 'other_nol64': {'tests': ['a11yr', 15:51:46 INFO - 'ts_paint', 15:51:46 INFO - 'tpaint', 15:51:46 INFO - 'sessionrestore', 15:51:46 INFO - 'sessionrestore_no_auto_restore', 15:51:46 INFO - 'tabpaint']}, 15:51:46 INFO - 'svgr': {'tests': ['tsvgx', 15:51:46 INFO - 'tsvgr_opacity', 15:51:46 INFO - 'tart', 15:51:46 INFO - 'tscrollx', 15:51:46 INFO - 'cart']}, 15:51:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['tsvgx', 15:51:46 INFO - 'tsvgr_opacity', 15:51:46 INFO - 'tart', 15:51:46 INFO - 'tscrollx', 15:51:46 INFO - 'cart']}, 15:51:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:46 INFO - 'tests': ['tp5o']}, 15:51:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:46 INFO - 'talos_options': ['--e10s'], 15:51:46 INFO - 'tests': ['tp5o']}, 15:51:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:46 INFO - 'talos_options': ['--xperf_path', 15:51:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:46 INFO - 'tests': ['tp5n']}, 15:51:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:46 INFO - 'talos_options': ['--e10s', 15:51:46 INFO - '--xperf_path', 15:51:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:46 INFO - 'tests': ['tp5n']}}, 15:51:46 INFO - 'talos.zip': {'path': '', 15:51:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:46 INFO - Running post-action listener: _resource_record_post_action 15:51:46 INFO - ##### 15:51:46 INFO - ##### Running create-virtualenv step. 15:51:46 INFO - ##### 15:51:46 INFO - Running pre-action listener: _resource_record_pre_action 15:51:46 INFO - Running main action method: create_virtualenv 15:51:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:46 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 15:51:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:46 INFO - Using real prefix '/tools/python27' 15:51:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:49 INFO - Installing pip.................done. 15:51:49 INFO - Return code: 0 15:51:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:49 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 0x105ca3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8d723a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, '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.E5D4ye9oOB/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.91a7VZFpuS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:51:49 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 15:51:49 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 15:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:49 INFO - 'HOME': '/Users/cltbld', 15:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:49 INFO - 'LOGNAME': 'cltbld', 15:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:49 INFO - 'MOZ_NO_REMOTE': '1', 15:51:49 INFO - 'NO_EM_RESTART': '1', 15:51:49 INFO - 'PAGER': '/bin/cat', 15:51:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:49 INFO - 'PWD': '/builds/slave/test', 15:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:49 INFO - 'SHELL': '/bin/bash', 15:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:51:49 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:49 INFO - 'USER': 'cltbld', 15:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:49 INFO - 'XPC_FLAGS': '0x0', 15:51:49 INFO - 'XPC_SERVICE_NAME': '0', 15:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:50 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 15:51:50 INFO - Cleaning up... 15:51:50 INFO - Return code: 0 15:51:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51:50 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')]} 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:50 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')]} 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:50 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 0x105ca3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8d723a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, '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.E5D4ye9oOB/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.91a7VZFpuS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:51:50 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 15:51:50 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 15:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:50 INFO - 'HOME': '/Users/cltbld', 15:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:50 INFO - 'LOGNAME': 'cltbld', 15:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:50 INFO - 'MOZ_NO_REMOTE': '1', 15:51:50 INFO - 'NO_EM_RESTART': '1', 15:51:50 INFO - 'PAGER': '/bin/cat', 15:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:50 INFO - 'PWD': '/builds/slave/test', 15:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:50 INFO - 'SHELL': '/bin/bash', 15:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:51:50 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:50 INFO - 'USER': 'cltbld', 15:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:50 INFO - 'XPC_FLAGS': '0x0', 15:51:50 INFO - 'XPC_SERVICE_NAME': '0', 15:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:50 INFO - Downloading/unpacking psutil>=0.7.1 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:00 INFO - Installing collected packages: psutil 15:52:00 INFO - Running setup.py install for psutil 15:52:00 INFO - building 'psutil._psutil_osx' extension 15:52:00 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 15:52:01 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 15:52:01 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 15:52:01 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 15:52:01 INFO - building 'psutil._psutil_posix' extension 15:52:01 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 15:52:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:52:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:52:01 INFO - ^ 15:52:01 INFO - 1 warning generated. 15:52:01 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 15:52:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:01 INFO - Successfully installed psutil 15:52:01 INFO - Cleaning up... 15:52:01 INFO - Return code: 0 15:52:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:01 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 0x105ca3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8d723a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, '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.E5D4ye9oOB/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.91a7VZFpuS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:52:01 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 15:52:01 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 15:52:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:52:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:01 INFO - 'HOME': '/Users/cltbld', 15:52:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:01 INFO - 'LOGNAME': 'cltbld', 15:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:01 INFO - 'MOZ_NO_REMOTE': '1', 15:52:01 INFO - 'NO_EM_RESTART': '1', 15:52:01 INFO - 'PAGER': '/bin/cat', 15:52:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:01 INFO - 'PWD': '/builds/slave/test', 15:52:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:01 INFO - 'SHELL': '/bin/bash', 15:52:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:52:01 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:52:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:01 INFO - 'USER': 'cltbld', 15:52:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:01 INFO - 'XPC_FLAGS': '0x0', 15:52:01 INFO - 'XPC_SERVICE_NAME': '0', 15:52:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:52:06 INFO - Installing collected packages: mozsystemmonitor 15:52:06 INFO - Running setup.py install for mozsystemmonitor 15:52:06 INFO - Successfully installed mozsystemmonitor 15:52:06 INFO - Cleaning up... 15:52:06 INFO - Return code: 0 15:52:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ca3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8d723a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, '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.E5D4ye9oOB/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.91a7VZFpuS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:52:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:52:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:06 INFO - 'HOME': '/Users/cltbld', 15:52:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:06 INFO - 'LOGNAME': 'cltbld', 15:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:06 INFO - 'MOZ_NO_REMOTE': '1', 15:52:06 INFO - 'NO_EM_RESTART': '1', 15:52:06 INFO - 'PAGER': '/bin/cat', 15:52:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:06 INFO - 'PWD': '/builds/slave/test', 15:52:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:06 INFO - 'SHELL': '/bin/bash', 15:52:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:52:06 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:52:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:06 INFO - 'USER': 'cltbld', 15:52:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:06 INFO - 'XPC_FLAGS': '0x0', 15:52:06 INFO - 'XPC_SERVICE_NAME': '0', 15:52:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:07 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:12 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:13 INFO - Downloading docopt-0.6.1.tar.gz 15:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:13 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:13 INFO - Running setup.py install for blobuploader 15:52:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:13 INFO - Running setup.py install for requests 15:52:14 INFO - Running setup.py install for docopt 15:52:14 INFO - Successfully installed blobuploader requests docopt 15:52:14 INFO - Cleaning up... 15:52:14 INFO - Return code: 0 15:52:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:14 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')]} 15:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:14 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')]} 15:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:14 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 0x105ca3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8d723a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, '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.E5D4ye9oOB/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.91a7VZFpuS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:52:14 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 15:52:14 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 15:52:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:14 INFO - 'HOME': '/Users/cltbld', 15:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:14 INFO - 'LOGNAME': 'cltbld', 15:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:14 INFO - 'MOZ_NO_REMOTE': '1', 15:52:14 INFO - 'NO_EM_RESTART': '1', 15:52:14 INFO - 'PAGER': '/bin/cat', 15:52:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:14 INFO - 'PWD': '/builds/slave/test', 15:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:14 INFO - 'SHELL': '/bin/bash', 15:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:52:14 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:14 INFO - 'USER': 'cltbld', 15:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:14 INFO - 'XPC_FLAGS': '0x0', 15:52:14 INFO - 'XPC_SERVICE_NAME': '0', 15:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:14 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-0HEIB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:14 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-s2uO25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:14 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Hzi1os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:14 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ttYWQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:14 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-BFyaLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:15 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-1flH7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:15 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-HoQRrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:15 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-FT2rqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:15 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-0JH7VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:15 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Qp_VVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:15 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-HN7kGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:15 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-RiLRqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:15 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-5GpZc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:15 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-4Ith3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:16 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-VvWYnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:16 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-wEMFDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:16 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-IBZOd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:16 INFO - Running setup.py install for manifestparser 15:52:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:16 INFO - Running setup.py install for mozcrash 15:52:16 INFO - Running setup.py install for mozdebug 15:52:16 INFO - Running setup.py install for mozdevice 15:52:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:16 INFO - Running setup.py install for mozfile 15:52:17 INFO - Running setup.py install for mozhttpd 15:52:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:17 INFO - Running setup.py install for mozinfo 15:52:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:17 INFO - Running setup.py install for mozInstall 15:52:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:17 INFO - Running setup.py install for mozleak 15:52:17 INFO - Running setup.py install for mozlog 15:52:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:17 INFO - Running setup.py install for moznetwork 15:52:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:17 INFO - Running setup.py install for mozprocess 15:52:18 INFO - Running setup.py install for mozprofile 15:52:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:18 INFO - Running setup.py install for mozrunner 15:52:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:18 INFO - Running setup.py install for mozscreenshot 15:52:18 INFO - Running setup.py install for moztest 15:52:18 INFO - Running setup.py install for mozversion 15:52:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:18 INFO - Cleaning up... 15:52:18 INFO - Return code: 0 15:52:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:18 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 0x105ca3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8d723a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, '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.E5D4ye9oOB/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.91a7VZFpuS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:52:18 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 15:52:18 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 15:52:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:52:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:18 INFO - 'HOME': '/Users/cltbld', 15:52:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:18 INFO - 'LOGNAME': 'cltbld', 15:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:18 INFO - 'MOZ_NO_REMOTE': '1', 15:52:18 INFO - 'NO_EM_RESTART': '1', 15:52:18 INFO - 'PAGER': '/bin/cat', 15:52:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:18 INFO - 'PWD': '/builds/slave/test', 15:52:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:18 INFO - 'SHELL': '/bin/bash', 15:52:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:52:18 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:52:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:18 INFO - 'USER': 'cltbld', 15:52:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:18 INFO - 'XPC_FLAGS': '0x0', 15:52:18 INFO - 'XPC_SERVICE_NAME': '0', 15:52:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:19 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ImMSl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:19 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)) 15:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:19 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-QSNDLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:19 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)) 15:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:19 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-u1Fz7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:19 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)) 15:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:19 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-wZidc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:19 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)) 15:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:19 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-MtFCYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:19 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)) 15:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:19 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-9byjUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:19 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)) 15:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:19 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-FAd3OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:20 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-AsCoIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:20 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-L7bXd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:20 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-cDSD7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:20 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-1NSSLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:20 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-r36FI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:20 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-HX79f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:20 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-XlT08W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:20 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-NsoBpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:20 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-zwN7UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:20 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)) 15:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:21 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Wuzh9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:21 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)) 15:52:21 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)) 15:52:21 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)) 15:52:21 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)) 15:52:21 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)) 15:52:21 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)) 15:52:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:27 INFO - Downloading blessings-1.6.tar.gz 15:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:27 INFO - Installing collected packages: blessings 15:52:27 INFO - Running setup.py install for blessings 15:52:27 INFO - Successfully installed blessings 15:52:27 INFO - Cleaning up... 15:52:27 INFO - Return code: 0 15:52:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:28 INFO - Reading from file tmpfile_stdout 15:52:28 INFO - Current package versions: 15:52:28 INFO - blessings == 1.6 15:52:28 INFO - blobuploader == 1.2.4 15:52:28 INFO - docopt == 0.6.1 15:52:28 INFO - manifestparser == 1.1 15:52:28 INFO - mozInstall == 1.12 15:52:28 INFO - mozcrash == 0.17 15:52:28 INFO - mozdebug == 0.1 15:52:28 INFO - mozdevice == 0.48 15:52:28 INFO - mozfile == 1.2 15:52:28 INFO - mozhttpd == 0.7 15:52:28 INFO - mozinfo == 0.9 15:52:28 INFO - mozleak == 0.1 15:52:28 INFO - mozlog == 3.1 15:52:28 INFO - moznetwork == 0.27 15:52:28 INFO - mozprocess == 0.22 15:52:28 INFO - mozprofile == 0.28 15:52:28 INFO - mozrunner == 6.11 15:52:28 INFO - mozscreenshot == 0.1 15:52:28 INFO - mozsystemmonitor == 0.0 15:52:28 INFO - moztest == 0.7 15:52:28 INFO - mozversion == 1.4 15:52:28 INFO - psutil == 3.1.1 15:52:28 INFO - requests == 1.2.3 15:52:28 INFO - wsgiref == 0.1.2 15:52:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 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 0x105ca3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8d723a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, '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.E5D4ye9oOB/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.91a7VZFpuS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:52:28 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 15:52:28 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 15:52:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:52:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:28 INFO - 'HOME': '/Users/cltbld', 15:52:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:28 INFO - 'LOGNAME': 'cltbld', 15:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:28 INFO - 'MOZ_NO_REMOTE': '1', 15:52:28 INFO - 'NO_EM_RESTART': '1', 15:52:28 INFO - 'PAGER': '/bin/cat', 15:52:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:28 INFO - 'PWD': '/builds/slave/test', 15:52:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:28 INFO - 'SHELL': '/bin/bash', 15:52:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:52:28 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:52:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:28 INFO - 'USER': 'cltbld', 15:52:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:28 INFO - 'XPC_FLAGS': '0x0', 15:52:28 INFO - 'XPC_SERVICE_NAME': '0', 15:52:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 INFO - Cleaning up... 15:52:28 INFO - Return code: 0 15:52:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 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 0x105ca3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8d723a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, '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.E5D4ye9oOB/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.91a7VZFpuS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:52:28 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 15:52:28 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 15:52:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:52:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:28 INFO - 'HOME': '/Users/cltbld', 15:52:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:28 INFO - 'LOGNAME': 'cltbld', 15:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:28 INFO - 'MOZ_NO_REMOTE': '1', 15:52:28 INFO - 'NO_EM_RESTART': '1', 15:52:28 INFO - 'PAGER': '/bin/cat', 15:52:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:28 INFO - 'PWD': '/builds/slave/test', 15:52:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:28 INFO - 'SHELL': '/bin/bash', 15:52:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:52:28 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:52:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:28 INFO - 'USER': 'cltbld', 15:52:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:28 INFO - 'XPC_FLAGS': '0x0', 15:52:28 INFO - 'XPC_SERVICE_NAME': '0', 15:52:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:28 INFO - Downloading/unpacking jsonschema 15:52:28 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 15:52:28 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 15:52:28 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 15:52:28 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 15:52:28 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 15:52:28 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 15:52:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:35 INFO - Downloading/unpacking functools32 (from jsonschema) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:35 INFO - warning: no files found matching '*.txt' 15:52:35 INFO - no previously-included directories found matching 'build' 15:52:35 INFO - no previously-included directories found matching 'dist' 15:52:35 INFO - no previously-included directories found matching '.git*' 15:52:35 INFO - Installing collected packages: jsonschema, functools32 15:52:35 INFO - Running setup.py install for functools32 15:52:35 INFO - warning: no files found matching '*.txt' 15:52:35 INFO - no previously-included directories found matching 'build' 15:52:35 INFO - no previously-included directories found matching 'dist' 15:52:35 INFO - no previously-included directories found matching '.git*' 15:52:35 INFO - Successfully installed jsonschema functools32 15:52:35 INFO - Cleaning up... 15:52:35 INFO - Return code: 0 15:52:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:35 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 0x105ca3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8d723a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, '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.E5D4ye9oOB/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.91a7VZFpuS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:52:35 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 15:52:35 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 15:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:35 INFO - 'HOME': '/Users/cltbld', 15:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:35 INFO - 'LOGNAME': 'cltbld', 15:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:35 INFO - 'MOZ_NO_REMOTE': '1', 15:52:35 INFO - 'NO_EM_RESTART': '1', 15:52:35 INFO - 'PAGER': '/bin/cat', 15:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:35 INFO - 'PWD': '/builds/slave/test', 15:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:35 INFO - 'SHELL': '/bin/bash', 15:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:52:35 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:35 INFO - 'USER': 'cltbld', 15:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:35 INFO - 'XPC_FLAGS': '0x0', 15:52:35 INFO - 'XPC_SERVICE_NAME': '0', 15:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:36 INFO - Downloading/unpacking flake8 15:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:52:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:52:40 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 15:52:40 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 15:52:40 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 15:52:40 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 15:52:40 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 15:52:40 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 15:52:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:52:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:52:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:52:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:52:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:52:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:52:42 INFO - no previously-included directories found matching 'docs/_build' 15:52:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:52:42 INFO - Running setup.py install for pep8 15:52:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:52:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:52:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:52:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:52:42 INFO - no previously-included directories found matching 'docs/_build' 15:52:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:52:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:52:42 INFO - Cleaning up... 15:52:42 INFO - Return code: 0 15:52:42 INFO - Running post-action listener: _resource_record_post_action 15:52:42 INFO - Running post-action listener: _start_resource_monitoring 15:52:42 INFO - Starting resource monitoring. 15:52:42 INFO - ##### 15:52:42 INFO - ##### Running install step. 15:52:42 INFO - ##### 15:52:42 INFO - Running pre-action listener: _resource_record_pre_action 15:52:42 INFO - Running main action method: install 15:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:43 INFO - Reading from file tmpfile_stdout 15:52:43 INFO - Detecting whether we're running mozinstall >=1.0... 15:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:52:43 INFO - Reading from file tmpfile_stdout 15:52:43 INFO - Output received: 15:52:43 INFO - Usage: mozinstall [options] installer 15:52:43 INFO - Options: 15:52:43 INFO - -h, --help show this help message and exit 15:52:43 INFO - -d DEST, --destination=DEST 15:52:43 INFO - Directory to install application into. [default: 15:52:43 INFO - "/builds/slave/test"] 15:52:43 INFO - --app=APP Application being installed. [default: firefox] 15:52:43 INFO - mkdir: /builds/slave/test/build/application 15:52:43 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'] 15:52:43 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 15:53:17 INFO - Reading from file tmpfile_stdout 15:53:17 INFO - Output received: 15:53:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:53:17 INFO - Running post-action listener: _resource_record_post_action 15:53:17 INFO - ##### 15:53:17 INFO - ##### Running run-tests step. 15:53:17 INFO - ##### 15:53:17 INFO - Running pre-action listener: _resource_record_pre_action 15:53:17 INFO - Running main action method: run_tests 15:53:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:17 INFO - 2016-04-04 15:53:17.228 screenresolution[1648:7929] starting screenresolution argv=screenresolution get 15:53:17 INFO - 2016-04-04 15:53:17.231 screenresolution[1648:7929] Display 0: 1600x1200x32@60 15:53:17 INFO - 2016-04-04 15:53:17.237 screenresolution[1649:7931] starting screenresolution argv=screenresolution list 15:53:17 INFO - Available Modes on Display 0 15:53:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:17 INFO - Intel Iris: 15:53:17 INFO - Chipset Model: Intel Iris 15:53:17 INFO - Type: GPU 15:53:17 INFO - Bus: Built-In 15:53:17 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:17 INFO - Vendor: Intel (0x8086) 15:53:17 INFO - Device ID: 0x0a2e 15:53:17 INFO - Revision ID: 0x0009 15:53:17 INFO - Displays: 15:53:17 INFO - Display: 15:53:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:17 INFO - Display Serial Number: 1600x1200 60 15:53:17 INFO - Main Display: Yes 15:53:17 INFO - Mirror: Off 15:53:17 INFO - Online: Yes 15:53:17 INFO - Rotation: Supported 15:53:17 INFO - Return code: 0 15:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:17 INFO - Python 2.7.3 15:53:17 INFO - Return code: 0 15:53:17 INFO - grabbing minidump binary from tooltool 15:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:17 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 0x105b42e00>, '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 0x10596bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:17 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 15:53:17 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 15:53:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:17 INFO - Return code: 0 15:53:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:53:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:53:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:53:18 INFO - Return code: 0 15:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5D4ye9oOB/Render', 15:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:18 INFO - 'HOME': '/Users/cltbld', 15:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:18 INFO - 'LOGNAME': 'cltbld', 15:53:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:18 INFO - 'MOZ_NO_REMOTE': '1', 15:53:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:18 INFO - 'NO_EM_RESTART': '1', 15:53:18 INFO - 'PAGER': '/bin/cat', 15:53:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:18 INFO - 'PWD': '/builds/slave/test', 15:53:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:18 INFO - 'SHELL': '/bin/bash', 15:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.91a7VZFpuS/Listeners', 15:53:18 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:18 INFO - 'USER': 'cltbld', 15:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:18 INFO - 'XPC_FLAGS': '0x0', 15:53:18 INFO - 'XPC_SERVICE_NAME': '0', 15:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:53:18 INFO - mozversion application_buildid: 20160404144745 15:53:18 INFO - mozversion application_changeset: 8649e83a43b9c1fc271d43e50ade50966c7e94b9 15:53:18 INFO - mozversion application_display_name: Nightly 15:53:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:18 INFO - mozversion application_name: Firefox 15:53:18 INFO - mozversion application_remotingname: firefox 15:53:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:53:18 INFO - mozversion application_vendor: Mozilla 15:53:18 INFO - mozversion application_version: 48.0a1 15:53:18 INFO - mozversion platform_buildid: 20160404144745 15:53:18 INFO - mozversion platform_changeset: 8649e83a43b9c1fc271d43e50ade50966c7e94b9 15:53:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:53:18 INFO - mozversion platform_version: 48.0a1 15:53:18 INFO - using testdate: 1459810398 15:53:18 INFO - actual date: 1459810398 15:53:18 INFO - starting webserver on 'localhost:49279' 15:53:18 INFO - SUITE-START | Running 2 tests 15:53:18 INFO - TEST-START | dromaeo_css 15:53:18 INFO - operating with platform_type : mac_ 15:53:18 INFO - Initialising browser for dromaeo_css test... 15:53:18 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpwv5ukg/profile http://localhost:49279/getInfo.html) 15:53:21 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 15:53:21 INFO - PROCESS | 1667 | colorDepth:24 15:53:21 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 15:53:21 INFO - PROCESS | 1667 | __metrics 15:53:21 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:53:21 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:53:21 INFO - TEST-INFO | 1667: exit 0 15:53:21 INFO - Browser initialized. 15:53:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:53:21 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpwv5ukg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:33 INFO - PROCESS | 1670 | RSS: Main: 235868160 15:53:33 INFO - PROCESS | 1670 | 15:54:25 INFO - PROCESS | 1670 | 1459810465325 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] 15:56:35 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 15:56:37 INFO - PROCESS | 1670 | RSS: Main: 353009664 15:56:37 INFO - PROCESS | 1670 | 15:59:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 15:59:40 INFO - PROCESS | 1670 | RSS: Main: 355229696 15:59:40 INFO - PROCESS | 1670 | 16:02:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 16:02:42 INFO - PROCESS | 1670 | RSS: Main: 365023232 16:02:42 INFO - PROCESS | 1670 | 16:05:44 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 16:05:45 INFO - PROCESS | 1670 | RSS: Main: 322293760 16:05:45 INFO - PROCESS | 1670 | 16:08:48 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 16:08:48 INFO - PROCESS | 1670 | RSS: Main: 325349376 16:08:48 INFO - PROCESS | 1670 | 16:11:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 16:11:51 INFO - PROCESS | 1670 | RSS: Main: 372600832 16:11:51 INFO - PROCESS | 1670 | 16:11:51 INFO - PROCESS | 1670 | __start_tp_report 16:11:51 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 16:11:51 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 16:11:51 INFO - PROCESS | 1670 | |i|pagename|runs| 16:11:51 INFO - PROCESS | 1670 | |0;dojo.html;3126.140311414361;3422.178677117491;3445.965540344599;3477.078574177842;3498.0904964709166;5543.750531226095;5576.9999999999945;5586.972065139674;5605.5515558755305;5610.186522954169;5586.329640443142;5588.86027849303;5687.374388817227;5727.312722473299;5735.913961290574;4960.5039496050285;4972.129877271481;4979.900401991958;4999.625028122905;5147.934596811558;5170.353705786777;5191.766370513336;5213.765380557884;5242.18746094356;5251.343582052244;5021.07110184617;5117.769700363493;5123.871903202413;5128.2564028216075;5156.922646160292;5044.747762611854;5047.570956468705;5053.519915608048;5056.898862022739;5068;4982.277569752366;5036.395632524084;5037.748112594392;5039;5060.165072762989;5426.077566813651;5540.473655002808;5569.888602227973;5573.637713548606;5604.691741954191;6071.1803906472505;6080.179175811253;6096.766006996462;6099.969500152515;6100.694965251764;6091.238595175603;6219.813405597839;6224.470919971808;6248.3751624837605;6251.499880009588;5573.916391254134;5586.301712285965;5674.460926212003;5679.062954612484;5767.36558978512;5234.398044224887;5258.368995720538;6342.5243106767175;6345.270293916259;6361.141245931833;6016.338202797689;6016.729247183887;6022.909656355158;6027.7890273841085;6040.335563088057;6049.364816694272;6096.512279017668;6129.570930034944;6145.494353883327;6193.009118541012;6097.857415703;6103.30736498198;6111.591738512148;6120.9957324329725;6132.539076726543;6133.82435864808;6144.15675297409;6151.2618485781095;6151.7539298428455;6153.1693221415435;4750;4762.309465127537;4815.927761083586;4817.397825271841;4875.439324477659;4288.5711428857485;4291.785410729451;4309.095090031128;4329.675274354436;4383.649308055348;5549.667019978814;5623.437656234344;5635.042042852725;5640.125780504029;5645.68948707825;6187.81436556904;6196.566240363131;6223.906641400383;6228.564000520011;6237.438630523275;5520.806771763049;5524.861878453071;5580.2466666999435;5627.099664053731;5657;5246.422893481714;5281.815136470282;5286.392064912584;5287.471252874759;5289.18017707256;6147.016477363601;6317.810465686037;6321.810345689637;6325.873482530324;6347.777827776005;6113.816585502442;6128.28924408451;6136.519078024552;6142.003848749085;6148.4773794227995;6291.02489114188;6298.716557755004;6320.873582528232;6325.8734825304155;6339.2392912850755;5866.090755932837;5990.6705131218205;6041.24484439445;6055.878882422415;6067.696615169312;5956.5532585055425;6149.431894866781;6209.254889413119;6213.099100630293;6222.595531290452;5871.03127983895;5873.089671100986;5926.081457374114;5936.940630593639;5952.166696662557;5813.476787089182;5917.112433135064;5960.284765828128;5980.43185897339;6006.399360063959;5788.450097240755;5797.942020579909;5808.941910581009;5815.3893841147765;5853.180554722428;5961.701914904324;5988.730507127277;5998.520118390431;5999.100134979788;6002.789902353396;5679.091345384719;5751.884962300815;5797.565182611237;5809.680467574324;5862.355140934579 16:11:51 INFO - PROCESS | 1670 | |1;ext.html;573.9267569644762;583.3670467542718;592.9830340965244;598.3537779198466;640.1549954060641;38809.22381552371;39249.607503924955;39376.409353859715;39496.60503394965;39504.80247598765;40608.187836243254;41189.58810411895;41197.588024119825;41246.143923523436;41299.38050929239;9339.953300233507;9591.952040239825;9594.992525784797;9608.087231712976;9623.663171788989;9473.81052378952;9689.903100969006;9699.70900872975;9706.369086009423;9710.805783884318;8281.917180828175;9647.517624118802;9745.805083898318;9754;9756.463394513334;8365.07984121746;9622.56698448568;9666.226701863834;9713.757156071119;9735.951320243425;9563.617455301779;9709.320347575673;9718.805623887554;9722.659706910224;9730.562124704406;39211.607883921366;39689.80155099206;39720;39731.40402893959;39752.80741577757;2333.94165145871;2591.663083799113;2651.6552848129813;3193.584833971592;3388.203772113551;27572.034978775646;28870.566941495894;28883.133505994854;29304.681289341817;29656.851715741283;2701.2987012987014;2712.56598944168;2742.794290428226;2763.1434255380896;2824.5763135529837;424870;428949.7105028972;430225;430518;431625;65991.67004164949;66910.65446727644;66939;67072;67203;65487;66016;67529.32470675328;67587.31031724148;67605.64788704297;16487.422940197277;17051.573710657332;17093.145342732812;17102.657946841242;17108.973461592097;12977.286249256382;13017.088803783834;13091.869081309256;13099;13107.410166542528;19032.71450928237;19109.522261943563;19190.424287271406;19216.03919804004;19221.94279314651;7153.749618763319;8072.071711753106;8486.618102185417;8508.74473765788;8571.528565928933;899.8065415935474;978.500964508106;995.5022488755623;1040.9739756505996;1128.1729865246077;28583.857080714464;29291.853540732587;29490;29775.553366699518;30175.09474715718;1101.3942331717524;1110.9166812489095;1145.8682251541013;1150.7525881935424;1155.942202889869;12880.291583962971;15213.923930380277;15361.6159596011;15612.92193539025;15614.219289035504;645955;647856;654199;654361;654673;52277;59184.70407647934;59445;60045;60086.39913600808;1309.6660351610278;1330.8669133086614;1334.3795135261955;1477.062065588359;1590.1254310129382;25118.874405627856;29037.48983263841;31826.681733182373;32275.838620806746;32710.34579308353;52254;58117;58695.70652146712;58721.70639146777;58728;424426;426344;430244;431409;431506;42078;42468.57531424646;42630.57369426266;42749.786251068545;42840.14319713651;46935.53064469448;50669;51424.74287628538;51828.74085629699;53278;37865.242695146495;38129.61870381261;38333;38668.41997370098;39357.01607459837;37575.43636845504;37600.43599346067;37785.86642400733;38202;38876.416853746654;38090.428643569816;38510.2297954045;38837.22325553417;39092.21815563616;39129.41305880471;28512.57231141493;32917.67082329242;32933.34133317272;32961;33093.503597445575;24867.005319787007;24907.750922490544;24908.62637060409;25231.738413079638;25478.617820733074 16:11:51 INFO - PROCESS | 1670 | |2;jquery.html;358.20657244204085;359.71762166699136;360.922401683638;368.5025215958456;370.44248406148745;18600.906995465022;19532.804671953276;21008.684869726927;21017.894910525465;21034.789652103475;19866.304679336226;20334.59330813383;20942.16231350744;21215;21234;5817.7963771267905;5994.670293133876;6016.699165041752;6031.668258245794;6035.456808887199;5751.4536119068625;6017.217761690974;6023.879522409549;6033.185519954815;6085;5964.821055368346;5986.311574168983;5995.310539287994;6003.879922401549;6008.008678568031;5905.911411328812;5982.670953097578;6592.17597800275;6606.1412016438035;6608.339166083401;5768.192453056576;5781.017227071408;5785.884282314372;5801.53587712982;5802.47777700009;17172.914135429368;24423.877880610482;25246.747532524623;25407.61888571673;25455;2157.9892100539555;2255.041607316884;2314.0281081945623;2695.5821847613456;2725.931851703723;9500.809983800355;10121.949390253076;10330.535125919352;10332.79334413315;10355.068043876086;1636.811766646839;1698.2188193430914;1724.7499112628725;1734.2456031626282;1760.4542591796585;101628;101855.49072254666;102177.4891125547;104383;107265;8861;10841.457927103613;11166.218364714392;11332.376719280519;11334.149938754626;13779.448822047007;13878.375473103735;13948;13952.441902323793;13957.79063314051;8451.661933522713;8626.266767324847;8634.827303453896;8725.345599080094;8751.824963500694;8776.341774366949;8825.69110081144;8867.778305542413;8884.911150888538;8897.377183597215;4381.255186618282;4442.489113751895;4453.42105526286;4487.730736155841;4503.166914120898;1801.8468430183582;1856.8236017578308;1861.2275905499066;1895.7819850717344;1895.9431217063511;868.5961028121953;933.8319102561604;982.2976571751232;1011.2516737614112;1032.1691038713757;19463.902680486506;19875.801241987683;20044.69932951007;20065.59868802616;20366.490837729176;806.4072906413782;936.4240991790136;958.5063692198523;969.6266937229218;1024.7438140464883;7273.490855640161;10450.790984180274;10672;10684.839727404094;10876.945615271872;615709;632714;632879;639767.6023239801;661143;67373.66313168402;84818.15181848226;109137.45431272793;109627;113290;1005.4821766790109;1015.9542820573092;1047.1727335405096;1049.800537897797;1055.3562326980536;17675.91162044233;17867.821321787134;17928.103594819946;17999;18310.90844545822;34852;51455.74272128615;52338.47661523336;53312.20031699605;53680.926381472935;73732.36638187917;75035.24964750283;75243;77505;77716.61141694481;7456.254374562717;7629.2370762923265;7768.844623107393;7963.761087167394;8028.397870159644;11950.46222919988;12196.81704774447;12535.373231338213;12558.874411256136;12585.874141258837;10795.784084318113;10934;11033;11103.611373601885;11229.3262404256;10571.682849514527;10793.56825726962;10826.729331766768;11160.609378671708;11410.771784564096;10346.896531034594;10948.34309941406;11027.283226590567;11329.376884271443;11550;7864.331531819859;8113.594320283844;8123.8781418277595;8144.104148543537;8316.960379952507;9452.527373631428;11110.777784444428;11184.77832487735;11284.435778210893;11431.485583148611 16:11:51 INFO - PROCESS | 1670 | |3;mootools.html;1410.1257220523278;1570.8272090070093;1605.093122385852;1865.6828339182337;1992.1533348326957;7981.082175549814;8594.65621375145;8789.472631642106;8790.91209087909;8807.383483156182;8527.232549070583;8770.166834150745;8775.6050977706;8779.692710755126;8803.911960880389;2483.2922617054187;2518.8110891683104;2519.48350588129;2520.823542352036;2522.382016405974;2445.4497738008895;2514.7736703696664;2516.5973444248925;2520.596704527276;2528.2288901884917;2483.962740558893;2495.8128140389454;2500.987495062522;2531.708853481855;2534.556452620793;2489.751024897505;2510.1967370441466;2521.2562294123186;2530.4812513434704;2532.2909585316143;2456.091246238903;2484.95030099397;2493.812964027705;2494.326531836412;2521.873906304696;8817.559122043873;8868.822623547492;8873.822523549492;8877.201051905295;8884.600192991331;5398.64908780928;5564.972175139098;5570.526505247059;5574.665520068809;5580.888382232332;3502.964970350289;3509.6490350964955;3570.982145089284;3737.850485980585;3740.9438858417147;897.842877496442;1045.790841831629;1071.935683858971;1079.773247618001;1080.475969154959;11746.588869389616;11788.882111178864;11805.704857378549;11818;11818.940905295418;3911.8044097794996;4874.53691899269;4937.40751109862;4941.407031156285;5001.674891132065;9992.050755178247;10006.099451049295;10130.24023198263;10165.695029149138;10179.9491002546;5520.06158952979;5566.081596536526;5582.106862901916;5590.413006634245;5590.86022849432;4491.932621010687;4576.405067341224;4640.23671005016;4640.582347588733;5070.822521211814;3690.538682664667;3890.2219556088894;3904.3557812960544;3905.3946638271113;3908.1988192420486;1122.5902545570807;1317.1767645221737;1330.3946704249543;1335.706144648176;1344.1196016609138;1331.447449308526;1358.8165597644388;1362.843273023615;1365.6176270644235;1394.4004078246248;7922.7227047053075;8101.189881011969;8120.309773669304;8141.755747327471;8201.261886430131;1173.372245848484;1194.689380760991;1197.3713800254761;1202.2606097250127;1218;6248.125262463259;6277.7175027123885;6340.1440805490665;6361.4592759615025;6370.171877655967;10315.071643552117;10781.083607893417;10789.028987391173;10789.190810689073;10790.67627971162;10334.588392115518;10454.372737635766;10538.789224215472;10633.680989570325;10646;8277.62750676221;8383.496990180609;8425.831483370299;8427.578621068922;8458.534780587126;7671.309582137635;7835.294823465915;7906.130325664288;7907.604619768874;7923.960380198062;9252;9563.474008929576;9580.281478888972;9612.75968100803;9734.659286925207;9710.660126895526;9868.654597089067;9932;10024;10028.498575071364;7153.535020223669;7468.253174682488;7476.102867655916;7550.093988721169;7556.962215188889;7569.205233450409;7777.494462859896;8069.475484093515;8266.380021498531;8282.751517454486;7292.453066020176;7306.3789577884345;7313.378362839218;7346.77959661211;7496.7750967471065;7173.569585824867;7185.604791736296;7266.309700578437;7320;7330.523515971445;6559.0817285579105;7665.348445382205;7670.893288218281;7743.186965368781;7794.961025194838;6893.965530172317;6939.167299924042;6960.199577048705;7017.2631873652535;7028.753993610199;7001.054857594159;7078;7101.680424380812;7113.82215444618;7158.534695244793 16:11:51 INFO - PROCESS | 1670 | |4;prototype.html;270.56979402749624;324.98050116992965;330.73375932374444;332.4116314124002;337.92058866166434;6551.836204094894;6568.441682456985;6604.834879128024;6605;6692.799216023515;6593.769218077368;6611;6611.4380277676455;6621.304762999888;6623.867522649544;4006.95819087038;4506.256467682829;4734.479207287196;4818.277258411232;4846.321514987904;4792.976035119819;4825.7587120644;4829.7585120744;4838.927416088762;4845.854624361275;4770.904581908359;4779.378680771495;4784.521547845205;4785.019071090418;4786.7075889509815;3996.3406038003986;4584.381108550353;4645.233536466496;4715;4769.761511924425;4075.9388609170887;4080.2655522006025;4091.89770255743;4092.1201941582403;4105.34314509677;5170.45710200431;6166.691665416712;6196.442320191204;6226.657533835637;6309.495240380758;5684.289463817023;5686.687232202227;5689.857753556194;5696.743646535874;5711.029125048752;5647.745851436695;7011.193712723051;7019.192792828788;7019.298070192991;7041.683124259421;4353.499347575006;4520.367148599199;4526.366308716782;4538.410006699108;4545.159145558082;6516.543841931067;6815.114035175445;7432.442566807457;7432.69586428209;7437.107547094329;4607.424071991001;4611.953880461152;4613.192691279013;4624.468186158568;4625.542953969489;4655;4658.580727734452;4659.790309436084;4661.650376221797;4673.158831410379;5547.639403438763;5564.527015203753;5573.637713548687;5574.968630803314;5577.525910297589;5998.580099393001;6873.48448866337;6938.202106757686;7050.717971281194;7105.502614817016;1596.6327744618802;1599.7760313556112;1620.262780434923;1621.505440840555;1623.63614563767;970.9805803883883;992.0426788149471;1019.2661283875598;1024.9590016399409;1045.038564520643;6562.278149403562;6663.167104111986;6665.200175978914;6671.299513551105;6723.798286051427;7382.18795932447;7402.222766609536;7406.7037318506655;7411.332980031823;7432.033835601337;5482.616216864861;6697.229818570927;6705.56413833109;6720.798376048726;6734;3188.56954311165;3853.0174805424435;3877.8448862045766;3886.6502014818802;3903.9609603903596;6479.935200648028;7448.590327532038;7688.500247483896;7774.766756997299;7815.57014364204;6148.723307451175;7581.696732130763;7646.158922518519;7654.119776225694;7674.155842857282;7784.610769461504;7789.883151752728;7789.922100779033;7799.142094369615;7800.531968081933;7175.677094530863;7358.705651773869;7402.703891844481;7412.925870741224;7416.147143078615;6515;6768.695408706521;7206.639668016683;7253.202147763847;7284.162321332902;7568.886466702894;7739.419543534144;7751.651175696994;7769.805754855947;7781.766547003373;3871.341871881843;4656.3946686930485;4657.068586282825;4658.67389282747;4670.813167473263;6009.639421634716;7084.610346430995;7321.707131714885;7334.376577990717;7335.046443962251;7084.397826184626;7099.538529995534;7103.396211322096;7105.076340075757;7105.2894710528535;7021.403180729695;7094.574325540484;7095.538789978635;7095.645217738989;7101.538400003983;6923.134608173978;6929.792106236821;6933.791986240421;6933.930660693329;6935.445164386938;6834.316568343126;7103.893441598483;7104.005439238614;7125.038119853753;7131.607761573163;6673.833154171185;6778.084958530535;6823.590584564942;6891.104156459628;6960.582365058112 16:11:51 INFO - PROCESS | 1670 | |5;yui.html;684.1209046375407;709.2623671381766;715.3275920634603;750.9061367329082;799.7200979657117;14752.926235368821;14980.5505834825;16927.153642317895;17279.963202207877;17282.740758888627;15818.446354377598;15868.968517046384;15888.967217130878;15890.84109158908;15891;737.4763917618498;902.440486898124;926.4441335198894;928.2944961828991;929.9581518831669;732.3482100930177;901.3014913442101;920.3695468604028;922.2529750901757;925.2690374604055;966.840471322231;972.4505654305295;973.6300205921775;975.0493269062642;976.379998700823;768.2087449926585;967.0957654592978;967.4678926590383;968.9903100969005;969.7381706939087;698.3958875572644;711.1288671377573;711.1927961763384;714.139461948351;715.0704084689883;14899.702005959929;14953.925230373887;14994.800415966696;15027.323770430357;15044.172570508617;12148.574799881962;12198;12216;12320.383980801014;12473.189242699196;9785.363951343212;9810.607575696964;10012.148967337713;10121;10256;3447.3450044491465;3481.599616044162;3485.3900567400856;3488.7034602058857;3575.66031227033;71450;71740.95626612278;72728.6363568184;72886.99999999948;73317.53364932725;9162.954185229164;9272.35093543459;9313.764696472934;9682.515874206261;9824.11582957523;20522;20523.897380513;20543.280985165748;20560.177592896416;20575.485612859797;7338.816529586697;7359.852802943911;7575.734849280248;7664.770056898302;7755.844883102306;3713.9442908356395;4038;4049.4128351388886;4125.278076336689;4199.181159673895;3577.695895848882;3638.272345530904;3641.417373220325;3647.1429214134655;3673.81630918453;622.1383384013084;635.6142615949982;645.0872016097263;654.5810681164058;666.6133642487442;470.1889241059214;535.3976776126857;557.6041010882238;573.4007961680054;620.8075496596069;7621.733239336597;7858.0963189232825;7933.246341597539;8022.598870056474;8198;519.4000928927095;529.0846834975514;545.6944111297686;568.7867049856304;602.7347966894553;3591.586967498719;3654.470101835219;3669.614690457517;3892.2410130024373;3932.3315036443873;86180.27639447176;86976;86984;90195;90393.54803226073;54845.45154548404;70584;71258.64370678113;75298;76069.47861042859;61984.69007654933;62351;65170.67414662896;65583;68192.63614727677;7515.210902855121;7540.698372065056;7573;7615.504992175491;7646.617669116633;46657.76804595293;46795.76602116968;47639.76180119077;48194.75902620464;48208.758956205;63939;66235;66540;66930;67437.6628116876;9632.662856799978;9761.804763904824;9968.55141518619;10119.342242754197;10231;10615.840762388725;10646.946765266124;10716.624918127829;10908;10954.780904381709;9981.850272245776;10123.24075694311;10163.7459063524;10499.737506562396;10542.314749541256;10191.694249172537;10206.744831379276;10337.534810933375;10585.788284234426;10811;9455;9526.952365238129;9553.761155971157;9558.90441095608;9574.808503830023;6923.619200943795;8365.916340836513;8610.870836937325;8705.085965973482;8845.557722113997;8664.35017373687;8704.651813927625;8787.560621968749;8854;8898.154675305836 16:11:51 INFO - PROCESS | 1670 | __end_tp_report 16:11:51 INFO - PROCESS | 1670 | __start_cc_report 16:11:51 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1121 16:11:51 INFO - PROCESS | 1670 | __end_cc_report 16:11:51 INFO - PROCESS | 1670 | __startTimestamp1459811511717__endTimestamp 16:11:51 INFO - PROCESS | 1670 | 16:11:51 INFO - PROCESS | 1670 | ------- Summary: start ------- 16:11:51 INFO - PROCESS | 1670 | Number of tests: 6 16:11:51 INFO - PROCESS | 1670 | 16:11:51 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5637.01 Median:5808.94 stddev:634.91 (10.9%) stddev-sans-first:605.53 16:11:51 INFO - PROCESS | 1670 | Values: 3126.1 3422.2 3446.0 3477.1 3498.1 5543.8 5577.0 5587.0 5605.6 5610.2 5586.3 5588.9 5687.4 5727.3 5735.9 4960.5 4972.1 4979.9 4999.6 5147.9 5170.4 5191.8 5213.8 5242.2 5251.3 5021.1 5117.8 5123.9 5128.3 5156.9 5044.7 5047.6 5053.5 5056.9 5068.0 4982.3 5036.4 5037.7 5039.0 5060.2 5426.1 5540.5 5569.9 5573.6 5604.7 6071.2 6080.2 6096.8 6100.0 6100.7 6091.2 6219.8 6224.5 6248.4 6251.5 5573.9 5586.3 5674.5 5679.1 5767.4 5234.4 5258.4 6342.5 6345.3 6361.1 6016.3 6016.7 6022.9 6027.8 6040.3 6049.4 6096.5 6129.6 6145.5 6193.0 6097.9 6103.3 6111.6 6121.0 6132.5 6133.8 6144.2 6151.3 6151.8 6153.2 4750.0 4762.3 4815.9 4817.4 4875.4 4288.6 4291.8 4309.1 4329.7 4383.6 5549.7 5623.4 5635.0 5640.1 5645.7 6187.8 6196.6 6223.9 6228.6 6237.4 5520.8 5524.9 5580.2 5627.1 5657.0 5246.4 5281.8 5286.4 5287.5 5289.2 6147.0 6317.8 6321.8 6325.9 6347.8 6113.8 6128.3 6136.5 6142.0 6148.5 6291.0 6298.7 6320.9 6325.9 6339.2 5866.1 5990.7 6041.2 6055.9 6067.7 5956.6 6149.4 6209.3 6213.1 6222.6 5871.0 5873.1 5926.1 5936.9 5952.2 5813.5 5917.1 5960.3 5980.4 6006.4 5788.5 5797.9 5808.9 5815.4 5853.2 5961.7 5988.7 5998.5 5999.1 6002.8 5679.1 5751.9 5797.6 5809.7 5862.4 16:11:51 INFO - PROCESS | 1670 | 16:11:51 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:65629.33 Median:39742.11 stddev:137061.09 (344.9%) stddev-sans-first:137358.55 16:11:51 INFO - PROCESS | 1670 | Values: 573.9 583.4 593.0 598.4 640.2 38809.2 39249.6 39376.4 39496.6 39504.8 40608.2 41189.6 41197.6 41246.1 41299.4 9340.0 9592.0 9595.0 9608.1 9623.7 9473.8 9689.9 9699.7 9706.4 9710.8 8281.9 9647.5 9745.8 9754.0 9756.5 8365.1 9622.6 9666.2 9713.8 9736.0 9563.6 9709.3 9718.8 9722.7 9730.6 39211.6 39689.8 39720.0 39731.4 39752.8 2333.9 2591.7 2651.7 3193.6 3388.2 27572.0 28870.6 28883.1 29304.7 29656.9 2701.3 2712.6 2742.8 2763.1 2824.6 424870.0 428949.7 430225.0 430518.0 431625.0 65991.7 66910.7 66939.0 67072.0 67203.0 65487.0 66016.0 67529.3 67587.3 67605.6 16487.4 17051.6 17093.1 17102.7 17109.0 12977.3 13017.1 13091.9 13099.0 13107.4 19032.7 19109.5 19190.4 19216.0 19221.9 7153.7 8072.1 8486.6 8508.7 8571.5 899.8 978.5 995.5 1041.0 1128.2 28583.9 29291.9 29490.0 29775.6 30175.1 1101.4 1110.9 1145.9 1150.8 1155.9 12880.3 15213.9 15361.6 15612.9 15614.2 645955.0 647856.0 654199.0 654361.0 654673.0 52277.0 59184.7 59445.0 60045.0 60086.4 1309.7 1330.9 1334.4 1477.1 1590.1 25118.9 29037.5 31826.7 32275.8 32710.3 52254.0 58117.0 58695.7 58721.7 58728.0 424426.0 426344.0 430244.0 431409.0 431506.0 42078.0 42468.6 42630.6 42749.8 42840.1 46935.5 50669.0 51424.7 51828.7 53278.0 37865.2 38129.6 38333.0 38668.4 39357.0 37575.4 37600.4 37785.9 38202.0 38876.4 38090.4 38510.2 38837.2 39092.2 39129.4 28512.6 32917.7 32933.3 32961.0 33093.5 24867.0 24907.8 24908.6 25231.7 25478.6 16:11:51 INFO - PROCESS | 1670 | 16:11:51 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:34509.91 Median:13368.95 stddev:105013.93 (785.5%) stddev-sans-first:105277.21 16:11:51 INFO - PROCESS | 1670 | Values: 358.2 359.7 360.9 368.5 370.4 18600.9 19532.8 21008.7 21017.9 21034.8 19866.3 20334.6 20942.2 21215.0 21234.0 5817.8 5994.7 6016.7 6031.7 6035.5 5751.5 6017.2 6023.9 6033.2 6085.0 5964.8 5986.3 5995.3 6003.9 6008.0 5905.9 5982.7 6592.2 6606.1 6608.3 5768.2 5781.0 5785.9 5801.5 5802.5 17172.9 24423.9 25246.7 25407.6 25455.0 2158.0 2255.0 2314.0 2695.6 2725.9 9500.8 10121.9 10330.5 10332.8 10355.1 1636.8 1698.2 1724.7 1734.2 1760.5 101628.0 101855.5 102177.5 104383.0 107265.0 8861.0 10841.5 11166.2 11332.4 11334.1 13779.4 13878.4 13948.0 13952.4 13957.8 8451.7 8626.3 8634.8 8725.3 8751.8 8776.3 8825.7 8867.8 8884.9 8897.4 4381.3 4442.5 4453.4 4487.7 4503.2 1801.8 1856.8 1861.2 1895.8 1895.9 868.6 933.8 982.3 1011.3 1032.2 19463.9 19875.8 20044.7 20065.6 20366.5 806.4 936.4 958.5 969.6 1024.7 7273.5 10450.8 10672.0 10684.8 10876.9 615709.0 632714.0 632879.0 639767.6 661143.0 67373.7 84818.2 109137.5 109627.0 113290.0 1005.5 1016.0 1047.2 1049.8 1055.4 17675.9 17867.8 17928.1 17999.0 18310.9 34852.0 51455.7 52338.5 53312.2 53680.9 73732.4 75035.2 75243.0 77505.0 77716.6 7456.3 7629.2 7768.8 7963.8 8028.4 11950.5 12196.8 12535.4 12558.9 12585.9 10795.8 10934.0 11033.0 11103.6 11229.3 10571.7 10793.6 10826.7 11160.6 11410.8 10346.9 10948.3 11027.3 11329.4 11550.0 7864.3 8113.6 8123.9 8144.1 8317.0 9452.5 11110.8 11184.8 11284.4 11431.5 16:11:51 INFO - PROCESS | 1670 | 16:11:51 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6058.51 Median:5459.36 stddev:3154.79 (57.8%) stddev-sans-first:3144.29 16:11:51 INFO - PROCESS | 1670 | Values: 1410.1 1570.8 1605.1 1865.7 1992.2 7981.1 8594.7 8789.5 8790.9 8807.4 8527.2 8770.2 8775.6 8779.7 8803.9 2483.3 2518.8 2519.5 2520.8 2522.4 2445.4 2514.8 2516.6 2520.6 2528.2 2484.0 2495.8 2501.0 2531.7 2534.6 2489.8 2510.2 2521.3 2530.5 2532.3 2456.1 2485.0 2493.8 2494.3 2521.9 8817.6 8868.8 8873.8 8877.2 8884.6 5398.6 5565.0 5570.5 5574.7 5580.9 3503.0 3509.6 3571.0 3737.9 3740.9 897.8 1045.8 1071.9 1079.8 1080.5 11746.6 11788.9 11805.7 11818.0 11818.9 3911.8 4874.5 4937.4 4941.4 5001.7 9992.1 10006.1 10130.2 10165.7 10179.9 5520.1 5566.1 5582.1 5590.4 5590.9 4491.9 4576.4 4640.2 4640.6 5070.8 3690.5 3890.2 3904.4 3905.4 3908.2 1122.6 1317.2 1330.4 1335.7 1344.1 1331.4 1358.8 1362.8 1365.6 1394.4 7922.7 8101.2 8120.3 8141.8 8201.3 1173.4 1194.7 1197.4 1202.3 1218.0 6248.1 6277.7 6340.1 6361.5 6370.2 10315.1 10781.1 10789.0 10789.2 10790.7 10334.6 10454.4 10538.8 10633.7 10646.0 8277.6 8383.5 8425.8 8427.6 8458.5 7671.3 7835.3 7906.1 7907.6 7924.0 9252.0 9563.5 9580.3 9612.8 9734.7 9710.7 9868.7 9932.0 10024.0 10028.5 7153.5 7468.3 7476.1 7550.1 7557.0 7569.2 7777.5 8069.5 8266.4 8282.8 7292.5 7306.4 7313.4 7346.8 7496.8 7173.6 7185.6 7266.3 7320.0 7330.5 6559.1 7665.3 7670.9 7743.2 7795.0 6894.0 6939.2 6960.2 7017.3 7028.8 7001.1 7078.0 7101.7 7113.8 7158.5 16:11:51 INFO - PROCESS | 1670 | 16:11:51 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5726.30 Median:6604.92 stddev:1869.88 (28.3%) stddev-sans-first:1829.74 16:11:51 INFO - PROCESS | 1670 | Values: 270.6 325.0 330.7 332.4 337.9 6551.8 6568.4 6604.8 6605.0 6692.8 6593.8 6611.0 6611.4 6621.3 6623.9 4007.0 4506.3 4734.5 4818.3 4846.3 4793.0 4825.8 4829.8 4838.9 4845.9 4770.9 4779.4 4784.5 4785.0 4786.7 3996.3 4584.4 4645.2 4715.0 4769.8 4075.9 4080.3 4091.9 4092.1 4105.3 5170.5 6166.7 6196.4 6226.7 6309.5 5684.3 5686.7 5689.9 5696.7 5711.0 5647.7 7011.2 7019.2 7019.3 7041.7 4353.5 4520.4 4526.4 4538.4 4545.2 6516.5 6815.1 7432.4 7432.7 7437.1 4607.4 4612.0 4613.2 4624.5 4625.5 4655.0 4658.6 4659.8 4661.7 4673.2 5547.6 5564.5 5573.6 5575.0 5577.5 5998.6 6873.5 6938.2 7050.7 7105.5 1596.6 1599.8 1620.3 1621.5 1623.6 971.0 992.0 1019.3 1025.0 1045.0 6562.3 6663.2 6665.2 6671.3 6723.8 7382.2 7402.2 7406.7 7411.3 7432.0 5482.6 6697.2 6705.6 6720.8 6734.0 3188.6 3853.0 3877.8 3886.7 3904.0 6479.9 7448.6 7688.5 7774.8 7815.6 6148.7 7581.7 7646.2 7654.1 7674.2 7784.6 7789.9 7789.9 7799.1 7800.5 7175.7 7358.7 7402.7 7412.9 7416.1 6515.0 6768.7 7206.6 7253.2 7284.2 7568.9 7739.4 7751.7 7769.8 7781.8 3871.3 4656.4 4657.1 4658.7 4670.8 6009.6 7084.6 7321.7 7334.4 7335.0 7084.4 7099.5 7103.4 7105.1 7105.3 7021.4 7094.6 7095.5 7095.6 7101.5 6923.1 6929.8 6933.8 6933.9 6935.4 6834.3 7103.9 7104.0 7125.0 7131.6 6673.8 6778.1 6823.6 6891.1 6960.6 16:11:51 INFO - PROCESS | 1670 | 16:11:51 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:17242.51 Median:33603.31 stddev:23904.63 (71.1%) stddev-sans-first:23939.35 16:11:51 INFO - PROCESS | 1670 | Values: 684.1 709.3 715.3 750.9 799.7 14752.9 14980.6 16927.2 17280.0 17282.7 15818.4 15869.0 15889.0 15890.8 15891.0 737.5 902.4 926.4 928.3 930.0 732.3 901.3 920.4 922.3 925.3 966.8 972.5 973.6 975.0 976.4 768.2 967.1 967.5 969.0 969.7 698.4 711.1 711.2 714.1 715.1 14899.7 14953.9 14994.8 15027.3 15044.2 12148.6 12198.0 12216.0 12320.4 12473.2 9785.4 9810.6 10012.1 10121.0 10256.0 3447.3 3481.6 3485.4 3488.7 3575.7 71450.0 71741.0 72728.6 72887.0 73317.5 9163.0 9272.4 9313.8 9682.5 9824.1 20522.0 20523.9 20543.3 20560.2 20575.5 7338.8 7359.9 7575.7 7664.8 7755.8 3713.9 4038.0 4049.4 4125.3 4199.2 3577.7 3638.3 3641.4 3647.1 3673.8 622.1 635.6 645.1 654.6 666.6 470.2 535.4 557.6 573.4 620.8 7621.7 7858.1 7933.2 8022.6 8198.0 519.4 529.1 545.7 568.8 602.7 3591.6 3654.5 3669.6 3892.2 3932.3 86180.3 86976.0 86984.0 90195.0 90393.5 54845.5 70584.0 71258.6 75298.0 76069.5 61984.7 62351.0 65170.7 65583.0 68192.6 7515.2 7540.7 7573.0 7615.5 7646.6 46657.8 46795.8 47639.8 48194.8 48208.8 63939.0 66235.0 66540.0 66930.0 67437.7 9632.7 9761.8 9968.6 10119.3 10231.0 10615.8 10646.9 10716.6 10908.0 10954.8 9981.9 10123.2 10163.7 10499.7 10542.3 10191.7 10206.7 10337.5 10585.8 10811.0 9455.0 9527.0 9553.8 9558.9 9574.8 6923.6 8365.9 8610.9 8705.1 8845.6 8664.4 8704.7 8787.6 8854.0 8898.2 16:11:51 INFO - PROCESS | 1670 | -------- Summary: end -------- 16:11:51 INFO - PROCESS | 1670 | 16:11:52 INFO - TEST-INFO | 1670: exit 0 16:11:52 INFO - TEST-OK | dromaeo_css | took 1113219ms 16:11:52 INFO - TEST-START | kraken 16:11:52 INFO - operating with platform_type : mac_ 16:11:52 INFO - Initialising browser for kraken test... 16:11:52 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmp2cn1n1/profile http://localhost:49279/getInfo.html) 16:11:54 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 16:11:54 INFO - PROCESS | 1675 | colorDepth:24 16:11:54 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 16:11:54 INFO - PROCESS | 1675 | __metrics 16:11:54 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:11:54 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:11:55 INFO - TEST-INFO | 1675: exit 0 16:11:55 INFO - Browser initialized. 16:11:55 INFO - Running cycle 1/1 for kraken test... 16:11:55 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmp2cn1n1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:07 INFO - PROCESS | 1677 | RSS: Main: 236077056 16:12:07 INFO - PROCESS | 1677 | 16:12:09 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:10 INFO - PROCESS | 1677 | RSS: Main: 281698304 16:12:10 INFO - PROCESS | 1677 | 16:12:12 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 16:12:13 INFO - PROCESS | 1677 | RSS: Main: 291950592 16:12:13 INFO - PROCESS | 1677 | 16:12:16 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 16:12:17 INFO - PROCESS | 1677 | RSS: Main: 277413888 16:12:17 INFO - PROCESS | 1677 | 16:12:19 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 16:12:20 INFO - PROCESS | 1677 | RSS: Main: 279834624 16:12:20 INFO - PROCESS | 1677 | 16:12:22 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:22 INFO - PROCESS | 1677 | RSS: Main: 280322048 16:12:22 INFO - PROCESS | 1677 | 16:12:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:26 INFO - PROCESS | 1677 | RSS: Main: 280203264 16:12:26 INFO - PROCESS | 1677 | 16:12:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:29 INFO - PROCESS | 1677 | RSS: Main: 280305664 16:12:29 INFO - PROCESS | 1677 | 16:12:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 16:12:32 INFO - PROCESS | 1677 | RSS: Main: 280797184 16:12:32 INFO - PROCESS | 1677 | 16:12:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:34 INFO - PROCESS | 1677 | RSS: Main: 315228160 16:12:34 INFO - PROCESS | 1677 | 16:12:36 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:37 INFO - PROCESS | 1677 | RSS: Main: 314486784 16:12:37 INFO - PROCESS | 1677 | 16:12:39 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:40 INFO - PROCESS | 1677 | RSS: Main: 322433024 16:12:40 INFO - PROCESS | 1677 | 16:12:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:43 INFO - PROCESS | 1677 | RSS: Main: 323330048 16:12:43 INFO - PROCESS | 1677 | 16:12:45 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:46 INFO - PROCESS | 1677 | RSS: Main: 323080192 16:12:46 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 16:12:48 INFO - PROCESS | 1677 | RSS: Main: 386879488 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | __start_tp_report 16:12:48 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 16:12:48 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 16:12:48 INFO - PROCESS | 1677 | |i|pagename|runs| 16:12:48 INFO - PROCESS | 1677 | |0;ai-astar;111;108;110;110;110;111;115;113;109;110 16:12:48 INFO - PROCESS | 1677 | |1;audio-beat-detection;159;121;144;161;120;145;140;120;161;121 16:12:48 INFO - PROCESS | 1677 | |2;audio-dft;187;185;183;185;184;187;183;183;195;255 16:12:48 INFO - PROCESS | 1677 | |3;audio-fft;74;75;84;82;58;58;59;79;105;55 16:12:48 INFO - PROCESS | 1677 | |4;audio-oscillator;94;96;131;77;78;83;115;80;79;117 16:12:48 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;85;87;86;87;84;90;85;87;84 16:12:48 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;92;93;93;92;91;93;93;92;92 16:12:48 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;86;84;85;86;87;85;84;84;84 16:12:48 INFO - PROCESS | 1677 | |8;json-parse-financial;54;52;53;54;53;43;42;64;59;75 16:12:48 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;65;64;73;78;70;70;67;68;70;68 16:12:48 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;84;83;83;81;83;83;84;83;84;85 16:12:48 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;134;126;115;134;111;126;135;134;121;121 16:12:48 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;140;129;142;141;141;129;144;141;141;139 16:12:48 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;68;69;64;67;68;68;67;69;66;66 16:12:48 INFO - PROCESS | 1677 | __end_tp_report 16:12:48 INFO - PROCESS | 1677 | __start_cc_report 16:12:48 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1273 16:12:48 INFO - PROCESS | 1677 | __end_cc_report 16:12:48 INFO - PROCESS | 1677 | __startTimestamp1459811568275__endTimestamp 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | ------- Summary: start ------- 16:12:48 INFO - PROCESS | 1677 | Number of tests: 14 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:110.70 Median:110.50 stddev:2.00 (1.8%) stddev-sans-first:2.12 16:12:48 INFO - PROCESS | 1677 | Values: 111.0 108.0 110.0 110.0 110.0 111.0 115.0 113.0 109.0 110.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:144.50 stddev:17.64 (12.2%) stddev-sans-first:17.19 16:12:48 INFO - PROCESS | 1677 | Values: 159.0 121.0 144.0 161.0 120.0 145.0 140.0 120.0 161.0 121.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:192.70 Median:186.00 stddev:22.18 (11.9%) stddev-sans-first:23.43 16:12:48 INFO - PROCESS | 1677 | Values: 187.0 185.0 183.0 185.0 184.0 187.0 183.0 183.0 195.0 255.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:72.90 Median:74.50 stddev:15.77 (21.2%) stddev-sans-first:16.72 16:12:48 INFO - PROCESS | 1677 | Values: 74.0 75.0 84.0 82.0 58.0 58.0 59.0 79.0 105.0 55.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:79.50 stddev:19.49 (24.5%) stddev-sans-first:20.67 16:12:48 INFO - PROCESS | 1677 | Values: 94.0 96.0 131.0 77.0 78.0 83.0 115.0 80.0 79.0 117.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.89 (2.2%) stddev-sans-first:1.90 16:12:48 INFO - PROCESS | 1677 | Values: 88.0 85.0 87.0 86.0 87.0 84.0 90.0 85.0 87.0 84.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 16:12:48 INFO - PROCESS | 1677 | Values: 93.0 92.0 93.0 93.0 92.0 91.0 93.0 93.0 92.0 92.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.05 (1.2%) stddev-sans-first:1.12 16:12:48 INFO - PROCESS | 1677 | Values: 85.0 86.0 84.0 85.0 86.0 87.0 85.0 84.0 84.0 84.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:9.60 (17.8%) stddev-sans-first:10.17 16:12:48 INFO - PROCESS | 1677 | Values: 54.0 52.0 53.0 54.0 53.0 43.0 42.0 64.0 59.0 75.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:70.00 stddev:4.03 (5.8%) stddev-sans-first:3.96 16:12:48 INFO - PROCESS | 1677 | Values: 65.0 64.0 73.0 78.0 70.0 70.0 67.0 68.0 70.0 68.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:1.06 (1.3%) stddev-sans-first:1.09 16:12:48 INFO - PROCESS | 1677 | Values: 84.0 83.0 83.0 81.0 83.0 83.0 84.0 83.0 84.0 85.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:130.00 stddev:8.62 (6.6%) stddev-sans-first:8.60 16:12:48 INFO - PROCESS | 1677 | Values: 134.0 126.0 115.0 134.0 111.0 126.0 135.0 134.0 121.0 121.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.70 Median:141.00 stddev:5.27 (3.7%) stddev-sans-first:5.57 16:12:48 INFO - PROCESS | 1677 | Values: 140.0 129.0 142.0 141.0 141.0 129.0 144.0 141.0 141.0 139.0 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.55 (2.3%) stddev-sans-first:1.62 16:12:48 INFO - PROCESS | 1677 | Values: 68.0 69.0 64.0 67.0 68.0 68.0 67.0 69.0 66.0 66.0 16:12:48 INFO - PROCESS | 1677 | -------- Summary: end -------- 16:12:48 INFO - PROCESS | 1677 | 16:12:48 INFO - TEST-INFO | 1677: exit 0 16:12:48 INFO - TEST-OK | kraken | took 56771ms 16:12:48 INFO - SUITE-END | took 1169s 16:12:49 INFO - Completed test suite (00:19:30) 16:12:49 INFO - javascript benchmark 16:12:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3126.140311414361, 3422.178677117491, 3445.965540344599, 3477.078574177842, 3498.0904964709166, 5543.750531226095, 5576.9999999999945, 5586.972065139674, 5605.5515558755305, 5610.186522954169, 5586.329640443142, 5588.86027849303, 5687.374388817227, 5727.312722473299, 5735.913961290574, 4960.5039496050285, 4972.129877271481, 4979.900401991958, 4999.625028122905, 5147.934596811558, 5170.353705786777, 5191.766370513336, 5213.765380557884, 5242.18746094356, 5251.343582052244, 5021.07110184617, 5117.769700363493, 5123.871903202413, 5128.2564028216075, 5156.922646160292, 5044.747762611854, 5047.570956468705, 5053.519915608048, 5056.898862022739, 5068.0, 4982.277569752366, 5036.395632524084, 5037.748112594392, 5039.0, 5060.165072762989, 5426.077566813651, 5540.473655002808, 5569.888602227973, 5573.637713548606, 5604.691741954191, 6071.1803906472505, 6080.179175811253, 6096.766006996462, 6099.969500152515, 6100.694965251764, 6091.238595175603, 6219.813405597839, 6224.470919971808, 6248.3751624837605, 6251.499880009588, 5573.916391254134, 5586.301712285965, 5674.460926212003, 5679.062954612484, 5767.36558978512, 5234.398044224887, 5258.368995720538, 6342.5243106767175, 6345.270293916259, 6361.141245931833, 6016.338202797689, 6016.729247183887, 6022.909656355158, 6027.7890273841085, 6040.335563088057, 6049.364816694272, 6096.512279017668, 6129.570930034944, 6145.494353883327, 6193.009118541012, 6097.857415703, 6103.30736498198, 6111.591738512148, 6120.9957324329725, 6132.539076726543, 6133.82435864808, 6144.15675297409, 6151.2618485781095, 6151.7539298428455, 6153.1693221415435, 4750.0, 4762.309465127537, 4815.927761083586, 4817.397825271841, 4875.439324477659, 4288.5711428857485, 4291.785410729451, 4309.095090031128, 4329.675274354436, 4383.649308055348, 5549.667019978814, 5623.437656234344, 5635.042042852725, 5640.125780504029, 5645.68948707825, 6187.81436556904, 6196.566240363131, 6223.906641400383, 6228.564000520011, 6237.438630523275, 5520.806771763049, 5524.861878453071, 5580.2466666999435, 5627.099664053731, 5657.0, 5246.422893481714, 5281.815136470282, 5286.392064912584, 5287.471252874759, 5289.18017707256, 6147.016477363601, 6317.810465686037, 6321.810345689637, 6325.873482530324, 6347.777827776005, 6113.816585502442, 6128.28924408451, 6136.519078024552, 6142.003848749085, 6148.4773794227995, 6291.02489114188, 6298.716557755004, 6320.873582528232, 6325.8734825304155, 6339.2392912850755, 5866.090755932837, 5990.6705131218205, 6041.24484439445, 6055.878882422415, 6067.696615169312, 5956.5532585055425, 6149.431894866781, 6209.254889413119, 6213.099100630293, 6222.595531290452, 5871.03127983895, 5873.089671100986, 5926.081457374114, 5936.940630593639, 5952.166696662557, 5813.476787089182, 5917.112433135064, 5960.284765828128, 5980.43185897339, 6006.399360063959, 5788.450097240755, 5797.942020579909, 5808.941910581009, 5815.3893841147765, 5853.180554722428, 5961.701914904324, 5988.730507127277, 5998.520118390431, 5999.100134979788, 6002.789902353396, 5679.091345384719, 5751.884962300815, 5797.565182611237, 5809.680467574324, 5862.355140934579], "unit": "score", "name": "dojo.html", "value": 5596.623388074398}, {"lowerIsBetter": false, "replicates": [573.9267569644762, 583.3670467542718, 592.9830340965244, 598.3537779198466, 640.1549954060641, 38809.22381552371, 39249.607503924955, 39376.409353859715, 39496.60503394965, 39504.80247598765, 40608.187836243254, 41189.58810411895, 41197.588024119825, 41246.143923523436, 41299.38050929239, 9339.953300233507, 9591.952040239825, 9594.992525784797, 9608.087231712976, 9623.663171788989, 9473.81052378952, 9689.903100969006, 9699.70900872975, 9706.369086009423, 9710.805783884318, 8281.917180828175, 9647.517624118802, 9745.805083898318, 9754.0, 9756.463394513334, 8365.07984121746, 9622.56698448568, 9666.226701863834, 9713.757156071119, 9735.951320243425, 9563.617455301779, 9709.320347575673, 9718.805623887554, 9722.659706910224, 9730.562124704406, 39211.607883921366, 39689.80155099206, 39720.0, 39731.40402893959, 39752.80741577757, 2333.94165145871, 2591.663083799113, 2651.6552848129813, 3193.584833971592, 3388.203772113551, 27572.034978775646, 28870.566941495894, 28883.133505994854, 29304.681289341817, 29656.851715741283, 2701.2987012987014, 2712.56598944168, 2742.794290428226, 2763.1434255380896, 2824.5763135529837, 424870.0, 428949.7105028972, 430225.0, 430518.0, 431625.0, 65991.67004164949, 66910.65446727644, 66939.0, 67072.0, 67203.0, 65487.0, 66016.0, 67529.32470675328, 67587.31031724148, 67605.64788704297, 16487.422940197277, 17051.573710657332, 17093.145342732812, 17102.657946841242, 17108.973461592097, 12977.286249256382, 13017.088803783834, 13091.869081309256, 13099.0, 13107.410166542528, 19032.71450928237, 19109.522261943563, 19190.424287271406, 19216.03919804004, 19221.94279314651, 7153.749618763319, 8072.071711753106, 8486.618102185417, 8508.74473765788, 8571.528565928933, 899.8065415935474, 978.500964508106, 995.5022488755623, 1040.9739756505996, 1128.1729865246077, 28583.857080714464, 29291.853540732587, 29490.0, 29775.553366699518, 30175.09474715718, 1101.3942331717524, 1110.9166812489095, 1145.8682251541013, 1150.7525881935424, 1155.942202889869, 12880.291583962971, 15213.923930380277, 15361.6159596011, 15612.92193539025, 15614.219289035504, 645955.0, 647856.0, 654199.0, 654361.0, 654673.0, 52277.0, 59184.70407647934, 59445.0, 60045.0, 60086.39913600808, 1309.6660351610278, 1330.8669133086614, 1334.3795135261955, 1477.062065588359, 1590.1254310129382, 25118.874405627856, 29037.48983263841, 31826.681733182373, 32275.838620806746, 32710.34579308353, 52254.0, 58117.0, 58695.70652146712, 58721.70639146777, 58728.0, 424426.0, 426344.0, 430244.0, 431409.0, 431506.0, 42078.0, 42468.57531424646, 42630.57369426266, 42749.786251068545, 42840.14319713651, 46935.53064469448, 50669.0, 51424.74287628538, 51828.74085629699, 53278.0, 37865.242695146495, 38129.61870381261, 38333.0, 38668.41997370098, 39357.01607459837, 37575.43636845504, 37600.43599346067, 37785.86642400733, 38202.0, 38876.416853746654, 38090.428643569816, 38510.2297954045, 38837.22325553417, 39092.21815563616, 39129.41305880471, 28512.57231141493, 32917.67082329242, 32933.34133317272, 32961.0, 33093.503597445575, 24867.005319787007, 24907.750922490544, 24908.62637060409, 25231.738413079638, 25478.617820733074], "unit": "score", "name": "ext.html", "value": 20146.701118015986}, {"lowerIsBetter": false, "replicates": [358.20657244204085, 359.71762166699136, 360.922401683638, 368.5025215958456, 370.44248406148745, 18600.906995465022, 19532.804671953276, 21008.684869726927, 21017.894910525465, 21034.789652103475, 19866.304679336226, 20334.59330813383, 20942.16231350744, 21215.0, 21234.0, 5817.7963771267905, 5994.670293133876, 6016.699165041752, 6031.668258245794, 6035.456808887199, 5751.4536119068625, 6017.217761690974, 6023.879522409549, 6033.185519954815, 6085.0, 5964.821055368346, 5986.311574168983, 5995.310539287994, 6003.879922401549, 6008.008678568031, 5905.911411328812, 5982.670953097578, 6592.17597800275, 6606.1412016438035, 6608.339166083401, 5768.192453056576, 5781.017227071408, 5785.884282314372, 5801.53587712982, 5802.47777700009, 17172.914135429368, 24423.877880610482, 25246.747532524623, 25407.61888571673, 25455.0, 2157.9892100539555, 2255.041607316884, 2314.0281081945623, 2695.5821847613456, 2725.931851703723, 9500.809983800355, 10121.949390253076, 10330.535125919352, 10332.79334413315, 10355.068043876086, 1636.811766646839, 1698.2188193430914, 1724.7499112628725, 1734.2456031626282, 1760.4542591796585, 101628.0, 101855.49072254666, 102177.4891125547, 104383.0, 107265.0, 8861.0, 10841.457927103613, 11166.218364714392, 11332.376719280519, 11334.149938754626, 13779.448822047007, 13878.375473103735, 13948.0, 13952.441902323793, 13957.79063314051, 8451.661933522713, 8626.266767324847, 8634.827303453896, 8725.345599080094, 8751.824963500694, 8776.341774366949, 8825.69110081144, 8867.778305542413, 8884.911150888538, 8897.377183597215, 4381.255186618282, 4442.489113751895, 4453.42105526286, 4487.730736155841, 4503.166914120898, 1801.8468430183582, 1856.8236017578308, 1861.2275905499066, 1895.7819850717344, 1895.9431217063511, 868.5961028121953, 933.8319102561604, 982.2976571751232, 1011.2516737614112, 1032.1691038713757, 19463.902680486506, 19875.801241987683, 20044.69932951007, 20065.59868802616, 20366.490837729176, 806.4072906413782, 936.4240991790136, 958.5063692198523, 969.6266937229218, 1024.7438140464883, 7273.490855640161, 10450.790984180274, 10672.0, 10684.839727404094, 10876.945615271872, 615709.0, 632714.0, 632879.0, 639767.6023239801, 661143.0, 67373.66313168402, 84818.15181848226, 109137.45431272793, 109627.0, 113290.0, 1005.4821766790109, 1015.9542820573092, 1047.1727335405096, 1049.800537897797, 1055.3562326980536, 17675.91162044233, 17867.821321787134, 17928.103594819946, 17999.0, 18310.90844545822, 34852.0, 51455.74272128615, 52338.47661523336, 53312.20031699605, 53680.926381472935, 73732.36638187917, 75035.24964750283, 75243.0, 77505.0, 77716.61141694481, 7456.254374562717, 7629.2370762923265, 7768.844623107393, 7963.761087167394, 8028.397870159644, 11950.46222919988, 12196.81704774447, 12535.373231338213, 12558.874411256136, 12585.874141258837, 10795.784084318113, 10934.0, 11033.0, 11103.611373601885, 11229.3262404256, 10571.682849514527, 10793.56825726962, 10826.729331766768, 11160.609378671708, 11410.771784564096, 10346.896531034594, 10948.34309941406, 11027.283226590567, 11329.376884271443, 11550.0, 7864.331531819859, 8113.594320283844, 8123.8781418277595, 8144.104148543537, 8316.960379952507, 9452.527373631428, 11110.777784444428, 11184.77832487735, 11284.435778210893, 11431.485583148611], "unit": "score", "name": "jquery.html", "value": 9385.43658136372}, {"lowerIsBetter": false, "replicates": [1410.1257220523278, 1570.8272090070093, 1605.093122385852, 1865.6828339182337, 1992.1533348326957, 7981.082175549814, 8594.65621375145, 8789.472631642106, 8790.91209087909, 8807.383483156182, 8527.232549070583, 8770.166834150745, 8775.6050977706, 8779.692710755126, 8803.911960880389, 2483.2922617054187, 2518.8110891683104, 2519.48350588129, 2520.823542352036, 2522.382016405974, 2445.4497738008895, 2514.7736703696664, 2516.5973444248925, 2520.596704527276, 2528.2288901884917, 2483.962740558893, 2495.8128140389454, 2500.987495062522, 2531.708853481855, 2534.556452620793, 2489.751024897505, 2510.1967370441466, 2521.2562294123186, 2530.4812513434704, 2532.2909585316143, 2456.091246238903, 2484.95030099397, 2493.812964027705, 2494.326531836412, 2521.873906304696, 8817.559122043873, 8868.822623547492, 8873.822523549492, 8877.201051905295, 8884.600192991331, 5398.64908780928, 5564.972175139098, 5570.526505247059, 5574.665520068809, 5580.888382232332, 3502.964970350289, 3509.6490350964955, 3570.982145089284, 3737.850485980585, 3740.9438858417147, 897.842877496442, 1045.790841831629, 1071.935683858971, 1079.773247618001, 1080.475969154959, 11746.588869389616, 11788.882111178864, 11805.704857378549, 11818.0, 11818.940905295418, 3911.8044097794996, 4874.53691899269, 4937.40751109862, 4941.407031156285, 5001.674891132065, 9992.050755178247, 10006.099451049295, 10130.24023198263, 10165.695029149138, 10179.9491002546, 5520.06158952979, 5566.081596536526, 5582.106862901916, 5590.413006634245, 5590.86022849432, 4491.932621010687, 4576.405067341224, 4640.23671005016, 4640.582347588733, 5070.822521211814, 3690.538682664667, 3890.2219556088894, 3904.3557812960544, 3905.3946638271113, 3908.1988192420486, 1122.5902545570807, 1317.1767645221737, 1330.3946704249543, 1335.706144648176, 1344.1196016609138, 1331.447449308526, 1358.8165597644388, 1362.843273023615, 1365.6176270644235, 1394.4004078246248, 7922.7227047053075, 8101.189881011969, 8120.309773669304, 8141.755747327471, 8201.261886430131, 1173.372245848484, 1194.689380760991, 1197.3713800254761, 1202.2606097250127, 1218.0, 6248.125262463259, 6277.7175027123885, 6340.1440805490665, 6361.4592759615025, 6370.171877655967, 10315.071643552117, 10781.083607893417, 10789.028987391173, 10789.190810689073, 10790.67627971162, 10334.588392115518, 10454.372737635766, 10538.789224215472, 10633.680989570325, 10646.0, 8277.62750676221, 8383.496990180609, 8425.831483370299, 8427.578621068922, 8458.534780587126, 7671.309582137635, 7835.294823465915, 7906.130325664288, 7907.604619768874, 7923.960380198062, 9252.0, 9563.474008929576, 9580.281478888972, 9612.75968100803, 9734.659286925207, 9710.660126895526, 9868.654597089067, 9932.0, 10024.0, 10028.498575071364, 7153.535020223669, 7468.253174682488, 7476.102867655916, 7550.093988721169, 7556.962215188889, 7569.205233450409, 7777.494462859896, 8069.475484093515, 8266.380021498531, 8282.751517454486, 7292.453066020176, 7306.3789577884345, 7313.378362839218, 7346.77959661211, 7496.7750967471065, 7173.569585824867, 7185.604791736296, 7266.309700578437, 7320.0, 7330.523515971445, 6559.0817285579105, 7665.348445382205, 7670.893288218281, 7743.186965368781, 7794.961025194838, 6893.965530172317, 6939.167299924042, 6960.199577048705, 7017.2631873652535, 7028.753993610199, 7001.054857594159, 7078.0, 7101.680424380812, 7113.82215444618, 7158.534695244793], "unit": "score", "name": "mootools.html", "value": 4968.780030501193}, {"lowerIsBetter": false, "replicates": [270.56979402749624, 324.98050116992965, 330.73375932374444, 332.4116314124002, 337.92058866166434, 6551.836204094894, 6568.441682456985, 6604.834879128024, 6605.0, 6692.799216023515, 6593.769218077368, 6611.0, 6611.4380277676455, 6621.304762999888, 6623.867522649544, 4006.95819087038, 4506.256467682829, 4734.479207287196, 4818.277258411232, 4846.321514987904, 4792.976035119819, 4825.7587120644, 4829.7585120744, 4838.927416088762, 4845.854624361275, 4770.904581908359, 4779.378680771495, 4784.521547845205, 4785.019071090418, 4786.7075889509815, 3996.3406038003986, 4584.381108550353, 4645.233536466496, 4715.0, 4769.761511924425, 4075.9388609170887, 4080.2655522006025, 4091.89770255743, 4092.1201941582403, 4105.34314509677, 5170.45710200431, 6166.691665416712, 6196.442320191204, 6226.657533835637, 6309.495240380758, 5684.289463817023, 5686.687232202227, 5689.857753556194, 5696.743646535874, 5711.029125048752, 5647.745851436695, 7011.193712723051, 7019.192792828788, 7019.298070192991, 7041.683124259421, 4353.499347575006, 4520.367148599199, 4526.366308716782, 4538.410006699108, 4545.159145558082, 6516.543841931067, 6815.114035175445, 7432.442566807457, 7432.69586428209, 7437.107547094329, 4607.424071991001, 4611.953880461152, 4613.192691279013, 4624.468186158568, 4625.542953969489, 4655.0, 4658.580727734452, 4659.790309436084, 4661.650376221797, 4673.158831410379, 5547.639403438763, 5564.527015203753, 5573.637713548687, 5574.968630803314, 5577.525910297589, 5998.580099393001, 6873.48448866337, 6938.202106757686, 7050.717971281194, 7105.502614817016, 1596.6327744618802, 1599.7760313556112, 1620.262780434923, 1621.505440840555, 1623.63614563767, 970.9805803883883, 992.0426788149471, 1019.2661283875598, 1024.9590016399409, 1045.038564520643, 6562.278149403562, 6663.167104111986, 6665.200175978914, 6671.299513551105, 6723.798286051427, 7382.18795932447, 7402.222766609536, 7406.7037318506655, 7411.332980031823, 7432.033835601337, 5482.616216864861, 6697.229818570927, 6705.56413833109, 6720.798376048726, 6734.0, 3188.56954311165, 3853.0174805424435, 3877.8448862045766, 3886.6502014818802, 3903.9609603903596, 6479.935200648028, 7448.590327532038, 7688.500247483896, 7774.766756997299, 7815.57014364204, 6148.723307451175, 7581.696732130763, 7646.158922518519, 7654.119776225694, 7674.155842857282, 7784.610769461504, 7789.883151752728, 7789.922100779033, 7799.142094369615, 7800.531968081933, 7175.677094530863, 7358.705651773869, 7402.703891844481, 7412.925870741224, 7416.147143078615, 6515.0, 6768.695408706521, 7206.639668016683, 7253.202147763847, 7284.162321332902, 7568.886466702894, 7739.419543534144, 7751.651175696994, 7769.805754855947, 7781.766547003373, 3871.341871881843, 4656.3946686930485, 4657.068586282825, 4658.67389282747, 4670.813167473263, 6009.639421634716, 7084.610346430995, 7321.707131714885, 7334.376577990717, 7335.046443962251, 7084.397826184626, 7099.538529995534, 7103.396211322096, 7105.076340075757, 7105.2894710528535, 7021.403180729695, 7094.574325540484, 7095.538789978635, 7095.645217738989, 7101.538400003983, 6923.134608173978, 6929.792106236821, 6933.791986240421, 6933.930660693329, 6935.445164386938, 6834.316568343126, 7103.893441598483, 7104.005439238614, 7125.038119853753, 7131.607761573163, 6673.833154171185, 6778.084958530535, 6823.590584564942, 6891.104156459628, 6960.582365058112], "unit": "score", "name": "prototype.html", "value": 5096.38913441954}, {"lowerIsBetter": false, "replicates": [684.1209046375407, 709.2623671381766, 715.3275920634603, 750.9061367329082, 799.7200979657117, 14752.926235368821, 14980.5505834825, 16927.153642317895, 17279.963202207877, 17282.740758888627, 15818.446354377598, 15868.968517046384, 15888.967217130878, 15890.84109158908, 15891.0, 737.4763917618498, 902.440486898124, 926.4441335198894, 928.2944961828991, 929.9581518831669, 732.3482100930177, 901.3014913442101, 920.3695468604028, 922.2529750901757, 925.2690374604055, 966.840471322231, 972.4505654305295, 973.6300205921775, 975.0493269062642, 976.379998700823, 768.2087449926585, 967.0957654592978, 967.4678926590383, 968.9903100969005, 969.7381706939087, 698.3958875572644, 711.1288671377573, 711.1927961763384, 714.139461948351, 715.0704084689883, 14899.702005959929, 14953.925230373887, 14994.800415966696, 15027.323770430357, 15044.172570508617, 12148.574799881962, 12198.0, 12216.0, 12320.383980801014, 12473.189242699196, 9785.363951343212, 9810.607575696964, 10012.148967337713, 10121.0, 10256.0, 3447.3450044491465, 3481.599616044162, 3485.3900567400856, 3488.7034602058857, 3575.66031227033, 71450.0, 71740.95626612278, 72728.6363568184, 72886.99999999948, 73317.53364932725, 9162.954185229164, 9272.35093543459, 9313.764696472934, 9682.515874206261, 9824.11582957523, 20522.0, 20523.897380513, 20543.280985165748, 20560.177592896416, 20575.485612859797, 7338.816529586697, 7359.852802943911, 7575.734849280248, 7664.770056898302, 7755.844883102306, 3713.9442908356395, 4038.0, 4049.4128351388886, 4125.278076336689, 4199.181159673895, 3577.695895848882, 3638.272345530904, 3641.417373220325, 3647.1429214134655, 3673.81630918453, 622.1383384013084, 635.6142615949982, 645.0872016097263, 654.5810681164058, 666.6133642487442, 470.1889241059214, 535.3976776126857, 557.6041010882238, 573.4007961680054, 620.8075496596069, 7621.733239336597, 7858.0963189232825, 7933.246341597539, 8022.598870056474, 8198.0, 519.4000928927095, 529.0846834975514, 545.6944111297686, 568.7867049856304, 602.7347966894553, 3591.586967498719, 3654.470101835219, 3669.614690457517, 3892.2410130024373, 3932.3315036443873, 86180.27639447176, 86976.0, 86984.0, 90195.0, 90393.54803226073, 54845.45154548404, 70584.0, 71258.64370678113, 75298.0, 76069.47861042859, 61984.69007654933, 62351.0, 65170.67414662896, 65583.0, 68192.63614727677, 7515.210902855121, 7540.698372065056, 7573.0, 7615.504992175491, 7646.617669116633, 46657.76804595293, 46795.76602116968, 47639.76180119077, 48194.75902620464, 48208.758956205, 63939.0, 66235.0, 66540.0, 66930.0, 67437.6628116876, 9632.662856799978, 9761.804763904824, 9968.55141518619, 10119.342242754197, 10231.0, 10615.840762388725, 10646.946765266124, 10716.624918127829, 10908.0, 10954.780904381709, 9981.850272245776, 10123.24075694311, 10163.7459063524, 10499.737506562396, 10542.314749541256, 10191.694249172537, 10206.744831379276, 10337.534810933375, 10585.788284234426, 10811.0, 9455.0, 9526.952365238129, 9553.761155971157, 9558.90441095608, 9574.808503830023, 6923.619200943795, 8365.916340836513, 8610.870836937325, 8705.085965973482, 8845.557722113997, 8664.35017373687, 8704.651813927625, 8787.560621968749, 8854.0, 8898.154675305836], "unit": "score", "name": "yui.html", "value": 6649.351784863588}], "name": "dromaeo_css", "value": 7501.5675899020225}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 110.0, 110.0, 111.0, 115.0, 113.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [159.0, 121.0, 144.0, 161.0, 120.0, 145.0, 140.0, 120.0, 161.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 139.2}, {"lowerIsBetter": true, "replicates": [187.0, 185.0, 183.0, 185.0, 184.0, 187.0, 183.0, 183.0, 195.0, 255.0], "unit": "score", "name": "audio-dft", "value": 192.7}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 84.0, 82.0, 58.0, 58.0, 59.0, 79.0, 105.0, 55.0], "unit": "score", "name": "audio-fft", "value": 72.9}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 131.0, 77.0, 78.0, 83.0, 115.0, 80.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 95.0}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 87.0, 86.0, 87.0, 84.0, 90.0, 85.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.3}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 93.0, 93.0, 92.0, 91.0, 93.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.4}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 85.0, 86.0, 87.0, 85.0, 84.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.0}, {"lowerIsBetter": true, "replicates": [54.0, 52.0, 53.0, 54.0, 53.0, 43.0, 42.0, 64.0, 59.0, 75.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 73.0, 78.0, 70.0, 70.0, 67.0, 68.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 81.0, 83.0, 83.0, 84.0, 83.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [134.0, 126.0, 115.0, 134.0, 111.0, 126.0, 135.0, 134.0, 121.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [140.0, 129.0, 142.0, 141.0, 141.0, 129.0, 144.0, 141.0, 141.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 64.0, 67.0, 68.0, 68.0, 67.0, 69.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1413.3}]} 16:12:49 INFO - Return code: 0 16:12:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:12:49 ERROR - # TBPL SUCCESS # 16:12:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:12:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:12:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:12:49 INFO - 2016-04-04 16:12:49.611 screenresolution[1681:10158] starting screenresolution argv=screenresolution get 16:12:49 INFO - 2016-04-04 16:12:49.614 screenresolution[1681:10158] Display 0: 1600x1200x32@60 16:12:49 INFO - 2016-04-04 16:12:49.620 screenresolution[1682:10161] starting screenresolution argv=screenresolution list 16:12:49 INFO - Available Modes on Display 0 16:12:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:12:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:12:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:12:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:12:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:12:49 INFO - Intel Iris: 16:12:49 INFO - Chipset Model: Intel Iris 16:12:49 INFO - Type: GPU 16:12:49 INFO - Bus: Built-In 16:12:49 INFO - VRAM (Dynamic, Max): 1536 MB 16:12:49 INFO - Vendor: Intel (0x8086) 16:12:49 INFO - Device ID: 0x0a2e 16:12:49 INFO - Revision ID: 0x0009 16:12:49 INFO - Displays: 16:12:49 INFO - Display: 16:12:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:12:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:12:49 INFO - Display Serial Number: 1600x1200 60 16:12:49 INFO - Main Display: Yes 16:12:49 INFO - Mirror: Off 16:12:49 INFO - Online: Yes 16:12:49 INFO - Rotation: Supported 16:12:49 INFO - Return code: 0 16:12:49 INFO - Running post-action listener: _resource_record_post_action 16:12:49 INFO - Running post-run listener: _resource_record_post_run 16:12:50 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 32243200; Write bytes: 701441024; Read time: 320; Write time: 1902 16:12:50 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 392731136; Write bytes: 386569728; Read time: 29920; Write time: 760 16:12:50 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 30453248; Write bytes: 297418240; Read time: 301; Write time: 1104 16:12:50 INFO - Running post-run listener: _upload_blobber_files 16:12:50 INFO - Blob upload gear active. 16:12:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:50 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 16:12:50 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'] 16:12:50 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 16:12:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:12:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:12:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:52 INFO - (blobuploader) - INFO - Done attempting. 16:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:12:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:52 INFO - (blobuploader) - INFO - Done attempting. 16:12:52 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:52 INFO - Return code: 0 16:12:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/880619e2d9528afb5359e2b6c8f4838c7a69cdc3ae7b3562333501851afeaa6104784bf9150e3aa357f2b47326dbb53c561a81f3322184913176b1b224ea3a2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfa2e64c059353ab95f7ee963d2b3c1e878e2cf53abf8af3346ab780e23d491975a9402510a4970018e083ca6e84fd9eb8e959cd3543ed72d9b99321a7ce244d"} 16:12:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:53 INFO - Contents: 16:12:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/880619e2d9528afb5359e2b6c8f4838c7a69cdc3ae7b3562333501851afeaa6104784bf9150e3aa357f2b47326dbb53c561a81f3322184913176b1b224ea3a2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfa2e64c059353ab95f7ee963d2b3c1e878e2cf53abf8af3346ab780e23d491975a9402510a4970018e083ca6e84fd9eb8e959cd3543ed72d9b99321a7ce244d"} 16:12:53 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:53 INFO - Copying logs to upload dir... 16:12:53 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1297.070897 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-04 16:12:53.226890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 16:12:53.230563) ========= 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.E5D4ye9oOB/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.91a7VZFpuS/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/880619e2d9528afb5359e2b6c8f4838c7a69cdc3ae7b3562333501851afeaa6104784bf9150e3aa357f2b47326dbb53c561a81f3322184913176b1b224ea3a2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfa2e64c059353ab95f7ee963d2b3c1e878e2cf53abf8af3346ab780e23d491975a9402510a4970018e083ca6e84fd9eb8e959cd3543ed72d9b99321a7ce244d"} build_url:https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011472 build_url: 'https://queue.taskcluster.net/v1/task/R9Uxs3hrSI2KpCUMlx0mTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/880619e2d9528afb5359e2b6c8f4838c7a69cdc3ae7b3562333501851afeaa6104784bf9150e3aa357f2b47326dbb53c561a81f3322184913176b1b224ea3a2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfa2e64c059353ab95f7ee963d2b3c1e878e2cf53abf8af3346ab780e23d491975a9402510a4970018e083ca6e84fd9eb8e959cd3543ed72d9b99321a7ce244d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 16:12:53.261935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 16:12:53.262694) ========= 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.E5D4ye9oOB/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.91a7VZFpuS/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005299 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 16:12:53.313573) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 16:12:53.313928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 16:12:53.314399) ========= ========= Total master_lag: 2.04 =========