builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0086 starttime: 1455426766.32 results: success (0) buildid: 20160213192017 builduid: f01063b39aba4f01aa38c85585761eb4 revision: e355cacefc881ba360d412853b57e8e060e966f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.318548) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.318973) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.319347) ========= 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.SJKQwAs2X7/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.l83c2aI3eG/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005692 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.341073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.341411) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.356514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.356824) ========= 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.SJKQwAs2X7/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.l83c2aI3eG/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005293 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.405597) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.405931) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.406304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.406633) ========= 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.SJKQwAs2X7/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.l83c2aI3eG/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-13 21:12:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.40M=0.001s 2016-02-13 21:12:46 (8.40 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105363 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.528976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.529609) ========= 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.SJKQwAs2X7/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.l83c2aI3eG/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.019814 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:46.581546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-13 21:12:46.582291) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e355cacefc881ba360d412853b57e8e060e966f4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e355cacefc881ba360d412853b57e8e060e966f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SJKQwAs2X7/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.l83c2aI3eG/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-13 21:12:46,657 truncating revision to first 12 chars 2016-02-13 21:12:46,657 Setting DEBUG logging. 2016-02-13 21:12:46,657 attempt 1/10 2016-02-13 21:12:46,657 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e355cacefc88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-13 21:12:47,630 unpacking tar archive at: mozilla-central-e355cacefc88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.223028 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-13 21:12:47.825645) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:47.826019) ========= echo e355cacefc881ba360d412853b57e8e060e966f4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e355cacefc881ba360d412853b57e8e060e966f4'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SJKQwAs2X7/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.l83c2aI3eG/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 e355cacefc881ba360d412853b57e8e060e966f4 program finished with exit code 0 elapsedTime=0.005079 script_repo_revision: 'e355cacefc881ba360d412853b57e8e060e966f4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:47.883652) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:47.884192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 21:12:47.899284) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-02-13 21:12:47.899570) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SJKQwAs2X7/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.l83c2aI3eG/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:12:48 INFO - MultiFileLogger online at 20160213 21:12:48 in /builds/slave/test 21:12:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:12:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:12:48 INFO - {'append_to_log': False, 21:12:48 INFO - 'base_work_dir': '/builds/slave/test', 21:12:48 INFO - 'blob_upload_branch': 'Firefox', 21:12:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:12:48 INFO - 'branch': 'Firefox', 21:12:48 INFO - 'buildbot_json_path': 'buildprops.json', 21:12:48 INFO - 'config_files': ('talos/mac_config.py',), 21:12:48 INFO - 'default_actions': ('clobber', 21:12:48 INFO - 'read-buildbot-config', 21:12:48 INFO - 'download-and-extract', 21:12:48 INFO - 'populate-webroot', 21:12:48 INFO - 'create-virtualenv', 21:12:48 INFO - 'install', 21:12:48 INFO - 'run-tests'), 21:12:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:12:48 INFO - 'download_minidump_stackwalk': True, 21:12:48 INFO - 'download_symbols': 'ondemand', 21:12:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:12:48 INFO - 'tooltool.py': '/tools/tooltool.py', 21:12:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:12:48 INFO - '/tools/misc-python/virtualenv.py')}, 21:12:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:12:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:12:48 INFO - 'installer_path': 'installer.exe', 21:12:48 INFO - 'log_level': 'info', 21:12:48 INFO - 'log_name': 'talos', 21:12:48 INFO - 'log_to_console': True, 21:12:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:12:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:12:48 INFO - 'opt_config_files': (), 21:12:48 INFO - 'pip_index': False, 21:12:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:12:48 INFO - 'cmd': ('bash', 21:12:48 INFO - '-c', 21:12:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:12:48 INFO - 'enabled': True, 21:12:48 INFO - 'halt_on_failure': False, 21:12:48 INFO - 'name': 'check_screen_resolution'},), 21:12:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:12:48 INFO - 'cmd': ('bash', 21:12:48 INFO - '-c', 21:12:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:12:48 INFO - 'enabled': True, 21:12:48 INFO - 'halt_on_failure': False, 21:12:48 INFO - 'name': 'check_screen_resolution'},), 21:12:48 INFO - 'run_cmd_checks_enabled': True, 21:12:48 INFO - 'sps_profile': False, 21:12:48 INFO - 'sps_profile_interval': 0, 21:12:48 INFO - 'suite': 'dromaeojs', 21:12:48 INFO - 'system_bits': '32', 21:12:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:12:48 INFO - 'title': 't-yosemite-r7-0086', 21:12:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:12:48 INFO - 'use_talos_json': True, 21:12:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:12:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:12:48 INFO - 'work_dir': 'build'} 21:12:48 INFO - ##### 21:12:48 INFO - ##### Running clobber step. 21:12:48 INFO - ##### 21:12:48 INFO - Running pre-action listener: _resource_record_pre_action 21:12:48 INFO - Running main action method: clobber 21:12:48 INFO - rmtree: /builds/slave/test/build 21:12:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:12:49 INFO - Running post-action listener: _resource_record_post_action 21:12:49 INFO - ##### 21:12:49 INFO - ##### Running read-buildbot-config step. 21:12:49 INFO - ##### 21:12:49 INFO - Running pre-action listener: _resource_record_pre_action 21:12:49 INFO - Running main action method: read_buildbot_config 21:12:49 INFO - Using buildbot properties: 21:12:49 INFO - { 21:12:49 INFO - "project": "", 21:12:49 INFO - "product": "firefox", 21:12:49 INFO - "script_repo_revision": "production", 21:12:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:12:49 INFO - "repository": "", 21:12:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:12:49 INFO - "buildid": "20160213192017", 21:12:49 INFO - "pgo_build": "False", 21:12:49 INFO - "basedir": "/builds/slave/test", 21:12:49 INFO - "buildnumber": 132, 21:12:49 INFO - "slavename": "t-yosemite-r7-0086", 21:12:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 21:12:49 INFO - "platform": "yosemite_r7", 21:12:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:12:49 INFO - "branch": "mozilla-central", 21:12:49 INFO - "repo_path": "mozilla-central", 21:12:49 INFO - "revision": "e355cacefc881ba360d412853b57e8e060e966f4", 21:12:49 INFO - "stage_platform": "macosx64", 21:12:49 INFO - "builduid": "f01063b39aba4f01aa38c85585761eb4", 21:12:49 INFO - "slavebuilddir": "test" 21:12:49 INFO - } 21:12:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 21:12:49 INFO - Running post-action listener: _resource_record_post_action 21:12:49 INFO - ##### 21:12:49 INFO - ##### Running download-and-extract step. 21:12:49 INFO - ##### 21:12:49 INFO - Running pre-action listener: _resource_record_pre_action 21:12:49 INFO - Running main action method: download_and_extract 21:12:49 INFO - mkdir: /builds/slave/test/build/tests 21:12: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')]} 21:12:49 INFO - https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:12:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/test_packages.json 21:12:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/test_packages.json 21:12:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:12:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:12:55 INFO - Downloaded 1277 bytes. 21:12:55 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:12:55 INFO - Using the following test package requirements: 21:12:55 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 21:12:55 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:12:55 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 21:12:55 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:12:55 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 21:12:55 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:12:55 INFO - u'jsshell-mac.zip'], 21:12:55 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:12:55 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 21:12:55 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 21:12:55 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:12:55 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 21:12:55 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:12:55 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 21:12:55 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:12:55 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 21:12:55 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 21:12:55 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:12:55 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 21:12:55 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:12:55 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')]} 21:12:55 INFO - https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:12:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:12:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:12:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:12:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:13:13 INFO - Downloaded 17756345 bytes. 21:13:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:13:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:13:16 INFO - Return code: 0 21:13:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:16 INFO - https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:13:20 INFO - Downloaded 17756345 bytes. 21:13:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:13:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:13:24 INFO - Return code: 0 21:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:24 INFO - https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:13:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 21:13:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 21:13:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 21:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:13:24 INFO - Downloaded 10707070 bytes. 21:13:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:13:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 21:13:25 INFO - Return code: 0 21:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:25 INFO - https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:13:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:13:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:13:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 21:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 21:13:33 INFO - Downloaded 111097869 bytes. 21:13:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:13:33 INFO - mkdir: /builds/slave/test/properties 21:13:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:13:33 INFO - Writing to file /builds/slave/test/properties/build_url 21:13:33 INFO - Contents: 21:13:33 INFO - build_url:https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:13:33 INFO - Running post-action listener: _resource_record_post_action 21:13:33 INFO - Running post-action listener: set_extra_try_arguments 21:13:33 INFO - ##### 21:13:33 INFO - ##### Running populate-webroot step. 21:13:33 INFO - ##### 21:13:33 INFO - Running pre-action listener: _resource_record_pre_action 21:13:33 INFO - Running main action method: populate_webroot 21:13:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:13:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:13:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:13:33 INFO - '--tppagecycles', 21:13:33 INFO - '7'], 21:13:33 INFO - 'tests': ['tsvgm']}}, 21:13:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:13:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:13:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:13:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:13:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:13:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:13:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:33 INFO - 'talos_options': ['--e10s'], 21:13:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:33 INFO - 'tests': ['damp', 'tps']}, 21:13:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:33 INFO - 'talos_options': ['--e10s'], 21:13:33 INFO - 'tests': ['damp', 'tps']}, 21:13:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:13:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:13:33 INFO - 'other': {'tests': ['a11yr', 21:13:33 INFO - 'ts_paint', 21:13:33 INFO - 'tpaint', 21:13:33 INFO - 'sessionrestore', 21:13:33 INFO - 'sessionrestore_no_auto_restore']}, 21:13:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:13:33 INFO - 'tests': ['a11yr', 21:13:33 INFO - 'ts_paint', 21:13:33 INFO - 'tpaint', 21:13:33 INFO - 'sessionrestore', 21:13:33 INFO - 'sessionrestore_no_auto_restore']}, 21:13:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:13:33 INFO - 'tests': ['a11yr', 21:13:33 INFO - 'ts_paint', 21:13:33 INFO - 'tpaint', 21:13:33 INFO - 'sessionrestore', 21:13:33 INFO - 'sessionrestore_no_auto_restore']}, 21:13:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:13:33 INFO - 'tests': ['a11yr', 21:13:33 INFO - 'ts_paint', 21:13:33 INFO - 'tpaint', 21:13:33 INFO - 'sessionrestore', 21:13:33 INFO - 'sessionrestore_no_auto_restore']}, 21:13:33 INFO - 'other_l64': {'tests': ['a11yr', 21:13:33 INFO - 'ts_paint', 21:13:33 INFO - 'tpaint', 21:13:33 INFO - 'sessionrestore', 21:13:33 INFO - 'sessionrestore_no_auto_restore']}, 21:13:33 INFO - 'other_nol64': {'tests': ['a11yr', 21:13:33 INFO - 'ts_paint', 21:13:33 INFO - 'tpaint', 21:13:33 INFO - 'sessionrestore', 21:13:33 INFO - 'sessionrestore_no_auto_restore']}, 21:13:33 INFO - 'svgr': {'tests': ['tsvgx', 21:13:33 INFO - 'tsvgr_opacity', 21:13:33 INFO - 'tart', 21:13:33 INFO - 'tscrollx', 21:13:33 INFO - 'cart']}, 21:13:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:13:33 INFO - 'tests': ['tsvgx', 21:13:33 INFO - 'tsvgr_opacity', 21:13:33 INFO - 'tart', 21:13:33 INFO - 'tscrollx', 21:13:33 INFO - 'cart']}, 21:13:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:33 INFO - 'tests': ['tp5o']}, 21:13:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:33 INFO - 'talos_options': ['--e10s'], 21:13:33 INFO - 'tests': ['tp5o']}, 21:13:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:33 INFO - 'talos_options': ['--xperf_path', 21:13:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:33 INFO - 'tests': ['tp5n']}, 21:13:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:33 INFO - 'talos_options': ['--e10s', 21:13:33 INFO - '--xperf_path', 21:13:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:33 INFO - 'tests': ['tp5n']}}, 21:13:33 INFO - 'talos.zip': {'path': '', 21:13:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:13:33 INFO - Running post-action listener: _resource_record_post_action 21:13:33 INFO - ##### 21:13:33 INFO - ##### Running create-virtualenv step. 21:13:33 INFO - ##### 21:13:33 INFO - Running pre-action listener: _resource_record_pre_action 21:13:33 INFO - Running main action method: create_virtualenv 21:13:33 INFO - Creating virtualenv /builds/slave/test/build/venv 21:13:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:13:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:13:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:13:34 INFO - Using real prefix '/tools/python27' 21:13:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:13:34 INFO - Installing distribute.............................................................................................................................................................................................done. 21:13:37 INFO - Installing pip.................done. 21:13:37 INFO - Return code: 0 21:13:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c04add70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, '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.SJKQwAs2X7/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.l83c2aI3eG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:37 INFO - 'HOME': '/Users/cltbld', 21:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:37 INFO - 'LOGNAME': 'cltbld', 21:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:37 INFO - 'MOZ_NO_REMOTE': '1', 21:13:37 INFO - 'NO_EM_RESTART': '1', 21:13:37 INFO - 'PAGER': '/bin/cat', 21:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:37 INFO - 'PWD': '/builds/slave/test', 21:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:37 INFO - 'SHELL': '/bin/bash', 21:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:13:37 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:37 INFO - 'USER': 'cltbld', 21:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:37 INFO - 'XPC_FLAGS': '0x0', 21:13:37 INFO - 'XPC_SERVICE_NAME': '0', 21:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:13:37 INFO - Cleaning up... 21:13:37 INFO - Return code: 0 21:13:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c04add70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, '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.SJKQwAs2X7/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.l83c2aI3eG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:37 INFO - 'HOME': '/Users/cltbld', 21:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:37 INFO - 'LOGNAME': 'cltbld', 21:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:37 INFO - 'MOZ_NO_REMOTE': '1', 21:13:37 INFO - 'NO_EM_RESTART': '1', 21:13:37 INFO - 'PAGER': '/bin/cat', 21:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:37 INFO - 'PWD': '/builds/slave/test', 21:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:37 INFO - 'SHELL': '/bin/bash', 21:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:13:37 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:37 INFO - 'USER': 'cltbld', 21:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:37 INFO - 'XPC_FLAGS': '0x0', 21:13:37 INFO - 'XPC_SERVICE_NAME': '0', 21:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:38 INFO - Downloading/unpacking psutil>=0.7.1 21:13:38 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 21:13:38 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 21:13:38 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 21:13:38 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 21:13:38 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 21:13:38 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 21:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:13:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:41 INFO - Installing collected packages: psutil 21:13:41 INFO - Running setup.py install for psutil 21:13:41 INFO - building 'psutil._psutil_osx' extension 21:13:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:13:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:13:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:13:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 21:13:41 INFO - building 'psutil._psutil_posix' extension 21:13:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 21:13:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:13:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:13:41 INFO - ^ 21:13:41 INFO - 1 warning generated. 21:13:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 21:13:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:41 INFO - Successfully installed psutil 21:13:41 INFO - Cleaning up... 21:13:41 INFO - Return code: 0 21:13:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:42 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')]} 21:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:42 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 0x10fd42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c04add70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, '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.SJKQwAs2X7/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.l83c2aI3eG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:13:42 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 21:13:42 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 21:13:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:13:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:42 INFO - 'HOME': '/Users/cltbld', 21:13:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:42 INFO - 'LOGNAME': 'cltbld', 21:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:42 INFO - 'MOZ_NO_REMOTE': '1', 21:13:42 INFO - 'NO_EM_RESTART': '1', 21:13:42 INFO - 'PAGER': '/bin/cat', 21:13:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:42 INFO - 'PWD': '/builds/slave/test', 21:13:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:42 INFO - 'SHELL': '/bin/bash', 21:13:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:13:42 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:42 INFO - 'USER': 'cltbld', 21:13:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:42 INFO - 'XPC_FLAGS': '0x0', 21:13:42 INFO - 'XPC_SERVICE_NAME': '0', 21:13:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:13:42 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 21:13:42 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 21:13:42 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 21:13:42 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 21:13:42 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 21:13:42 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 21:13:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:13:45 INFO - Installing collected packages: mozsystemmonitor 21:13:45 INFO - Running setup.py install for mozsystemmonitor 21:13:45 INFO - Successfully installed mozsystemmonitor 21:13:45 INFO - Cleaning up... 21:13:45 INFO - Return code: 0 21:13:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:13:45 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')]} 21:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:45 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')]} 21:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:45 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 0x10fd42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c04add70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, '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.SJKQwAs2X7/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.l83c2aI3eG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:13:45 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 21:13:45 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 21:13:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:13:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:45 INFO - 'HOME': '/Users/cltbld', 21:13:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:45 INFO - 'LOGNAME': 'cltbld', 21:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:45 INFO - 'MOZ_NO_REMOTE': '1', 21:13:45 INFO - 'NO_EM_RESTART': '1', 21:13:45 INFO - 'PAGER': '/bin/cat', 21:13:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:45 INFO - 'PWD': '/builds/slave/test', 21:13:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:45 INFO - 'SHELL': '/bin/bash', 21:13:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:13:45 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:45 INFO - 'USER': 'cltbld', 21:13:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:45 INFO - 'XPC_FLAGS': '0x0', 21:13:45 INFO - 'XPC_SERVICE_NAME': '0', 21:13:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:45 INFO - Downloading/unpacking blobuploader==1.2.4 21:13:45 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 21:13:45 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 21:13:45 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 21:13:45 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 21:13:45 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 21:13:45 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 21:13:47 INFO - Downloading blobuploader-1.2.4.tar.gz 21:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:13:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:13:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:48 INFO - Downloading docopt-0.6.1.tar.gz 21:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:13:48 INFO - Installing collected packages: blobuploader, requests, docopt 21:13:48 INFO - Running setup.py install for blobuploader 21:13:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:13:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:13:49 INFO - Running setup.py install for requests 21:13:49 INFO - Running setup.py install for docopt 21:13:49 INFO - Successfully installed blobuploader requests docopt 21:13:49 INFO - Cleaning up... 21:13:49 INFO - Return code: 0 21:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c04add70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, '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.SJKQwAs2X7/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.l83c2aI3eG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:13:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:13:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:49 INFO - 'HOME': '/Users/cltbld', 21:13:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:49 INFO - 'LOGNAME': 'cltbld', 21:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:49 INFO - 'MOZ_NO_REMOTE': '1', 21:13:49 INFO - 'NO_EM_RESTART': '1', 21:13:49 INFO - 'PAGER': '/bin/cat', 21:13:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:49 INFO - 'PWD': '/builds/slave/test', 21:13:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:49 INFO - 'SHELL': '/bin/bash', 21:13:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:13:49 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:49 INFO - 'USER': 'cltbld', 21:13:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:49 INFO - 'XPC_FLAGS': '0x0', 21:13:49 INFO - 'XPC_SERVICE_NAME': '0', 21:13:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2hrdLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-nCRySa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-5l3PDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-6KYTNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-4gYgtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2ni_eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-9WJeOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-lIApkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-e1qO46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-P8RFIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-U1BPwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-VysaJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-98Of9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-K1u3N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-saDQeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0zUVAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-bajuE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:13:51 INFO - Running setup.py install for manifestparser 21:13:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:13:52 INFO - Running setup.py install for mozcrash 21:13:52 INFO - Running setup.py install for mozdebug 21:13:52 INFO - Running setup.py install for mozdevice 21:13:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:13:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:13:52 INFO - Running setup.py install for mozfile 21:13:52 INFO - Running setup.py install for mozhttpd 21:13:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:13:52 INFO - Running setup.py install for mozinfo 21:13:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:13:52 INFO - Running setup.py install for mozInstall 21:13:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:13:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:13:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:13:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:13:53 INFO - Running setup.py install for mozleak 21:13:53 INFO - Running setup.py install for mozlog 21:13:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:13:53 INFO - Running setup.py install for moznetwork 21:13:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:13:53 INFO - Running setup.py install for mozprocess 21:13:53 INFO - Running setup.py install for mozprofile 21:13:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:13:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:13:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:13:53 INFO - Running setup.py install for mozrunner 21:13:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:13:54 INFO - Running setup.py install for mozscreenshot 21:13:54 INFO - Running setup.py install for moztest 21:13:54 INFO - Running setup.py install for mozversion 21:13:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:13:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:13:54 INFO - Cleaning up... 21:13:54 INFO - Return code: 0 21:13:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:54 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')]} 21:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:54 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')]} 21:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:54 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 0x10fd42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c04add70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, '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.SJKQwAs2X7/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.l83c2aI3eG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:13:54 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 21:13:54 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 21:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:54 INFO - 'HOME': '/Users/cltbld', 21:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:54 INFO - 'LOGNAME': 'cltbld', 21:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:54 INFO - 'MOZ_NO_REMOTE': '1', 21:13:54 INFO - 'NO_EM_RESTART': '1', 21:13:54 INFO - 'PAGER': '/bin/cat', 21:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:54 INFO - 'PWD': '/builds/slave/test', 21:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:54 INFO - 'SHELL': '/bin/bash', 21:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:13:54 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:54 INFO - 'USER': 'cltbld', 21:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:54 INFO - 'XPC_FLAGS': '0x0', 21:13:54 INFO - 'XPC_SERVICE_NAME': '0', 21:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:54 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-iMUEv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:54 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-A9CfWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:54 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-LTclZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:55 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)) 21:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-QIQ6MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:55 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)) 21:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-btA7Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:55 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)) 21:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-r0G3GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:55 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)) 21:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-7xJf6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:55 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)) 21:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-3SrzD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:55 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)) 21:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-PJzGTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-yp1DOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-GkG3jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-7GYZzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:56 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)) 21:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ThqwTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:56 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)) 21:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-naPFvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:56 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)) 21:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Eb9C0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:56 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)) 21:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-CM4P6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:56 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)) 21:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-caxSOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:56 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)) 21:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:13:56 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)) 21:13:56 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)) 21:13:56 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)) 21:13:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:13:56 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 21:13:56 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 21:13:56 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 21:13:56 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 21:13:56 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 21:13:56 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 21:13:58 INFO - Downloading blessings-1.6.tar.gz 21:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:13:58 INFO - Installing collected packages: blessings 21:13:58 INFO - Running setup.py install for blessings 21:13:59 INFO - Successfully installed blessings 21:13:59 INFO - Cleaning up... 21:13:59 INFO - Return code: 0 21:13:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:13:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:59 INFO - Reading from file tmpfile_stdout 21:13:59 INFO - Current package versions: 21:13:59 INFO - blessings == 1.6 21:13:59 INFO - blobuploader == 1.2.4 21:13:59 INFO - docopt == 0.6.1 21:13:59 INFO - manifestparser == 1.1 21:13:59 INFO - mozInstall == 1.12 21:13:59 INFO - mozcrash == 0.16 21:13:59 INFO - mozdebug == 0.1 21:13:59 INFO - mozdevice == 0.48 21:13:59 INFO - mozfile == 1.2 21:13:59 INFO - mozhttpd == 0.7 21:13:59 INFO - mozinfo == 0.9 21:13:59 INFO - mozleak == 0.1 21:13:59 INFO - mozlog == 3.1 21:13:59 INFO - moznetwork == 0.27 21:13:59 INFO - mozprocess == 0.22 21:13:59 INFO - mozprofile == 0.28 21:13:59 INFO - mozrunner == 6.11 21:13:59 INFO - mozscreenshot == 0.1 21:13:59 INFO - mozsystemmonitor == 0.0 21:13:59 INFO - moztest == 0.7 21:13:59 INFO - mozversion == 1.4 21:13:59 INFO - psutil == 3.1.1 21:13:59 INFO - requests == 1.2.3 21:13:59 INFO - wsgiref == 0.1.2 21:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:59 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 0x10fd42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c04add70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, '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.SJKQwAs2X7/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.l83c2aI3eG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:13:59 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 21:13:59 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 21:13:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:13:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:59 INFO - 'HOME': '/Users/cltbld', 21:13:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:59 INFO - 'LOGNAME': 'cltbld', 21:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:59 INFO - 'MOZ_NO_REMOTE': '1', 21:13:59 INFO - 'NO_EM_RESTART': '1', 21:13:59 INFO - 'PAGER': '/bin/cat', 21:13:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:59 INFO - 'PWD': '/builds/slave/test', 21:13:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:59 INFO - 'SHELL': '/bin/bash', 21:13:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:13:59 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:59 INFO - 'USER': 'cltbld', 21:13:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:59 INFO - 'XPC_FLAGS': '0x0', 21:13:59 INFO - 'XPC_SERVICE_NAME': '0', 21:13:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:13:59 INFO - Cleaning up... 21:13:59 INFO - Return code: 0 21:13:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c04add70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, '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.SJKQwAs2X7/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.l83c2aI3eG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:13:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:13:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:59 INFO - 'HOME': '/Users/cltbld', 21:13:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:59 INFO - 'LOGNAME': 'cltbld', 21:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:59 INFO - 'MOZ_NO_REMOTE': '1', 21:13:59 INFO - 'NO_EM_RESTART': '1', 21:13:59 INFO - 'PAGER': '/bin/cat', 21:13:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:59 INFO - 'PWD': '/builds/slave/test', 21:13:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:59 INFO - 'SHELL': '/bin/bash', 21:13:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:13:59 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:59 INFO - 'USER': 'cltbld', 21:13:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:59 INFO - 'XPC_FLAGS': '0x0', 21:13:59 INFO - 'XPC_SERVICE_NAME': '0', 21:13:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:00 INFO - Downloading/unpacking jsonschema 21:14:00 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 21:14:00 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 21:14:00 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 21:14:00 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 21:14:00 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 21:14:00 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 21:14:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:14:02 INFO - Downloading/unpacking functools32 (from jsonschema) 21:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:02 INFO - Downloading functools32-3.2.3-2.tar.gz 21:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:14:02 INFO - warning: no files found matching '*.txt' 21:14:02 INFO - no previously-included directories found matching 'build' 21:14:02 INFO - no previously-included directories found matching 'dist' 21:14:02 INFO - no previously-included directories found matching '.git*' 21:14:02 INFO - Installing collected packages: jsonschema, functools32 21:14:02 INFO - Running setup.py install for functools32 21:14:02 INFO - warning: no files found matching '*.txt' 21:14:02 INFO - no previously-included directories found matching 'build' 21:14:02 INFO - no previously-included directories found matching 'dist' 21:14:02 INFO - no previously-included directories found matching '.git*' 21:14:02 INFO - Successfully installed jsonschema functools32 21:14:02 INFO - Cleaning up... 21:14:03 INFO - Return code: 0 21:14:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c04add70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, '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.SJKQwAs2X7/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.l83c2aI3eG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 21:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:14:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:14:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:03 INFO - 'HOME': '/Users/cltbld', 21:14:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:03 INFO - 'LOGNAME': 'cltbld', 21:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:03 INFO - 'MOZ_NO_REMOTE': '1', 21:14:03 INFO - 'NO_EM_RESTART': '1', 21:14:03 INFO - 'PAGER': '/bin/cat', 21:14:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:03 INFO - 'PWD': '/builds/slave/test', 21:14:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:03 INFO - 'SHELL': '/bin/bash', 21:14:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:14:03 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:14:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:03 INFO - 'USER': 'cltbld', 21:14:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:03 INFO - 'XPC_FLAGS': '0x0', 21:14:03 INFO - 'XPC_SERVICE_NAME': '0', 21:14:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:03 INFO - Downloading/unpacking flake8 21:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:14:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:14:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:14:06 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 21:14:06 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 21:14:06 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 21:14:06 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 21:14:06 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 21:14:06 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 21:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:14:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:14:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:14:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:14:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:14:06 INFO - no previously-included directories found matching 'docs/_build' 21:14:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:14:06 INFO - Running setup.py install for pep8 21:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:14:07 INFO - no previously-included directories found matching 'docs/_build' 21:14:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:14:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:14:07 INFO - Cleaning up... 21:14:07 INFO - Return code: 0 21:14:07 INFO - Running post-action listener: _resource_record_post_action 21:14:07 INFO - Running post-action listener: _start_resource_monitoring 21:14:07 INFO - Starting resource monitoring. 21:14:07 INFO - ##### 21:14:07 INFO - ##### Running install step. 21:14:07 INFO - ##### 21:14:07 INFO - Running pre-action listener: _resource_record_pre_action 21:14:07 INFO - Running main action method: install 21:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:07 INFO - Reading from file tmpfile_stdout 21:14:07 INFO - Detecting whether we're running mozinstall >=1.0... 21:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:14:07 INFO - Reading from file tmpfile_stdout 21:14:07 INFO - Output received: 21:14:07 INFO - Usage: mozinstall [options] installer 21:14:07 INFO - Options: 21:14:07 INFO - -h, --help show this help message and exit 21:14:07 INFO - -d DEST, --destination=DEST 21:14:07 INFO - Directory to install application into. [default: 21:14:07 INFO - "/builds/slave/test"] 21:14:07 INFO - --app=APP Application being installed. [default: firefox] 21:14:07 INFO - mkdir: /builds/slave/test/build/application 21:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:14:41 INFO - Reading from file tmpfile_stdout 21:14:41 INFO - Output received: 21:14:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:14:41 INFO - Running post-action listener: _resource_record_post_action 21:14:41 INFO - ##### 21:14:41 INFO - ##### Running run-tests step. 21:14:41 INFO - ##### 21:14:41 INFO - Running pre-action listener: _resource_record_pre_action 21:14:41 INFO - Running main action method: run_tests 21:14:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:14:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:14:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:14:41 INFO - 2016-02-13 21:14:41.499 screenresolution[2338:21470] starting screenresolution argv=screenresolution get 21:14:41 INFO - 2016-02-13 21:14:41.501 screenresolution[2338:21470] Display 0: 1600x1200x32@60 21:14:41 INFO - 2016-02-13 21:14:41.507 screenresolution[2339:21473] starting screenresolution argv=screenresolution list 21:14:41 INFO - Available Modes on Display 0 21:14:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:14:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:14:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:14:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:14:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:14:41 INFO - Intel Iris: 21:14:41 INFO - Chipset Model: Intel Iris 21:14:41 INFO - Type: GPU 21:14:41 INFO - Bus: Built-In 21:14:41 INFO - VRAM (Dynamic, Max): 1536 MB 21:14:41 INFO - Vendor: Intel (0x8086) 21:14:41 INFO - Device ID: 0x0a2e 21:14:41 INFO - Revision ID: 0x0009 21:14:41 INFO - Displays: 21:14:41 INFO - Display: 21:14:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:14:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:14:41 INFO - Display Serial Number: 1600x1200 60 21:14:41 INFO - Main Display: Yes 21:14:41 INFO - Mirror: Off 21:14:41 INFO - Online: Yes 21:14:41 INFO - Rotation: Supported 21:14:41 INFO - Return code: 0 21:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:14:41 INFO - Python 2.7.3 21:14:41 INFO - Return code: 0 21:14:41 INFO - grabbing minidump binary from tooltool 21:14: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')]} 21:14:41 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 0x10fbe6d30>, '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 0x10fa0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbddb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:14:41 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 21:14:41 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 21:14:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:14:41 INFO - Return code: 0 21:14:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:14:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:14:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:14:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:14:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:14:43 INFO - Return code: 0 21:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 21:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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 21:14:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJKQwAs2X7/Render', 21:14:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:43 INFO - 'HOME': '/Users/cltbld', 21:14:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:43 INFO - 'LOGNAME': 'cltbld', 21:14:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:14:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:43 INFO - 'MOZ_NO_REMOTE': '1', 21:14:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:14:43 INFO - 'NO_EM_RESTART': '1', 21:14:43 INFO - 'PAGER': '/bin/cat', 21:14:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:43 INFO - 'PWD': '/builds/slave/test', 21:14:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:14:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:43 INFO - 'SHELL': '/bin/bash', 21:14:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l83c2aI3eG/Listeners', 21:14:43 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:14:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:43 INFO - 'USER': 'cltbld', 21:14:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:43 INFO - 'XPC_FLAGS': '0x0', 21:14:43 INFO - 'XPC_SERVICE_NAME': '0', 21:14:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 21:14:43 INFO - mozversion application_buildid: 20160213192017 21:14:43 INFO - mozversion application_changeset: e355cacefc881ba360d412853b57e8e060e966f4 21:14:43 INFO - mozversion application_display_name: Nightly 21:14:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:14:43 INFO - mozversion application_name: Firefox 21:14:43 INFO - mozversion application_remotingname: firefox 21:14:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:14:43 INFO - mozversion application_vendor: Mozilla 21:14:43 INFO - mozversion application_version: 47.0a1 21:14:43 INFO - mozversion platform_buildid: 20160213192017 21:14:43 INFO - mozversion platform_changeset: e355cacefc881ba360d412853b57e8e060e966f4 21:14:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:14:43 INFO - mozversion platform_version: 47.0a1 21:14:43 INFO - using testdate: 1455426883 21:14:43 INFO - actual date: 1455426883 21:14:43 INFO - starting webserver on 'localhost:51746' 21:14:43 INFO - SUITE-START | Running 2 tests 21:14:43 INFO - TEST-START | dromaeo_css 21:14:43 INFO - operating with platform_type : mac_ 21:14:43 INFO - Initialising browser for dromaeo_css test... 21:14:43 INFO - TEST-INFO | started process 2357 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp4m9cTu/profile http://localhost:51746/getInfo.html) 21:14:45 INFO - PROCESS | 2357 | __metrics Screen width/height:1600/1200 21:14:45 INFO - PROCESS | 2357 | colorDepth:24 21:14:45 INFO - PROCESS | 2357 | Browser inner width/height: 1024/689 21:14:45 INFO - PROCESS | 2357 | __metrics 21:14:45 INFO - PROCESS | 2357 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:14:45 INFO - PROCESS | 2357 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:14:46 INFO - TEST-INFO | 2357: exit 0 21:14:46 INFO - Browser initialized. 21:14:46 INFO - Running cycle 1/1 for dromaeo_css test... 21:14:46 INFO - TEST-INFO | started process 2360 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp4m9cTu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:14:58 INFO - PROCESS | 2360 | RSS: Main: 246329344 21:14:58 INFO - PROCESS | 2360 | 21:15:49 INFO - PROCESS | 2360 | 1455426949342 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] 21:18:00 INFO - PROCESS | 2360 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51746/tests/dromaeo/cssquery-ext.html) 21:18:01 INFO - PROCESS | 2360 | RSS: Main: 381038592 21:18:01 INFO - PROCESS | 2360 | 21:21:04 INFO - PROCESS | 2360 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-ext.html (next: http://localhost:51746/tests/dromaeo/cssquery-jquery.html) 21:21:04 INFO - PROCESS | 2360 | RSS: Main: 383008768 21:21:04 INFO - PROCESS | 2360 | 21:24:07 INFO - PROCESS | 2360 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51746/tests/dromaeo/cssquery-mootools.html) 21:24:07 INFO - PROCESS | 2360 | RSS: Main: 379121664 21:24:07 INFO - PROCESS | 2360 | 21:27:09 INFO - PROCESS | 2360 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51746/tests/dromaeo/cssquery-prototype.html) 21:27:10 INFO - PROCESS | 2360 | RSS: Main: 340439040 21:27:10 INFO - PROCESS | 2360 | 21:30:13 INFO - PROCESS | 2360 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51746/tests/dromaeo/cssquery-yui.html) 21:30:14 INFO - PROCESS | 2360 | RSS: Main: 348557312 21:30:14 INFO - PROCESS | 2360 | 21:33:17 INFO - PROCESS | 2360 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-yui.html (next: http://localhost:51746/tests/dromaeo/cssquery-dojo.html) 21:33:17 INFO - PROCESS | 2360 | RSS: Main: 384737280 21:33:17 INFO - PROCESS | 2360 | 21:33:17 INFO - PROCESS | 2360 | __start_tp_report 21:33:17 INFO - PROCESS | 2360 | _x_x_mozilla_page_load 21:33:17 INFO - PROCESS | 2360 | _x_x_mozilla_page_load_details 21:33:17 INFO - PROCESS | 2360 | |i|pagename|runs| 21:33:17 INFO - PROCESS | 2360 | |0;dojo.html;2822.280318518777;3457.4122399192133;3457.9654203457967;3508.8070156141403;3527.435610302352;5527.39198688144;5633.352164501073;5654.886902261952;5676.602637815349;5717.942820571799;5613.46672066154;5682.715864206793;5700.914486282709;5701.258836351269;5707.857303567413;5150.768215430306;5171.379434467869;5172.965406918613;5192.221166824968;5251.501107394811;5230.34620672416;5238.423773384925;5244.973775131119;5248.658837175591;5271.86820329491;5228.032813929435;5242.947570524284;5244.501772331641;5246.973765131169;5261.105612045962;5164.509371609691;5250.737463126867;5278.340207474066;5282.128448805962;5294.761735721863;5125.666831655931;5202.505761952609;5204.42751297357;5229.2417599448245;5329.0674132027125;4540.8637740867825;5661.1508273758855;5688.658680479143;5780.739866706008;5796.188533605298;6160.845978850564;6170.907436388457;6251;6268.655223962726;6274.090256912722;6195.5663103582765;6245.0320200369015;6255.96872015637;6256.843578910563;6262.091996660504;5725.484706376446;5839.270091238595;5848.824535263906;5854.882902341972;5867.383924687846;6229.252489701174;6237.594556353823;6296.055591661196;6300.747970081237;6309.936900631027;6144.5084393248435;6161.322254551996;6167;6181.1655426516845;6186.226721659793;6142.867137759686;6256.843578910563;6262.499000079983;6265.185525881606;6272.529560282997;6136.519078024463;6216.222972128484;6240;6249.6562689051625;6250;5354.866128346823;6203.348648391854;6223.013709533004;6260.5617606768;6266.404691554295;4851.830185943475;4914.926276105862;4926.556609905126;4934.407871055496;4987.675801072919;4295.591918767712;4331.0904710011255;4332.415123958225;4361.6074553290355;4364.192624364503;5560.499555039985;5569.470900264469;5574.554035677136;5584.413636568183;5590.91613625796;6148.077788331697;6152.384761523812;6200.131981522591;6210.378962103753;6220.222472190976;5715.48560629537;5733.885322293614;5740.397258287903;5744.052231381859;5767.221425107557;5371.973140134274;5376.838694839161;5382.569394448435;5391.622586418992;5393.946060539422;6216.937830621636;6256.343083976117;6258.3741625837965;6312.779052733133;6322.272938612118;6227;6248.4376406123665;6255.155554000152;6269.5611307208055;6281.623102613858;6337.4613157882095;6385.648789316632;6387.297397286387;6401.967990160019;6427.517936154901;5072.797088116434;6081.1486391906055;6149.354317796746;6197.907031394442;6208;6184.257889053342;6260.060990851409;6262.906056409066;6264.21697287839;6266.874662506633;5323.414424413389;5999.4900433463645;6153.353897840662;6173.81478555644;6174.413430724074;5986.521078313812;5998.430149135826;6038.365971572922;6058.878822423439;6108.918862504554;5880.8235752927485;5888.293404791281;5894.734736936934;5919.644821310735;5926.288845338587;6061.515078793774;6073.635581865102;6078.149059131813;6086.573939824169;6120.877582448237;5860.413958604276;5904;5912.615679980788;6005.309389420273;6100.359462256399 21:33:17 INFO - PROCESS | 2360 | |1;ext.html;455.4284373111746;473.59271026916855;524.9658173398403;572.8625129968809;613.4295105551837;30435.391292174172;38423.965483624204;39173.80413097938;39247.21505569891;39402.605973940255;41811.79094104533;42183.73448796533;42250.78874605623;42311.78844105775;42327.57672423275;9305.627774888997;9533.618655253817;9535.761605959837;9549.952250238739;9556;9507.714768556954;9620.663276785279;9648.179904708108;9654.5172741363;9673.90326096737;9634.229261659051;9729.562169702345;9730.562124704406;9737.610495580167;9776.657816976407;9583.904160958406;9680.370775899544;9692.854607180898;9701.90298097024;9708.320417570772;9453.480058596775;9600.135987761136;9613.230941524662;9613.855792163124;9615.23078153746;40089.19821603581;40509.987250318976;40552.188956221005;40558;40608;3117.579126817873;3335.499675048738;3402.8298585070647;3539.787612743218;3753.1555400035045;24112.432691874972;26744.732552674614;27749.445011099866;28339.716602833912;28475.57286640702;2568.948621027569;2773.4869049225754;2819.9013034543896;2866.2834291427143;2868.784841136923;420785;424227.8788606037;424997;425136;425180;61976.38023619706;66103.33896660972;66144;66146.33853661401;66234.33765662281;69710.65144674346;69776;69858.30141698518;69916.6504167476;69949.30050699427;16825;17064.890782099123;17064.914675426542;17067.658646826992;17069.573260668334;12945.611631651065;12998.740025199631;13036.739265214643;13039;13044.41300141496;19959.20163193485;20739.066741996645;20770.896145519477;20789.79210207909;20803.37589872306;8785.648574057093;8969;9017.909820901707;9019.278457723367;9036.367454278268;723.8451289597672;928.9581968811419;1073.4632683658172;1126.7915435644431;1127.7349822791637;28023.299417514725;28932.42135157285;29298;29439.411211775645;29619.555706664418;944.4852555357347;970.7718686108759;1085.7448499602588;1105.6406667832987;1114.6990312615549;14292.499762508261;14435.783463248059;16011.679766404606;16238.188090595659;16441.215389608577;631572;635902;638713;640214;641515;60129.79740405167;60375.39624603785;60402.395976040556;60502.69748651228;60545.69727151336;1323.702167012453;1325.8674132586857;1389.1179101270563;1427.7715565509468;1552.340255391454;21368;31105.844470778407;31107.68892311048;31278.843605781825;31946.68053319437;52749.7362513185;53308.2003769936;53358;53456.73271633617;53481.465185347646;507579;514120;514193.14517137373;515374;517779;42813.785931070146;43329.783351084305;43851;44034.55965440305;44074;44936.77531612321;45298.54701453075;45701.62895113152;46366.37717679865;46910.29634555416;36896.81551592225;38267.23465530729;39283.214335713696;39301;39892.2021559573;35718.64281357153;36132.638673613976;37587.81206093952;38166.80916595399;38585.42121868118;36119;36317.092072697335;36359.27281454409;37415.62584374121;37806.62193378141;30400;32802;32835.86531164874;32958;33291.83354083214;24909.003639854203;24948.875255623607;25071.749282506942;25542;25568.977240910157 21:33:17 INFO - PROCESS | 2360 | |2;jquery.html;295.9807612505187;349.9965000349997;357.8300307354007;363.13573694606816;371.70263788968816;14618.41526338948;14772.261386930664;18543.536411589717;18710.43868683938;19891.801081989175;15958.042517448961;17607;19381.93399363038;20623;21191;6179.351168127349;6423.261324947644;6438.259600145996;6439.388258115495;6446.355364463563;4626.843289177706;4872.902541949159;6355.396237357444;6452.387023232785;7154.356107950283;6214.161088253073;7243.818904527403;7456.627168641573;7459.104907411118;7459.254074592552;7079.398251148658;7436.962815185916;7448.441366897478;7457.403407727396;7463.925360746377;7022.403095736869;7024.613646249454;7027.332403421667;7038.824029399255;7040.014397984286;26452.86773566139;26462.735372646413;26487.867560662075;27270.181894543195;27641.723582764316;2413.3242692046256;2452.8037756979397;2556.9360765980814;2894.435585060914;3049.420610084077;12987.02597305206;13792.793108103386;15236.847631523764;15384.769228461582;15699.686006279924;1828.506303298102;1846.6399052184695;1903.8667293289336;1919.2323070771804;1954.775200851906;83057.16942830555;83566;84460.57769711173;98277.01722982821;106962.46518767434;17488.213030413663;19077.993621339676;19251.668374615598;19287.807121928883;19334.323298684478;27964.88140474399;27995.880164793587;28036.85981570079;28051.719482805318;28059.57910631342;7912.960435197787;8253.8349233015;8274.917250827415;8317;8322.875156872651;8286.295664868434;8303.95848020756;8312.33501319893;8376.204260595234;8402.537860417613;4061.147159096623;4322.502912165141;4404.053128577371;4406.823727050882;4459.9331010034875;1762.3831658919275;1792.103948025987;1816.1736409933712;1818.4544636608964;1818.4908225696827;897.5960817632092;898.6225785170244;934.7616357828846;935.4995077633433;938.9202417220251;17938.641227175383;18474.44576662702;18592.721109183374;19065.523361916064;19129.52176195606;772.8377040821377;965.498649599879;983.095552092077;988.7478692933256;1005.8390657494912;10176.592936282614;10464.319819211727;10471.581136754598;10495.842562361418;10496.055355018085;708946;728942.3552882308;743351.8497222546;745683;759636;78852;113595.43202283936;114341;115325.4233728826;116593;478.3685535093643;493.88146844757;494.53760733713375;1153.8846115388562;1207.3540655749132;10780.892191077988;10911.181661375269;10978.396188209406;11201.60794372193;11360.829587556029;48627.5137248623;49183.262251066975;49559.00881982412;49942.50057499524;54179.45820541744;64916;65424.34575654183;70296.29703702897;70829;73097;7250.274972502708;7323.267673232847;7577.583232922242;7610.238976102345;7785.260400261966;11125;11910.464029118884;12079.698007549881;12209.267443953391;12337.383130843242;8208.83582328362;9942.00579942;10339.276250662382;10444;10571.577136914437;8740.519271440131;10147.188224942134;10205.560581147225;10691;10798.190135739695;10043.69868903934;10441.425721585081;10779.407132607781;10879;10885.564577417132;7414.163143311559;7577.659005344663;7743.341815945708;7778.805529861799;7830.4518683691595;7824.1293072895905;10648.094911932263;10679.678985435574;10713.035826775627;10840.620578279722 21:33:17 INFO - PROCESS | 2360 | |3;mootools.html;1389.1456754096234;1489.4861272860862;1519.5365413548866;1741.9738703919443;1931.3723040012;6991.685374158163;7921.960390198048;8662.307015438766;8666.436681615698;8673.17604827542;8368.539730314831;8619.051904290523;8626.611802468888;8651.524166170859;8651.56742162891;2151.741790985084;2208.4920468292303;2394.772496612819;2446.3517167950463;2467.1365022242253;2448.6327050942323;2474.8020158387285;2483.0688491815567;2486.0304481252324;2486.8383555068863;2442.7190873049562;2469.604863221885;2473.75262473753;2476.4799392127584;2478.7273399925994;2139.368886178573;2193.8903054847356;2196.670499425083;2199.56008798241;2394;2436.573599620059;2469.296250568579;2469.4567195217023;2469.987650061756;2472.4807790364043;8504.532250726208;8568.914310856873;8569.914300856974;8570.27152692022;8574.056853746082;5220.660657057279;5331.040412725708;5346.1555763262;5348.545373643245;5388.865278368033;3553.182767963357;3560.3769340365334;3603.279344131158;3656.945145822788;3664.5602527696847;1044.6395993382348;1055.37205362809;1071.3036526257918;1075.8386242063675;1080.740622250662;11926.582569610022;11950.581729639507;11958.162928595002;11970;11985.52057917691;4702.835400760957;4793.448753393334;4794.161021821167;4838;4874.975625121922;10131.240156988108;10139.340942838839;10168.542415591317;10184.694459166089;10194.388336699822;5390.568754499631;5390.973045134828;5391.029614669397;5392.514673679388;5396.91904621431;4854.490278520704;4862.294967229732;4903.828366007173;4908.288298196741;4913.263010548446;3630.8547658093908;3719.3305205062807;3725.273571653556;3764.7176461765475;3807.600201978808;1174.4069245031376;1176.6234804862534;1183.3077649574923;1183.9171258011856;1186.2526608236756;1283.826683397748;1308.2804457548311;1334.9933250333881;1337.411538922871;1368.8015237790464;8011.118776934649;8052;8056.476329038711;8149.837003259901;8153.633086511121;1188.7979043562616;1198.5804968261214;1201.6335017819474;1211.2550781269456;1214.6173955204083;4806.2310030394965;5981.132735753378;6210.658413787285;6303.054541818672;6422.293547709748;10383.428911409945;10389.220808439397;10528.736781580368;10678.62624808128;10688.30526015822;10466.581336746598;10468.319559228627;10511.054005139575;10595.046445819758;10610.938906109483;7970.561619110888;8110.513369197867;8152.673893044331;8272.710455134042;8274.213949674771;6815.965920170367;8037.477563958324;8041.236082572146;8101.230383113595;8115.1479094694205;7781.844363112819;7981.8403631928195;9412.905870941477;9509.096635819586;9733.951330243304;9532.428054316762;9868.062534059252;10006.149477294512;10168.440735759605;10266.127379172854;6900.275471075665;7003.964980175067;7008;7035.296470352924;7044.260352662896;8024.799380015546;8050.959745201237;8061.9596902017465;8115.75652730419;8124.918750812416;7744.57404842739;7777.72777952769;7800.1419843816;7912.604369781603;7941.523508589503;7368.005319281829;7494.812629684301;7589.1272503660575;7597.544147351176;7642.388608911163;7570.470067095251;7601.619919003917;7652.96684947525;7684.385249180164;7708.4218683600075;6934.930650693428;7007.474439417166;7014.298570143149;7019.5788252705;7021.5787052777;7024.894626580503;7059.329363710439;7115.679794409368;7133.82165445868;7185.425165986604 21:33:17 INFO - PROCESS | 2360 | |4;prototype.html;315.9842007899605;322.70472517646357;326.38802245789145;331.14068990968445;334.93803646325415;4893.902121957568;6488.12410324606;6520.5109616778755;6538.444232240259;6586.8682626347445;6450.838729031777;6507.31673174317;6508.837279068014;6517.902231466532;6530.2816690164045;4804.159272127373;4823.252395878644;4842.564169224769;4851.611871050308;4857.635677324215;4687.484376718558;4799.808007679689;4834.057358815033;4839.225723884179;4859.861660869224;4766.404199475066;4778.1638213312535;4795.592374648159;4806.615470762348;4837.806487740486;4543.977280113579;4768.141734487791;4797.856064318076;4801.0157917626975;4815.783289751969;4011.0574015106426;4017.9196416071513;4071.124708187724;4076.4700588923547;4092.631663150331;6081.574289799716;6171.9691401542705;6202.069689546604;6216.222972128484;6222.937770622281;5181.171012637959;5321.73391330432;5374;5604.887902241973;5614.691191984439;6520.47836173105;6607.900881486781;6649.9692547655195;6682.164729408824;6825;3908.804559772;4574.062317224961;4598.563136502061;4599.701019433726;4604.447466304032;7021.508494405393;7258.782236532859;7327.267273272683;7332.816679582999;7333.376662983653;4477.6417886569;4524.9547504524535;4539.477960034572;4542.977285113553;4563.726176429358;4633.62930965522;4645.675982345016;4659.207934651117;4672.275797251432;4674.602658773974;4749.076623967229;5520.972395137998;5529.281193444826;5539.224508568804;5547.916781248285;6742.033095982331;6973.860522789516;6974.581525108409;6980.755673551402;6982.406495447843;1580.0519688187226;1602.8317026712261;1605.3257631794675;1605.654784221398;1609.2597405193508;951.7715748220377;970.9853203402321;1022.504085518523;1038.8337865941564;1041.7447725307347;5361.92761447712;6394.392532709385;6403.711832967528;6430.678466076677;6445.355464453611;7280.563166209939;7282.745103921337;7286.70853165878;7296.087989001375;7296.379807716404;6204.689765511706;6401;6414.069959855795;6419.454346380517;6433.1636887205295;3837.6929845612285;3869.3228684980577;3875.5736868944396;3881.86413475527;3889.397143442771;6062.363451837582;7625.351845093229;7641.69433222676;7654.4259180561685;7659.310662040443;7313.48805583604;7479.925200747923;7509.7371591994015;7510.511816731895;7513.962430187814;7652.923470765221;7690.384769218449;7694.037570651231;7699.730509432255;7706.344960678293;5997.700114994145;7367.300106489874;7373.852522949618;7382.52013619113;7388;6927.1687397510605;7146.392556632536;7159.8926016110845;7170.605616690923;7206.783796486114;7185.856282874209;7588.886166707614;7591.734289299848;7593;7594.924050759421;3980.6218409251073;4594.540545945512;4600.355950167046;4601.93097103537;4608.631309495166;6957.860842783217;7212.42300615939;7246.6376681164675;7254.6735396908325;7267.7819665410125;5949.494292984971;6840.41856442208;7039.401650859734;7049.400800931773;7058.505904586629;6739.258681544928;6995.090638217;7018.859622807618;7029.297070293134;7033.191183014019;6809;6859.657017149023;6885.758998435031;6896.689648965909;6921.826954326182;5657.349404818498;6018.759249629966;7046.929530704628;7054.118235220598;7061.6822243000215;6678.365555272241;6860.965695171492;6883.965580172067;6907.20567134786;6908.896366554606 21:33:17 INFO - PROCESS | 2360 | |5;yui.html;649.2792999770252;662.6289278004318;689.7551369263912;708.6385943168982;753.822851629867;13351.265680387587;15063.849361506382;15247.237638118077;15326.540203793904;15348.923255383736;13901.096428732151;13902.791458128111;13940.51208207713;13941.163530188196;13942.790858137136;850.3027517435721;864.312871267344;867.657275376226;868.5396739727922;870.4385671242045;703.1175874277774;712.4514124124421;831.1771346367113;858.8582883824162;858.9821062041501;852.6802449081595;886.472548833443;904.5386852705102;904.7873749668822;905.1627244798568;729.3581648149594;740.0601236429758;892.6340200517789;893.5532233883058;895.6730793260479;551.6414330685046;552.9032419326642;553.2724467325494;656.5207398599001;671.3051991189096;14932.925335373362;14937.954343195981;14942.477013304591;14943.476978305816;14945.551633451014;12435.191712538746;12554.623361299176;12565.874341256653;12775.48898044077;12841;10010.449425281606;10051.296409251356;10274.845877311845;10330.27688061836;10878.966498182739;3531.329047480996;3563.732720045981;3574.660407261306;3575.94636080459;3576.2847430514003;80025.79961300585;81457;83172.16827831705;83591.58204209001;83987.5800620993;7879.172686867796;9564.90435095654;9762.17021553176;9787.755306117404;10080.899191008142;22072.22747203872;22154.889225554092;22180.889095554743;22184.33446996593;22229.221977230718;7420.703171873065;7609.923900761032;7610.315071643578;7620.123685776096;7819.726309579138;3975.1453437511072;4060.2285565742413;4078.2659121358442;4083.3670781028395;4086.203190377848;3566.0906468850794;3616.5840928293055;3622.42041273395;3625.619309972415;3631.582368027711;660.5706290910946;663.7345061975152;677.298995539624;680.357062575861;698.1900994845954;519.158962480776;556.262951589146;581.1225050174268;596.2440612396451;604.6795198544778;8060.758177254692;8500.872486912702;8542.10307917672;8746.832664950834;8874.247640750033;465.3461886050105;512.3467578836938;555.0960206491692;594.9077892926604;606.4432105700038;3860.5946375630156;4064.248114098842;4119.217348703737;4178.6448151907425;4187.91624167515;94176;97096;98086.01913980769;98284.50857745665;98585.50707246418;72850;79824;80399.59800200962;81311.37377252422;81335.18664813276;63176.73646527136;63510.41223969438;63682.36317636857;64278.6786066076;64312.678436607515;8896.644134234817;8917.241929691532;8960.955195223982;8978.55107244622;9092.363534552518;37456.625433745314;47833.92157738826;48161.052652596525;50319.742006450135;50657.49342506528;62918;64257.35742642514;70510.64744676244;70842;70922.64538677274;8820.955895220482;10402.647655804696;11108.277961932448;11251.268667536911;11671.88328116708;10148.492575371349;11772.82340764872;12063.577774777841;12099.092568057255;12326.383680815745;11281.43592820372;11421.600243991421;11559.826602600799;11735.354555499189;11752.94123529411;11339.206255562032;11491.195616306779;11889.46497407636;11917.463714132711;12376.504939802307;6633.8209521083545;10316.845247321446;10998.780024399308;11086.223964322742;11392.430378480876;8367.748967530984;8489.4481858679;8704.911751680695;9078.409903356262;9662.565184566853;9818.312718109664;9833.4099954003;9868.654597089067;9878.456684882112;9906.702798916043 21:33:17 INFO - PROCESS | 2360 | __end_tp_report 21:33:17 INFO - PROCESS | 2360 | __start_cc_report 21:33:17 INFO - PROCESS | 2360 | _x_x_mozilla_cycle_collect,1189 21:33:17 INFO - PROCESS | 2360 | __end_cc_report 21:33:17 INFO - PROCESS | 2360 | __startTimestamp1455427997353__endTimestamp 21:33:17 INFO - PROCESS | 2360 | 21:33:17 INFO - PROCESS | 2360 | ------- Summary: start ------- 21:33:17 INFO - PROCESS | 2360 | Number of tests: 6 21:33:17 INFO - PROCESS | 2360 | 21:33:17 INFO - PROCESS | 2360 | [#0] dojo.html Cycles:165 Average:5720.61 Median:5904.00 stddev:652.31 (11.0%) stddev-sans-first:613.40 21:33:17 INFO - PROCESS | 2360 | Values: 2822.3 3457.4 3458.0 3508.8 3527.4 5527.4 5633.4 5654.9 5676.6 5717.9 5613.5 5682.7 5700.9 5701.3 5707.9 5150.8 5171.4 5173.0 5192.2 5251.5 5230.3 5238.4 5245.0 5248.7 5271.9 5228.0 5242.9 5244.5 5247.0 5261.1 5164.5 5250.7 5278.3 5282.1 5294.8 5125.7 5202.5 5204.4 5229.2 5329.1 4540.9 5661.2 5688.7 5780.7 5796.2 6160.8 6170.9 6251.0 6268.7 6274.1 6195.6 6245.0 6256.0 6256.8 6262.1 5725.5 5839.3 5848.8 5854.9 5867.4 6229.3 6237.6 6296.1 6300.7 6309.9 6144.5 6161.3 6167.0 6181.2 6186.2 6142.9 6256.8 6262.5 6265.2 6272.5 6136.5 6216.2 6240.0 6249.7 6250.0 5354.9 6203.3 6223.0 6260.6 6266.4 4851.8 4914.9 4926.6 4934.4 4987.7 4295.6 4331.1 4332.4 4361.6 4364.2 5560.5 5569.5 5574.6 5584.4 5590.9 6148.1 6152.4 6200.1 6210.4 6220.2 5715.5 5733.9 5740.4 5744.1 5767.2 5372.0 5376.8 5382.6 5391.6 5393.9 6216.9 6256.3 6258.4 6312.8 6322.3 6227.0 6248.4 6255.2 6269.6 6281.6 6337.5 6385.6 6387.3 6402.0 6427.5 5072.8 6081.1 6149.4 6197.9 6208.0 6184.3 6260.1 6262.9 6264.2 6266.9 5323.4 5999.5 6153.4 6173.8 6174.4 5986.5 5998.4 6038.4 6058.9 6108.9 5880.8 5888.3 5894.7 5919.6 5926.3 6061.5 6073.6 6078.1 6086.6 6120.9 5860.4 5904.0 5912.6 6005.3 6100.4 21:33:17 INFO - PROCESS | 2360 | 21:33:17 INFO - PROCESS | 2360 | [#1] ext.html Cycles:180 Average:67306.48 Median:41209.90 stddev:141995.84 (344.6%) stddev-sans-first:142305.47 21:33:17 INFO - PROCESS | 2360 | Values: 455.4 473.6 525.0 572.9 613.4 30435.4 38424.0 39173.8 39247.2 39402.6 41811.8 42183.7 42250.8 42311.8 42327.6 9305.6 9533.6 9535.8 9550.0 9556.0 9507.7 9620.7 9648.2 9654.5 9673.9 9634.2 9729.6 9730.6 9737.6 9776.7 9583.9 9680.4 9692.9 9701.9 9708.3 9453.5 9600.1 9613.2 9613.9 9615.2 40089.2 40510.0 40552.2 40558.0 40608.0 3117.6 3335.5 3402.8 3539.8 3753.2 24112.4 26744.7 27749.4 28339.7 28475.6 2568.9 2773.5 2819.9 2866.3 2868.8 420785.0 424227.9 424997.0 425136.0 425180.0 61976.4 66103.3 66144.0 66146.3 66234.3 69710.7 69776.0 69858.3 69916.7 69949.3 16825.0 17064.9 17064.9 17067.7 17069.6 12945.6 12998.7 13036.7 13039.0 13044.4 19959.2 20739.1 20770.9 20789.8 20803.4 8785.6 8969.0 9017.9 9019.3 9036.4 723.8 929.0 1073.5 1126.8 1127.7 28023.3 28932.4 29298.0 29439.4 29619.6 944.5 970.8 1085.7 1105.6 1114.7 14292.5 14435.8 16011.7 16238.2 16441.2 631572.0 635902.0 638713.0 640214.0 641515.0 60129.8 60375.4 60402.4 60502.7 60545.7 1323.7 1325.9 1389.1 1427.8 1552.3 21368.0 31105.8 31107.7 31278.8 31946.7 52749.7 53308.2 53358.0 53456.7 53481.5 507579.0 514120.0 514193.1 515374.0 517779.0 42813.8 43329.8 43851.0 44034.6 44074.0 44936.8 45298.5 45701.6 46366.4 46910.3 36896.8 38267.2 39283.2 39301.0 39892.2 35718.6 36132.6 37587.8 38166.8 38585.4 36119.0 36317.1 36359.3 37415.6 37806.6 30400.0 32802.0 32835.9 32958.0 33291.8 24909.0 24948.9 25071.7 25542.0 25569.0 21:33:17 INFO - PROCESS | 2360 | 21:33:17 INFO - PROCESS | 2360 | [#2] jquery.html Cycles:180 Average:37562.30 Median:353.91 stddev:121106.46 (34219.2%) stddev-sans-first:121413.87 21:33:17 INFO - PROCESS | 2360 | Values: 296.0 350.0 357.8 363.1 371.7 14618.4 14772.3 18543.5 18710.4 19891.8 15958.0 17607.0 19381.9 20623.0 21191.0 6179.4 6423.3 6438.3 6439.4 6446.4 4626.8 4872.9 6355.4 6452.4 7154.4 6214.2 7243.8 7456.6 7459.1 7459.3 7079.4 7437.0 7448.4 7457.4 7463.9 7022.4 7024.6 7027.3 7038.8 7040.0 26452.9 26462.7 26487.9 27270.2 27641.7 2413.3 2452.8 2556.9 2894.4 3049.4 12987.0 13792.8 15236.8 15384.8 15699.7 1828.5 1846.6 1903.9 1919.2 1954.8 83057.2 83566.0 84460.6 98277.0 106962.5 17488.2 19078.0 19251.7 19287.8 19334.3 27964.9 27995.9 28036.9 28051.7 28059.6 7913.0 8253.8 8274.9 8317.0 8322.9 8286.3 8304.0 8312.3 8376.2 8402.5 4061.1 4322.5 4404.1 4406.8 4459.9 1762.4 1792.1 1816.2 1818.5 1818.5 897.6 898.6 934.8 935.5 938.9 17938.6 18474.4 18592.7 19065.5 19129.5 772.8 965.5 983.1 988.7 1005.8 10176.6 10464.3 10471.6 10495.8 10496.1 708946.0 728942.4 743351.8 745683.0 759636.0 78852.0 113595.4 114341.0 115325.4 116593.0 478.4 493.9 494.5 1153.9 1207.4 10780.9 10911.2 10978.4 11201.6 11360.8 48627.5 49183.3 49559.0 49942.5 54179.5 64916.0 65424.3 70296.3 70829.0 73097.0 7250.3 7323.3 7577.6 7610.2 7785.3 11125.0 11910.5 12079.7 12209.3 12337.4 8208.8 9942.0 10339.3 10444.0 10571.6 8740.5 10147.2 10205.6 10691.0 10798.2 10043.7 10441.4 10779.4 10879.0 10885.6 7414.2 7577.7 7743.3 7778.8 7830.5 7824.1 10648.1 10679.7 10713.0 10840.6 21:33:17 INFO - PROCESS | 2360 | 21:33:17 INFO - PROCESS | 2360 | [#3] mootools.html Cycles:180 Average:5990.74 Median:4889.40 stddev:3159.19 (64.6%) stddev-sans-first:3149.12 21:33:17 INFO - PROCESS | 2360 | Values: 1389.1 1489.5 1519.5 1742.0 1931.4 6991.7 7922.0 8662.3 8666.4 8673.2 8368.5 8619.1 8626.6 8651.5 8651.6 2151.7 2208.5 2394.8 2446.4 2467.1 2448.6 2474.8 2483.1 2486.0 2486.8 2442.7 2469.6 2473.8 2476.5 2478.7 2139.4 2193.9 2196.7 2199.6 2394.0 2436.6 2469.3 2469.5 2470.0 2472.5 8504.5 8568.9 8569.9 8570.3 8574.1 5220.7 5331.0 5346.2 5348.5 5388.9 3553.2 3560.4 3603.3 3656.9 3664.6 1044.6 1055.4 1071.3 1075.8 1080.7 11926.6 11950.6 11958.2 11970.0 11985.5 4702.8 4793.4 4794.2 4838.0 4875.0 10131.2 10139.3 10168.5 10184.7 10194.4 5390.6 5391.0 5391.0 5392.5 5396.9 4854.5 4862.3 4903.8 4908.3 4913.3 3630.9 3719.3 3725.3 3764.7 3807.6 1174.4 1176.6 1183.3 1183.9 1186.3 1283.8 1308.3 1335.0 1337.4 1368.8 8011.1 8052.0 8056.5 8149.8 8153.6 1188.8 1198.6 1201.6 1211.3 1214.6 4806.2 5981.1 6210.7 6303.1 6422.3 10383.4 10389.2 10528.7 10678.6 10688.3 10466.6 10468.3 10511.1 10595.0 10610.9 7970.6 8110.5 8152.7 8272.7 8274.2 6816.0 8037.5 8041.2 8101.2 8115.1 7781.8 7981.8 9412.9 9509.1 9734.0 9532.4 9868.1 10006.1 10168.4 10266.1 6900.3 7004.0 7008.0 7035.3 7044.3 8024.8 8051.0 8062.0 8115.8 8124.9 7744.6 7777.7 7800.1 7912.6 7941.5 7368.0 7494.8 7589.1 7597.5 7642.4 7570.5 7601.6 7653.0 7684.4 7708.4 6934.9 7007.5 7014.3 7019.6 7021.6 7024.9 7059.3 7115.7 7133.8 7185.4 21:33:17 INFO - PROCESS | 2360 | 21:33:17 INFO - PROCESS | 2360 | [#4] prototype.html Cycles:180 Average:5666.76 Median:6425.07 stddev:1827.89 (28.4%) stddev-sans-first:1788.35 21:33:17 INFO - PROCESS | 2360 | Values: 316.0 322.7 326.4 331.1 334.9 4893.9 6488.1 6520.5 6538.4 6586.9 6450.8 6507.3 6508.8 6517.9 6530.3 4804.2 4823.3 4842.6 4851.6 4857.6 4687.5 4799.8 4834.1 4839.2 4859.9 4766.4 4778.2 4795.6 4806.6 4837.8 4544.0 4768.1 4797.9 4801.0 4815.8 4011.1 4017.9 4071.1 4076.5 4092.6 6081.6 6172.0 6202.1 6216.2 6222.9 5181.2 5321.7 5374.0 5604.9 5614.7 6520.5 6607.9 6650.0 6682.2 6825.0 3908.8 4574.1 4598.6 4599.7 4604.4 7021.5 7258.8 7327.3 7332.8 7333.4 4477.6 4525.0 4539.5 4543.0 4563.7 4633.6 4645.7 4659.2 4672.3 4674.6 4749.1 5521.0 5529.3 5539.2 5547.9 6742.0 6973.9 6974.6 6980.8 6982.4 1580.1 1602.8 1605.3 1605.7 1609.3 951.8 971.0 1022.5 1038.8 1041.7 5361.9 6394.4 6403.7 6430.7 6445.4 7280.6 7282.7 7286.7 7296.1 7296.4 6204.7 6401.0 6414.1 6419.5 6433.2 3837.7 3869.3 3875.6 3881.9 3889.4 6062.4 7625.4 7641.7 7654.4 7659.3 7313.5 7479.9 7509.7 7510.5 7514.0 7652.9 7690.4 7694.0 7699.7 7706.3 5997.7 7367.3 7373.9 7382.5 7388.0 6927.2 7146.4 7159.9 7170.6 7206.8 7185.9 7588.9 7591.7 7593.0 7594.9 3980.6 4594.5 4600.4 4601.9 4608.6 6957.9 7212.4 7246.6 7254.7 7267.8 5949.5 6840.4 7039.4 7049.4 7058.5 6739.3 6995.1 7018.9 7029.3 7033.2 6809.0 6859.7 6885.8 6896.7 6921.8 5657.3 6018.8 7046.9 7054.1 7061.7 6678.4 6861.0 6884.0 6907.2 6908.9 21:33:17 INFO - PROCESS | 2360 | 21:33:17 INFO - PROCESS | 2360 | [#5] yui.html Cycles:180 Average:18251.75 Median:605.56 stddev:25902.30 (4277.4%) stddev-sans-first:25941.24 21:33:17 INFO - PROCESS | 2360 | Values: 649.3 662.6 689.8 708.6 753.8 13351.3 15063.8 15247.2 15326.5 15348.9 13901.1 13902.8 13940.5 13941.2 13942.8 850.3 864.3 867.7 868.5 870.4 703.1 712.5 831.2 858.9 859.0 852.7 886.5 904.5 904.8 905.2 729.4 740.1 892.6 893.6 895.7 551.6 552.9 553.3 656.5 671.3 14932.9 14938.0 14942.5 14943.5 14945.6 12435.2 12554.6 12565.9 12775.5 12841.0 10010.4 10051.3 10274.8 10330.3 10879.0 3531.3 3563.7 3574.7 3575.9 3576.3 80025.8 81457.0 83172.2 83591.6 83987.6 7879.2 9564.9 9762.2 9787.8 10080.9 22072.2 22154.9 22180.9 22184.3 22229.2 7420.7 7609.9 7610.3 7620.1 7819.7 3975.1 4060.2 4078.3 4083.4 4086.2 3566.1 3616.6 3622.4 3625.6 3631.6 660.6 663.7 677.3 680.4 698.2 519.2 556.3 581.1 596.2 604.7 8060.8 8500.9 8542.1 8746.8 8874.2 465.3 512.3 555.1 594.9 606.4 3860.6 4064.2 4119.2 4178.6 4187.9 94176.0 97096.0 98086.0 98284.5 98585.5 72850.0 79824.0 80399.6 81311.4 81335.2 63176.7 63510.4 63682.4 64278.7 64312.7 8896.6 8917.2 8961.0 8978.6 9092.4 37456.6 47833.9 48161.1 50319.7 50657.5 62918.0 64257.4 70510.6 70842.0 70922.6 8821.0 10402.6 11108.3 11251.3 11671.9 10148.5 11772.8 12063.6 12099.1 12326.4 11281.4 11421.6 11559.8 11735.4 11752.9 11339.2 11491.2 11889.5 11917.5 12376.5 6633.8 10316.8 10998.8 11086.2 11392.4 8367.7 8489.4 8704.9 9078.4 9662.6 9818.3 9833.4 9868.7 9878.5 9906.7 21:33:17 INFO - PROCESS | 2360 | -------- Summary: end -------- 21:33:17 INFO - PROCESS | 2360 | 21:33:18 INFO - TEST-INFO | 2360: exit 0 21:33:18 INFO - TEST-OK | dromaeo_css | took 1114741ms 21:33:18 INFO - TEST-START | kraken 21:33:18 INFO - operating with platform_type : mac_ 21:33:18 INFO - Initialising browser for kraken test... 21:33:18 INFO - TEST-INFO | started process 2364 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp9VHk1n/profile http://localhost:51746/getInfo.html) 21:33:20 INFO - PROCESS | 2364 | __metrics Screen width/height:1600/1200 21:33:20 INFO - PROCESS | 2364 | colorDepth:24 21:33:20 INFO - PROCESS | 2364 | Browser inner width/height: 1024/689 21:33:20 INFO - PROCESS | 2364 | __metrics 21:33:20 INFO - PROCESS | 2364 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:33:20 INFO - PROCESS | 2364 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:33:20 INFO - TEST-INFO | 2364: exit 0 21:33:20 INFO - Browser initialized. 21:33:20 INFO - Running cycle 1/1 for kraken test... 21:33:20 INFO - TEST-INFO | started process 2366 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp9VHk1n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:33:32 INFO - PROCESS | 2366 | RSS: Main: 245993472 21:33:32 INFO - PROCESS | 2366 | 21:33:35 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51746/tests/kraken/driver.html?testName=audio-beat-detection) 21:33:36 INFO - PROCESS | 2366 | RSS: Main: 291368960 21:33:36 INFO - PROCESS | 2366 | 21:33:38 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51746/tests/kraken/driver.html?testName=audio-dft) 21:33:39 INFO - PROCESS | 2366 | RSS: Main: 302645248 21:33:39 INFO - PROCESS | 2366 | 21:33:42 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51746/tests/kraken/driver.html?testName=audio-fft) 21:33:43 INFO - PROCESS | 2366 | RSS: Main: 288174080 21:33:43 INFO - PROCESS | 2366 | 21:33:44 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51746/tests/kraken/driver.html?testName=audio-oscillator) 21:33:45 INFO - PROCESS | 2366 | RSS: Main: 292769792 21:33:45 INFO - PROCESS | 2366 | 21:33:47 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:33:48 INFO - PROCESS | 2366 | RSS: Main: 290562048 21:33:48 INFO - PROCESS | 2366 | 21:33:51 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51746/tests/kraken/driver.html?testName=imaging-darkroom) 21:33:51 INFO - PROCESS | 2366 | RSS: Main: 291061760 21:33:51 INFO - PROCESS | 2366 | 21:33:54 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51746/tests/kraken/driver.html?testName=imaging-desaturate) 21:33:55 INFO - PROCESS | 2366 | RSS: Main: 290983936 21:33:55 INFO - PROCESS | 2366 | 21:33:58 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51746/tests/kraken/driver.html?testName=json-parse-financial) 21:33:58 INFO - PROCESS | 2366 | RSS: Main: 290713600 21:33:58 INFO - PROCESS | 2366 | 21:34:00 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:34:00 INFO - PROCESS | 2366 | RSS: Main: 326701056 21:34:00 INFO - PROCESS | 2366 | 21:34:02 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:34:03 INFO - PROCESS | 2366 | RSS: Main: 325128192 21:34:03 INFO - PROCESS | 2366 | 21:34:05 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:34:06 INFO - PROCESS | 2366 | RSS: Main: 333467648 21:34:06 INFO - PROCESS | 2366 | 21:34:08 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:34:09 INFO - PROCESS | 2366 | RSS: Main: 333643776 21:34:09 INFO - PROCESS | 2366 | 21:34:11 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:34:12 INFO - PROCESS | 2366 | RSS: Main: 334331904 21:34:12 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51746/tests/kraken/driver.html?testName=ai-astar) 21:34:14 INFO - PROCESS | 2366 | RSS: Main: 394121216 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | __start_tp_report 21:34:14 INFO - PROCESS | 2366 | _x_x_mozilla_page_load 21:34:14 INFO - PROCESS | 2366 | _x_x_mozilla_page_load_details 21:34:14 INFO - PROCESS | 2366 | |i|pagename|runs| 21:34:14 INFO - PROCESS | 2366 | |0;ai-astar;110;108;112;124;111;112;115;112;111;112 21:34:14 INFO - PROCESS | 2366 | |1;audio-beat-detection;161;125;144;157;121;146;143;114;157;122 21:34:14 INFO - PROCESS | 2366 | |2;audio-dft;185;183;184;185;186;186;183;176;184;182 21:34:14 INFO - PROCESS | 2366 | |3;audio-fft;77;78;85;78;57;57;60;77;75;56 21:34:14 INFO - PROCESS | 2366 | |4;audio-oscillator;96;94;126;78;82;74;115;87;115;152 21:34:14 INFO - PROCESS | 2366 | |5;imaging-gaussian-blur;89;93;88;94;86;93;85;105;130;93 21:34:14 INFO - PROCESS | 2366 | |6;imaging-darkroom;94;95;94;96;95;93;95;94;95;95 21:34:14 INFO - PROCESS | 2366 | |7;imaging-desaturate;85;87;98;129;135;142;86;102;143;144 21:34:14 INFO - PROCESS | 2366 | |8;json-parse-financial;56;55;55;54;53;55;55;63;53;52 21:34:14 INFO - PROCESS | 2366 | |9;json-stringify-tinderbox;63;62;72;77;69;68;68;68;67;68 21:34:14 INFO - PROCESS | 2366 | |10;stanford-crypto-aes;84;84;82;83;83;82;83;82;85;81 21:34:14 INFO - PROCESS | 2366 | |11;stanford-crypto-ccm;128;126;127;111;126;131;121;134;121;130 21:34:14 INFO - PROCESS | 2366 | |12;stanford-crypto-pbkdf2;160;126;140;138;137;123;134;131;139;138 21:34:14 INFO - PROCESS | 2366 | |13;stanford-crypto-sha256-iterative;66;67;67;65;67;68;67;89;93;91 21:34:14 INFO - PROCESS | 2366 | __end_tp_report 21:34:14 INFO - PROCESS | 2366 | __start_cc_report 21:34:14 INFO - PROCESS | 2366 | _x_x_mozilla_cycle_collect,1118 21:34:14 INFO - PROCESS | 2366 | __end_cc_report 21:34:14 INFO - PROCESS | 2366 | __startTimestamp1455428054278__endTimestamp 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | ------- Summary: start ------- 21:34:14 INFO - PROCESS | 2366 | Number of tests: 14 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.00 stddev:4.35 (3.9%) stddev-sans-first:4.50 21:34:14 INFO - PROCESS | 2366 | Values: 110.0 108.0 112.0 124.0 111.0 112.0 115.0 112.0 111.0 112.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:145.00 stddev:17.18 (11.8%) stddev-sans-first:16.27 21:34:14 INFO - PROCESS | 2366 | Values: 161.0 125.0 144.0 157.0 121.0 146.0 143.0 114.0 157.0 122.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.50 stddev:2.91 (1.6%) stddev-sans-first:3.03 21:34:14 INFO - PROCESS | 2366 | Values: 185.0 183.0 184.0 185.0 186.0 186.0 183.0 176.0 184.0 182.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#3] audio-fft Cycles:10 Average:70.00 Median:77.00 stddev:11.11 (14.4%) stddev-sans-first:11.49 21:34:14 INFO - PROCESS | 2366 | Values: 77.0 78.0 85.0 78.0 57.0 57.0 60.0 77.0 75.0 56.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:80.00 stddev:24.72 (30.9%) stddev-sans-first:26.13 21:34:14 INFO - PROCESS | 2366 | Values: 96.0 94.0 126.0 78.0 82.0 74.0 115.0 87.0 115.0 152.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:91.00 stddev:13.33 (14.7%) stddev-sans-first:13.93 21:34:14 INFO - PROCESS | 2366 | Values: 89.0 93.0 88.0 94.0 86.0 93.0 85.0 105.0 130.0 93.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 21:34:14 INFO - PROCESS | 2366 | Values: 94.0 95.0 94.0 96.0 95.0 93.0 95.0 94.0 95.0 95.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#7] imaging-desaturate Cycles:10 Average:115.10 Median:114.50 stddev:25.68 (22.4%) stddev-sans-first:24.81 21:34:14 INFO - PROCESS | 2366 | Values: 85.0 87.0 98.0 129.0 135.0 142.0 86.0 102.0 143.0 144.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:3.03 (5.5%) stddev-sans-first:3.20 21:34:14 INFO - PROCESS | 2366 | Values: 56.0 55.0 55.0 54.0 53.0 55.0 55.0 63.0 53.0 52.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:4.21 (6.2%) stddev-sans-first:4.02 21:34:14 INFO - PROCESS | 2366 | Values: 63.0 62.0 72.0 77.0 69.0 68.0 68.0 68.0 67.0 68.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.20 (1.4%) stddev-sans-first:1.20 21:34:14 INFO - PROCESS | 2366 | Values: 84.0 84.0 82.0 83.0 83.0 82.0 83.0 82.0 85.0 81.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:127.50 stddev:6.52 (5.1%) stddev-sans-first:6.85 21:34:14 INFO - PROCESS | 2366 | Values: 128.0 126.0 127.0 111.0 126.0 131.0 121.0 134.0 121.0 130.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:138.00 stddev:10.02 (7.3%) stddev-sans-first:6.08 21:34:14 INFO - PROCESS | 2366 | Values: 160.0 126.0 140.0 138.0 137.0 123.0 134.0 131.0 139.0 138.0 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - PROCESS | 2366 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:67.50 stddev:11.79 (17.5%) stddev-sans-first:12.15 21:34:14 INFO - PROCESS | 2366 | Values: 66.0 67.0 67.0 65.0 67.0 68.0 67.0 89.0 93.0 91.0 21:34:14 INFO - PROCESS | 2366 | -------- Summary: end -------- 21:34:14 INFO - PROCESS | 2366 | 21:34:14 INFO - TEST-INFO | 2366: exit 0 21:34:15 INFO - TEST-OK | kraken | took 56992ms 21:34:15 INFO - SUITE-END | took 1171s 21:34:15 INFO - Completed test suite (00:19:32) 21:34:15 INFO - Working with test: dromaeo_css 21:34:15 INFO - Generating results file: dromaeo_css 21:34:15 INFO - Working with test: kraken 21:34:15 INFO - Generating results file: kraken 21:34:15 INFO - javascript benchmark 21:34:15 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:34:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 21:34:15 INFO - process_Request line: dromaeo_css 7549.89 graph.html#tests=[[72,1,59]] 21:34:15 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:34:15 INFO - process_Request line: kraken 1454.60 graph.html#tests=[[232,1,59]] 21:34:15 INFO - RETURN: dromaeo_css: 7549.89 21:34:15 INFO - RETURN: kraken: 1454.60 21:34:15 INFO - javascript benchmark 21:34:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2822.280318518777, 3457.4122399192133, 3457.9654203457967, 3508.8070156141403, 3527.435610302352, 5527.39198688144, 5633.352164501073, 5654.886902261952, 5676.602637815349, 5717.942820571799, 5613.46672066154, 5682.715864206793, 5700.914486282709, 5701.258836351269, 5707.857303567413, 5150.768215430306, 5171.379434467869, 5172.965406918613, 5192.221166824968, 5251.501107394811, 5230.34620672416, 5238.423773384925, 5244.973775131119, 5248.658837175591, 5271.86820329491, 5228.032813929435, 5242.947570524284, 5244.501772331641, 5246.973765131169, 5261.105612045962, 5164.509371609691, 5250.737463126867, 5278.340207474066, 5282.128448805962, 5294.761735721863, 5125.666831655931, 5202.505761952609, 5204.42751297357, 5229.2417599448245, 5329.0674132027125, 4540.8637740867825, 5661.1508273758855, 5688.658680479143, 5780.739866706008, 5796.188533605298, 6160.845978850564, 6170.907436388457, 6251.0, 6268.655223962726, 6274.090256912722, 6195.5663103582765, 6245.0320200369015, 6255.96872015637, 6256.843578910563, 6262.091996660504, 5725.484706376446, 5839.270091238595, 5848.824535263906, 5854.882902341972, 5867.383924687846, 6229.252489701174, 6237.594556353823, 6296.055591661196, 6300.747970081237, 6309.936900631027, 6144.5084393248435, 6161.322254551996, 6167.0, 6181.1655426516845, 6186.226721659793, 6142.867137759686, 6256.843578910563, 6262.499000079983, 6265.185525881606, 6272.529560282997, 6136.519078024463, 6216.222972128484, 6240.0, 6249.6562689051625, 6250.0, 5354.866128346823, 6203.348648391854, 6223.013709533004, 6260.5617606768, 6266.404691554295, 4851.830185943475, 4914.926276105862, 4926.556609905126, 4934.407871055496, 4987.675801072919, 4295.591918767712, 4331.0904710011255, 4332.415123958225, 4361.6074553290355, 4364.192624364503, 5560.499555039985, 5569.470900264469, 5574.554035677136, 5584.413636568183, 5590.91613625796, 6148.077788331697, 6152.384761523812, 6200.131981522591, 6210.378962103753, 6220.222472190976, 5715.48560629537, 5733.885322293614, 5740.397258287903, 5744.052231381859, 5767.221425107557, 5371.973140134274, 5376.838694839161, 5382.569394448435, 5391.622586418992, 5393.946060539422, 6216.937830621636, 6256.343083976117, 6258.3741625837965, 6312.779052733133, 6322.272938612118, 6227.0, 6248.4376406123665, 6255.155554000152, 6269.5611307208055, 6281.623102613858, 6337.4613157882095, 6385.648789316632, 6387.297397286387, 6401.967990160019, 6427.517936154901, 5072.797088116434, 6081.1486391906055, 6149.354317796746, 6197.907031394442, 6208.0, 6184.257889053342, 6260.060990851409, 6262.906056409066, 6264.21697287839, 6266.874662506633, 5323.414424413389, 5999.4900433463645, 6153.353897840662, 6173.81478555644, 6174.413430724074, 5986.521078313812, 5998.430149135826, 6038.365971572922, 6058.878822423439, 6108.918862504554, 5880.8235752927485, 5888.293404791281, 5894.734736936934, 5919.644821310735, 5926.288845338587, 6061.515078793774, 6073.635581865102, 6078.149059131813, 6086.573939824169, 6120.877582448237, 5860.413958604276, 5904.0, 5912.615679980788, 6005.309389420273, 6100.359462256399], "unit": "score", "name": "dojo.html", "value": 5678.97880647554}, {"lowerIsBetter": false, "replicates": [455.4284373111746, 473.59271026916855, 524.9658173398403, 572.8625129968809, 613.4295105551837, 30435.391292174172, 38423.965483624204, 39173.80413097938, 39247.21505569891, 39402.605973940255, 41811.79094104533, 42183.73448796533, 42250.78874605623, 42311.78844105775, 42327.57672423275, 9305.627774888997, 9533.618655253817, 9535.761605959837, 9549.952250238739, 9556.0, 9507.714768556954, 9620.663276785279, 9648.179904708108, 9654.5172741363, 9673.90326096737, 9634.229261659051, 9729.562169702345, 9730.562124704406, 9737.610495580167, 9776.657816976407, 9583.904160958406, 9680.370775899544, 9692.854607180898, 9701.90298097024, 9708.320417570772, 9453.480058596775, 9600.135987761136, 9613.230941524662, 9613.855792163124, 9615.23078153746, 40089.19821603581, 40509.987250318976, 40552.188956221005, 40558.0, 40608.0, 3117.579126817873, 3335.499675048738, 3402.8298585070647, 3539.787612743218, 3753.1555400035045, 24112.432691874972, 26744.732552674614, 27749.445011099866, 28339.716602833912, 28475.57286640702, 2568.948621027569, 2773.4869049225754, 2819.9013034543896, 2866.2834291427143, 2868.784841136923, 420785.0, 424227.8788606037, 424997.0, 425136.0, 425180.0, 61976.38023619706, 66103.33896660972, 66144.0, 66146.33853661401, 66234.33765662281, 69710.65144674346, 69776.0, 69858.30141698518, 69916.6504167476, 69949.30050699427, 16825.0, 17064.890782099123, 17064.914675426542, 17067.658646826992, 17069.573260668334, 12945.611631651065, 12998.740025199631, 13036.739265214643, 13039.0, 13044.41300141496, 19959.20163193485, 20739.066741996645, 20770.896145519477, 20789.79210207909, 20803.37589872306, 8785.648574057093, 8969.0, 9017.909820901707, 9019.278457723367, 9036.367454278268, 723.8451289597672, 928.9581968811419, 1073.4632683658172, 1126.7915435644431, 1127.7349822791637, 28023.299417514725, 28932.42135157285, 29298.0, 29439.411211775645, 29619.555706664418, 944.4852555357347, 970.7718686108759, 1085.7448499602588, 1105.6406667832987, 1114.6990312615549, 14292.499762508261, 14435.783463248059, 16011.679766404606, 16238.188090595659, 16441.215389608577, 631572.0, 635902.0, 638713.0, 640214.0, 641515.0, 60129.79740405167, 60375.39624603785, 60402.395976040556, 60502.69748651228, 60545.69727151336, 1323.702167012453, 1325.8674132586857, 1389.1179101270563, 1427.7715565509468, 1552.340255391454, 21368.0, 31105.844470778407, 31107.68892311048, 31278.843605781825, 31946.68053319437, 52749.7362513185, 53308.2003769936, 53358.0, 53456.73271633617, 53481.465185347646, 507579.0, 514120.0, 514193.14517137373, 515374.0, 517779.0, 42813.785931070146, 43329.783351084305, 43851.0, 44034.55965440305, 44074.0, 44936.77531612321, 45298.54701453075, 45701.62895113152, 46366.37717679865, 46910.29634555416, 36896.81551592225, 38267.23465530729, 39283.214335713696, 39301.0, 39892.2021559573, 35718.64281357153, 36132.638673613976, 37587.81206093952, 38166.80916595399, 38585.42121868118, 36119.0, 36317.092072697335, 36359.27281454409, 37415.62584374121, 37806.62193378141, 30400.0, 32802.0, 32835.86531164874, 32958.0, 33291.83354083214, 24909.003639854203, 24948.875255623607, 25071.749282506942, 25542.0, 25568.977240910157], "unit": "score", "name": "ext.html", "value": 20212.019211005343}, {"lowerIsBetter": false, "replicates": [295.9807612505187, 349.9965000349997, 357.8300307354007, 363.13573694606816, 371.70263788968816, 14618.41526338948, 14772.261386930664, 18543.536411589717, 18710.43868683938, 19891.801081989175, 15958.042517448961, 17607.0, 19381.93399363038, 20623.0, 21191.0, 6179.351168127349, 6423.261324947644, 6438.259600145996, 6439.388258115495, 6446.355364463563, 4626.843289177706, 4872.902541949159, 6355.396237357444, 6452.387023232785, 7154.356107950283, 6214.161088253073, 7243.818904527403, 7456.627168641573, 7459.104907411118, 7459.254074592552, 7079.398251148658, 7436.962815185916, 7448.441366897478, 7457.403407727396, 7463.925360746377, 7022.403095736869, 7024.613646249454, 7027.332403421667, 7038.824029399255, 7040.014397984286, 26452.86773566139, 26462.735372646413, 26487.867560662075, 27270.181894543195, 27641.723582764316, 2413.3242692046256, 2452.8037756979397, 2556.9360765980814, 2894.435585060914, 3049.420610084077, 12987.02597305206, 13792.793108103386, 15236.847631523764, 15384.769228461582, 15699.686006279924, 1828.506303298102, 1846.6399052184695, 1903.8667293289336, 1919.2323070771804, 1954.775200851906, 83057.16942830555, 83566.0, 84460.57769711173, 98277.01722982821, 106962.46518767434, 17488.213030413663, 19077.993621339676, 19251.668374615598, 19287.807121928883, 19334.323298684478, 27964.88140474399, 27995.880164793587, 28036.85981570079, 28051.719482805318, 28059.57910631342, 7912.960435197787, 8253.8349233015, 8274.917250827415, 8317.0, 8322.875156872651, 8286.295664868434, 8303.95848020756, 8312.33501319893, 8376.204260595234, 8402.537860417613, 4061.147159096623, 4322.502912165141, 4404.053128577371, 4406.823727050882, 4459.9331010034875, 1762.3831658919275, 1792.103948025987, 1816.1736409933712, 1818.4544636608964, 1818.4908225696827, 897.5960817632092, 898.6225785170244, 934.7616357828846, 935.4995077633433, 938.9202417220251, 17938.641227175383, 18474.44576662702, 18592.721109183374, 19065.523361916064, 19129.52176195606, 772.8377040821377, 965.498649599879, 983.095552092077, 988.7478692933256, 1005.8390657494912, 10176.592936282614, 10464.319819211727, 10471.581136754598, 10495.842562361418, 10496.055355018085, 708946.0, 728942.3552882308, 743351.8497222546, 745683.0, 759636.0, 78852.0, 113595.43202283936, 114341.0, 115325.4233728826, 116593.0, 478.3685535093643, 493.88146844757, 494.53760733713375, 1153.8846115388562, 1207.3540655749132, 10780.892191077988, 10911.181661375269, 10978.396188209406, 11201.60794372193, 11360.829587556029, 48627.5137248623, 49183.262251066975, 49559.00881982412, 49942.50057499524, 54179.45820541744, 64916.0, 65424.34575654183, 70296.29703702897, 70829.0, 73097.0, 7250.274972502708, 7323.267673232847, 7577.583232922242, 7610.238976102345, 7785.260400261966, 11125.0, 11910.464029118884, 12079.698007549881, 12209.267443953391, 12337.383130843242, 8208.83582328362, 9942.00579942, 10339.276250662382, 10444.0, 10571.577136914437, 8740.519271440131, 10147.188224942134, 10205.560581147225, 10691.0, 10798.190135739695, 10043.69868903934, 10441.425721585081, 10779.407132607781, 10879.0, 10885.564577417132, 7414.163143311559, 7577.659005344663, 7743.341815945708, 7778.805529861799, 7830.4518683691595, 7824.1293072895905, 10648.094911932263, 10679.678985435574, 10713.035826775627, 10840.620578279722], "unit": "score", "name": "jquery.html", "value": 9610.630423375153}, {"lowerIsBetter": false, "replicates": [1389.1456754096234, 1489.4861272860862, 1519.5365413548866, 1741.9738703919443, 1931.3723040012, 6991.685374158163, 7921.960390198048, 8662.307015438766, 8666.436681615698, 8673.17604827542, 8368.539730314831, 8619.051904290523, 8626.611802468888, 8651.524166170859, 8651.56742162891, 2151.741790985084, 2208.4920468292303, 2394.772496612819, 2446.3517167950463, 2467.1365022242253, 2448.6327050942323, 2474.8020158387285, 2483.0688491815567, 2486.0304481252324, 2486.8383555068863, 2442.7190873049562, 2469.604863221885, 2473.75262473753, 2476.4799392127584, 2478.7273399925994, 2139.368886178573, 2193.8903054847356, 2196.670499425083, 2199.56008798241, 2394.0, 2436.573599620059, 2469.296250568579, 2469.4567195217023, 2469.987650061756, 2472.4807790364043, 8504.532250726208, 8568.914310856873, 8569.914300856974, 8570.27152692022, 8574.056853746082, 5220.660657057279, 5331.040412725708, 5346.1555763262, 5348.545373643245, 5388.865278368033, 3553.182767963357, 3560.3769340365334, 3603.279344131158, 3656.945145822788, 3664.5602527696847, 1044.6395993382348, 1055.37205362809, 1071.3036526257918, 1075.8386242063675, 1080.740622250662, 11926.582569610022, 11950.581729639507, 11958.162928595002, 11970.0, 11985.52057917691, 4702.835400760957, 4793.448753393334, 4794.161021821167, 4838.0, 4874.975625121922, 10131.240156988108, 10139.340942838839, 10168.542415591317, 10184.694459166089, 10194.388336699822, 5390.568754499631, 5390.973045134828, 5391.029614669397, 5392.514673679388, 5396.91904621431, 4854.490278520704, 4862.294967229732, 4903.828366007173, 4908.288298196741, 4913.263010548446, 3630.8547658093908, 3719.3305205062807, 3725.273571653556, 3764.7176461765475, 3807.600201978808, 1174.4069245031376, 1176.6234804862534, 1183.3077649574923, 1183.9171258011856, 1186.2526608236756, 1283.826683397748, 1308.2804457548311, 1334.9933250333881, 1337.411538922871, 1368.8015237790464, 8011.118776934649, 8052.0, 8056.476329038711, 8149.837003259901, 8153.633086511121, 1188.7979043562616, 1198.5804968261214, 1201.6335017819474, 1211.2550781269456, 1214.6173955204083, 4806.2310030394965, 5981.132735753378, 6210.658413787285, 6303.054541818672, 6422.293547709748, 10383.428911409945, 10389.220808439397, 10528.736781580368, 10678.62624808128, 10688.30526015822, 10466.581336746598, 10468.319559228627, 10511.054005139575, 10595.046445819758, 10610.938906109483, 7970.561619110888, 8110.513369197867, 8152.673893044331, 8272.710455134042, 8274.213949674771, 6815.965920170367, 8037.477563958324, 8041.236082572146, 8101.230383113595, 8115.1479094694205, 7781.844363112819, 7981.8403631928195, 9412.905870941477, 9509.096635819586, 9733.951330243304, 9532.428054316762, 9868.062534059252, 10006.149477294512, 10168.440735759605, 10266.127379172854, 6900.275471075665, 7003.964980175067, 7008.0, 7035.296470352924, 7044.260352662896, 8024.799380015546, 8050.959745201237, 8061.9596902017465, 8115.75652730419, 8124.918750812416, 7744.57404842739, 7777.72777952769, 7800.1419843816, 7912.604369781603, 7941.523508589503, 7368.005319281829, 7494.812629684301, 7589.1272503660575, 7597.544147351176, 7642.388608911163, 7570.470067095251, 7601.619919003917, 7652.96684947525, 7684.385249180164, 7708.4218683600075, 6934.930650693428, 7007.474439417166, 7014.298570143149, 7019.5788252705, 7021.5787052777, 7024.894626580503, 7059.329363710439, 7115.679794409368, 7133.82165445868, 7185.425165986604], "unit": "score", "name": "mootools.html", "value": 4887.886924644089}, {"lowerIsBetter": false, "replicates": [315.9842007899605, 322.70472517646357, 326.38802245789145, 331.14068990968445, 334.93803646325415, 4893.902121957568, 6488.12410324606, 6520.5109616778755, 6538.444232240259, 6586.8682626347445, 6450.838729031777, 6507.31673174317, 6508.837279068014, 6517.902231466532, 6530.2816690164045, 4804.159272127373, 4823.252395878644, 4842.564169224769, 4851.611871050308, 4857.635677324215, 4687.484376718558, 4799.808007679689, 4834.057358815033, 4839.225723884179, 4859.861660869224, 4766.404199475066, 4778.1638213312535, 4795.592374648159, 4806.615470762348, 4837.806487740486, 4543.977280113579, 4768.141734487791, 4797.856064318076, 4801.0157917626975, 4815.783289751969, 4011.0574015106426, 4017.9196416071513, 4071.124708187724, 4076.4700588923547, 4092.631663150331, 6081.574289799716, 6171.9691401542705, 6202.069689546604, 6216.222972128484, 6222.937770622281, 5181.171012637959, 5321.73391330432, 5374.0, 5604.887902241973, 5614.691191984439, 6520.47836173105, 6607.900881486781, 6649.9692547655195, 6682.164729408824, 6825.0, 3908.804559772, 4574.062317224961, 4598.563136502061, 4599.701019433726, 4604.447466304032, 7021.508494405393, 7258.782236532859, 7327.267273272683, 7332.816679582999, 7333.376662983653, 4477.6417886569, 4524.9547504524535, 4539.477960034572, 4542.977285113553, 4563.726176429358, 4633.62930965522, 4645.675982345016, 4659.207934651117, 4672.275797251432, 4674.602658773974, 4749.076623967229, 5520.972395137998, 5529.281193444826, 5539.224508568804, 5547.916781248285, 6742.033095982331, 6973.860522789516, 6974.581525108409, 6980.755673551402, 6982.406495447843, 1580.0519688187226, 1602.8317026712261, 1605.3257631794675, 1605.654784221398, 1609.2597405193508, 951.7715748220377, 970.9853203402321, 1022.504085518523, 1038.8337865941564, 1041.7447725307347, 5361.92761447712, 6394.392532709385, 6403.711832967528, 6430.678466076677, 6445.355464453611, 7280.563166209939, 7282.745103921337, 7286.70853165878, 7296.087989001375, 7296.379807716404, 6204.689765511706, 6401.0, 6414.069959855795, 6419.454346380517, 6433.1636887205295, 3837.6929845612285, 3869.3228684980577, 3875.5736868944396, 3881.86413475527, 3889.397143442771, 6062.363451837582, 7625.351845093229, 7641.69433222676, 7654.4259180561685, 7659.310662040443, 7313.48805583604, 7479.925200747923, 7509.7371591994015, 7510.511816731895, 7513.962430187814, 7652.923470765221, 7690.384769218449, 7694.037570651231, 7699.730509432255, 7706.344960678293, 5997.700114994145, 7367.300106489874, 7373.852522949618, 7382.52013619113, 7388.0, 6927.1687397510605, 7146.392556632536, 7159.8926016110845, 7170.605616690923, 7206.783796486114, 7185.856282874209, 7588.886166707614, 7591.734289299848, 7593.0, 7594.924050759421, 3980.6218409251073, 4594.540545945512, 4600.355950167046, 4601.93097103537, 4608.631309495166, 6957.860842783217, 7212.42300615939, 7246.6376681164675, 7254.6735396908325, 7267.7819665410125, 5949.494292984971, 6840.41856442208, 7039.401650859734, 7049.400800931773, 7058.505904586629, 6739.258681544928, 6995.090638217, 7018.859622807618, 7029.297070293134, 7033.191183014019, 6809.0, 6859.657017149023, 6885.758998435031, 6896.689648965909, 6921.826954326182, 5657.349404818498, 6018.759249629966, 7046.929530704628, 7054.118235220598, 7061.6822243000215, 6678.365555272241, 6860.965695171492, 6883.965580172067, 6907.20567134786, 6908.896366554606], "unit": "score", "name": "prototype.html", "value": 5055.53052940459}, {"lowerIsBetter": false, "replicates": [649.2792999770252, 662.6289278004318, 689.7551369263912, 708.6385943168982, 753.822851629867, 13351.265680387587, 15063.849361506382, 15247.237638118077, 15326.540203793904, 15348.923255383736, 13901.096428732151, 13902.791458128111, 13940.51208207713, 13941.163530188196, 13942.790858137136, 850.3027517435721, 864.312871267344, 867.657275376226, 868.5396739727922, 870.4385671242045, 703.1175874277774, 712.4514124124421, 831.1771346367113, 858.8582883824162, 858.9821062041501, 852.6802449081595, 886.472548833443, 904.5386852705102, 904.7873749668822, 905.1627244798568, 729.3581648149594, 740.0601236429758, 892.6340200517789, 893.5532233883058, 895.6730793260479, 551.6414330685046, 552.9032419326642, 553.2724467325494, 656.5207398599001, 671.3051991189096, 14932.925335373362, 14937.954343195981, 14942.477013304591, 14943.476978305816, 14945.551633451014, 12435.191712538746, 12554.623361299176, 12565.874341256653, 12775.48898044077, 12841.0, 10010.449425281606, 10051.296409251356, 10274.845877311845, 10330.27688061836, 10878.966498182739, 3531.329047480996, 3563.732720045981, 3574.660407261306, 3575.94636080459, 3576.2847430514003, 80025.79961300585, 81457.0, 83172.16827831705, 83591.58204209001, 83987.5800620993, 7879.172686867796, 9564.90435095654, 9762.17021553176, 9787.755306117404, 10080.899191008142, 22072.22747203872, 22154.889225554092, 22180.889095554743, 22184.33446996593, 22229.221977230718, 7420.703171873065, 7609.923900761032, 7610.315071643578, 7620.123685776096, 7819.726309579138, 3975.1453437511072, 4060.2285565742413, 4078.2659121358442, 4083.3670781028395, 4086.203190377848, 3566.0906468850794, 3616.5840928293055, 3622.42041273395, 3625.619309972415, 3631.582368027711, 660.5706290910946, 663.7345061975152, 677.298995539624, 680.357062575861, 698.1900994845954, 519.158962480776, 556.262951589146, 581.1225050174268, 596.2440612396451, 604.6795198544778, 8060.758177254692, 8500.872486912702, 8542.10307917672, 8746.832664950834, 8874.247640750033, 465.3461886050105, 512.3467578836938, 555.0960206491692, 594.9077892926604, 606.4432105700038, 3860.5946375630156, 4064.248114098842, 4119.217348703737, 4178.6448151907425, 4187.91624167515, 94176.0, 97096.0, 98086.01913980769, 98284.50857745665, 98585.50707246418, 72850.0, 79824.0, 80399.59800200962, 81311.37377252422, 81335.18664813276, 63176.73646527136, 63510.41223969438, 63682.36317636857, 64278.6786066076, 64312.678436607515, 8896.644134234817, 8917.241929691532, 8960.955195223982, 8978.55107244622, 9092.363534552518, 37456.625433745314, 47833.92157738826, 48161.052652596525, 50319.742006450135, 50657.49342506528, 62918.0, 64257.35742642514, 70510.64744676244, 70842.0, 70922.64538677274, 8820.955895220482, 10402.647655804696, 11108.277961932448, 11251.268667536911, 11671.88328116708, 10148.492575371349, 11772.82340764872, 12063.577774777841, 12099.092568057255, 12326.383680815745, 11281.43592820372, 11421.600243991421, 11559.826602600799, 11735.354555499189, 11752.94123529411, 11339.206255562032, 11491.195616306779, 11889.46497407636, 11917.463714132711, 12376.504939802307, 6633.8209521083545, 10316.845247321446, 10998.780024399308, 11086.223964322742, 11392.430378480876, 8367.748967530984, 8489.4481858679, 8704.911751680695, 9078.409903356262, 9662.565184566853, 9818.312718109664, 9833.4099954003, 9868.654597089067, 9878.456684882112, 9906.702798916043], "unit": "score", "name": "yui.html", "value": 6793.420804282277}], "name": "dromaeo_css", "value": 7549.893399037104}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 112.0, 124.0, 111.0, 112.0, 115.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [161.0, 125.0, 144.0, 157.0, 121.0, 146.0, 143.0, 114.0, 157.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 139.0}, {"lowerIsBetter": true, "replicates": [185.0, 183.0, 184.0, 185.0, 186.0, 186.0, 183.0, 176.0, 184.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.4}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 85.0, 78.0, 57.0, 57.0, 60.0, 77.0, 75.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.0}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 126.0, 78.0, 82.0, 74.0, 115.0, 87.0, 115.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 101.9}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 88.0, 94.0, 86.0, 93.0, 85.0, 105.0, 130.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 94.0, 96.0, 95.0, 93.0, 95.0, 94.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 94.6}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 98.0, 129.0, 135.0, 142.0, 86.0, 102.0, 143.0, 144.0], "unit": "score", "name": "imaging-desaturate", "value": 115.1}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 54.0, 53.0, 55.0, 55.0, 63.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 72.0, 77.0, 69.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 82.0, 83.0, 83.0, 82.0, 83.0, 82.0, 85.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [128.0, 126.0, 127.0, 111.0, 126.0, 131.0, 121.0, 134.0, 121.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [160.0, 126.0, 140.0, 138.0, 137.0, 123.0, 134.0, 131.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 65.0, 67.0, 68.0, 67.0, 89.0, 93.0, 91.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.0}], "name": "kraken", "value": 1454.6000000000001}]} 21:34:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1454.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7549.89"}}} 21:34:15 INFO - Return code: 0 21:34:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:34:15 INFO - # TBPL SUCCESS # 21:34:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:34:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:34:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:34:15 INFO - 2016-02-13 21:34:15.662 screenresolution[2370:23618] starting screenresolution argv=screenresolution get 21:34:15 INFO - 2016-02-13 21:34:15.665 screenresolution[2370:23618] Display 0: 1600x1200x32@60 21:34:15 INFO - 2016-02-13 21:34:15.671 screenresolution[2371:23621] starting screenresolution argv=screenresolution list 21:34:15 INFO - Available Modes on Display 0 21:34:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:34:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:34:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:34:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:34:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:34:15 INFO - Intel Iris: 21:34:15 INFO - Chipset Model: Intel Iris 21:34:15 INFO - Type: GPU 21:34:15 INFO - Bus: Built-In 21:34:15 INFO - VRAM (Dynamic, Max): 1536 MB 21:34:15 INFO - Vendor: Intel (0x8086) 21:34:15 INFO - Device ID: 0x0a2e 21:34:15 INFO - Revision ID: 0x0009 21:34:15 INFO - Displays: 21:34:15 INFO - Display: 21:34:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:34:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:34:15 INFO - Display Serial Number: 1600x1200 60 21:34:15 INFO - Main Display: Yes 21:34:15 INFO - Mirror: Off 21:34:15 INFO - Online: Yes 21:34:15 INFO - Rotation: Supported 21:34:15 INFO - Return code: 0 21:34:15 INFO - Running post-action listener: _resource_record_post_action 21:34:15 INFO - Running post-run listener: _resource_record_post_run 21:34:16 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 352256; Write bytes: 708471808; Read time: 3; Write time: 2051 21:34:16 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401078784; Write bytes: 395834880; Read time: 30074; Write time: 745 21:34:16 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 352256; Write bytes: 301086208; Read time: 3; Write time: 1254 21:34:16 INFO - Running post-run listener: _upload_blobber_files 21:34:16 INFO - Blob upload gear active. 21:34:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:34:16 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 21:34:16 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:34:16 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:34:17 INFO - (blobuploader) - INFO - Open directory for files ... 21:34:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:34:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:34:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:18 INFO - (blobuploader) - INFO - Done attempting. 21:34:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:34:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:34:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:19 INFO - (blobuploader) - INFO - Done attempting. 21:34:19 INFO - (blobuploader) - INFO - Iteration through files over. 21:34:19 INFO - Return code: 0 21:34:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:34:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:34:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/939666b8b81099b3ce1c2e900cfae2161f16b1b8ec78a7d50d28961c0bc7b6f4f7192418e5fe856eb73327869f97b3a2a9a1200e4d3465d905c6ba46c637cc88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50411127827726e4d7864fc86adf4ba17a40aaeeeb02255d7cd593da575e9778e6827a3d066bd70328958184c42dc34bf4cd3ebf2a199ac2a723cdd98e97540d"} 21:34:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:34:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:34:19 INFO - Contents: 21:34:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/939666b8b81099b3ce1c2e900cfae2161f16b1b8ec78a7d50d28961c0bc7b6f4f7192418e5fe856eb73327869f97b3a2a9a1200e4d3465d905c6ba46c637cc88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50411127827726e4d7864fc86adf4ba17a40aaeeeb02255d7cd593da575e9778e6827a3d066bd70328958184c42dc34bf4cd3ebf2a199ac2a723cdd98e97540d"} 21:34:19 INFO - Running post-run listener: copy_logs_to_upload_dir 21:34:19 INFO - Copying logs to upload dir... 21:34:19 INFO - mkdir: /builds/slave/test/build/upload/logs 21:34:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.370968 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-02-13 21:34:19.303731) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 21:34:19.306789) ========= 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.SJKQwAs2X7/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.l83c2aI3eG/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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/Firefox/sha512/939666b8b81099b3ce1c2e900cfae2161f16b1b8ec78a7d50d28961c0bc7b6f4f7192418e5fe856eb73327869f97b3a2a9a1200e4d3465d905c6ba46c637cc88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50411127827726e4d7864fc86adf4ba17a40aaeeeb02255d7cd593da575e9778e6827a3d066bd70328958184c42dc34bf4cd3ebf2a199ac2a723cdd98e97540d"} build_url:https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/LmeiSUq7QF6UBRm3jX5Mtg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/939666b8b81099b3ce1c2e900cfae2161f16b1b8ec78a7d50d28961c0bc7b6f4f7192418e5fe856eb73327869f97b3a2a9a1200e4d3465d905c6ba46c637cc88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50411127827726e4d7864fc86adf4ba17a40aaeeeb02255d7cd593da575e9778e6827a3d066bd70328958184c42dc34bf4cd3ebf2a199ac2a723cdd98e97540d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 21:34:19.334989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 21:34:19.335283) ========= 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.SJKQwAs2X7/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.l83c2aI3eG/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005105 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 21:34:19.384171) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 21:34:19.384485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 21:34:19.384868) ========= ========= Total master_lag: 0.28 =========