builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0082 starttime: 1455801381.43 results: success (0) buildid: 20160218030343 builduid: 34942056434347afba9e2f31af1df6ef revision: 1150ac4755c7bb35df4fc7504f6f1b6c257f400e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.431266) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.431955) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.432263) ========= 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.h3t04WEyOd/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.QNqqsZA96D/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005808 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.457060) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.457375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.475381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.475722) ========= 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.h3t04WEyOd/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.QNqqsZA96D/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005227 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.523865) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.524528) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.524883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.525193) ========= 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.h3t04WEyOd/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.QNqqsZA96D/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-18 05:16:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.24M=0.002s 2016-02-18 05:16:21 (7.24 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.699214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.699539) ========= 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.h3t04WEyOd/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.QNqqsZA96D/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.019738 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:21.747943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 05:16:21.748303) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1150ac4755c7bb35df4fc7504f6f1b6c257f400e --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 1150ac4755c7bb35df4fc7504f6f1b6c257f400e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h3t04WEyOd/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.QNqqsZA96D/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-18 05:16:21,721 truncating revision to first 12 chars 2016-02-18 05:16:21,721 Setting DEBUG logging. 2016-02-18 05:16:21,721 attempt 1/10 2016-02-18 05:16:21,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1150ac4755c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 05:16:22,925 unpacking tar archive at: mozilla-central-1150ac4755c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.448219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 05:16:23.212245) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:23.212627) ========= echo 1150ac4755c7bb35df4fc7504f6f1b6c257f400e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1150ac4755c7bb35df4fc7504f6f1b6c257f400e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h3t04WEyOd/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.QNqqsZA96D/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 1150ac4755c7bb35df4fc7504f6f1b6c257f400e program finished with exit code 0 elapsedTime=0.004968 script_repo_revision: '1150ac4755c7bb35df4fc7504f6f1b6c257f400e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:23.262981) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:23.263298) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 05:16:23.276690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-18 05:16:23.277083) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.h3t04WEyOd/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.QNqqsZA96D/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:16:23 INFO - MultiFileLogger online at 20160218 05:16:23 in /builds/slave/test 05:16:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:16:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:23 INFO - {'append_to_log': False, 05:16:23 INFO - 'base_work_dir': '/builds/slave/test', 05:16:23 INFO - 'blob_upload_branch': 'Firefox', 05:16:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:23 INFO - 'branch': 'Firefox', 05:16:23 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:23 INFO - 'config_files': ('talos/mac_config.py',), 05:16:23 INFO - 'default_actions': ('clobber', 05:16:23 INFO - 'read-buildbot-config', 05:16:23 INFO - 'download-and-extract', 05:16:23 INFO - 'populate-webroot', 05:16:23 INFO - 'create-virtualenv', 05:16:23 INFO - 'install', 05:16:23 INFO - 'run-tests'), 05:16:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:23 INFO - 'download_minidump_stackwalk': True, 05:16:23 INFO - 'download_symbols': 'ondemand', 05:16:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:23 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:23 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:23 INFO - 'installer_path': 'installer.exe', 05:16:23 INFO - 'log_level': 'info', 05:16:23 INFO - 'log_name': 'talos', 05:16:23 INFO - 'log_to_console': True, 05:16:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:16:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:16:23 INFO - 'opt_config_files': (), 05:16:23 INFO - 'pip_index': False, 05:16:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:23 INFO - 'cmd': ('bash', 05:16:23 INFO - '-c', 05:16:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:23 INFO - 'enabled': True, 05:16:23 INFO - 'halt_on_failure': False, 05:16:23 INFO - 'name': 'check_screen_resolution'},), 05:16:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:23 INFO - 'cmd': ('bash', 05:16:23 INFO - '-c', 05:16:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:23 INFO - 'enabled': True, 05:16:23 INFO - 'halt_on_failure': False, 05:16:23 INFO - 'name': 'check_screen_resolution'},), 05:16:23 INFO - 'run_cmd_checks_enabled': True, 05:16:23 INFO - 'sps_profile': False, 05:16:23 INFO - 'sps_profile_interval': 0, 05:16:23 INFO - 'suite': 'dromaeojs-e10s', 05:16:23 INFO - 'system_bits': '32', 05:16:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:23 INFO - 'title': 't-yosemite-r7-0082', 05:16:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:23 INFO - 'use_talos_json': True, 05:16:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:23 INFO - 'work_dir': 'build'} 05:16:23 INFO - ##### 05:16:23 INFO - ##### Running clobber step. 05:16:23 INFO - ##### 05:16:23 INFO - Running pre-action listener: _resource_record_pre_action 05:16:23 INFO - Running main action method: clobber 05:16:23 INFO - rmtree: /builds/slave/test/build 05:16:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:23 INFO - Running post-action listener: _resource_record_post_action 05:16:23 INFO - ##### 05:16:23 INFO - ##### Running read-buildbot-config step. 05:16:23 INFO - ##### 05:16:23 INFO - Running pre-action listener: _resource_record_pre_action 05:16:23 INFO - Running main action method: read_buildbot_config 05:16:23 INFO - Using buildbot properties: 05:16:23 INFO - { 05:16:23 INFO - "project": "", 05:16:23 INFO - "product": "firefox", 05:16:23 INFO - "script_repo_revision": "production", 05:16:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:16:23 INFO - "repository": "", 05:16:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:16:23 INFO - "buildid": "20160218030343", 05:16:23 INFO - "pgo_build": "False", 05:16:23 INFO - "basedir": "/builds/slave/test", 05:16:23 INFO - "buildnumber": 111, 05:16:23 INFO - "slavename": "t-yosemite-r7-0082", 05:16:23 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:16:23 INFO - "platform": "yosemite_r7", 05:16:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:16:23 INFO - "branch": "mozilla-central", 05:16:23 INFO - "repo_path": "mozilla-central", 05:16:23 INFO - "revision": "1150ac4755c7bb35df4fc7504f6f1b6c257f400e", 05:16:23 INFO - "stage_platform": "macosx64", 05:16:23 INFO - "builduid": "34942056434347afba9e2f31af1df6ef", 05:16:23 INFO - "slavebuilddir": "test" 05:16:23 INFO - } 05:16:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:16:23 INFO - Running post-action listener: _resource_record_post_action 05:16:23 INFO - ##### 05:16:23 INFO - ##### Running download-and-extract step. 05:16:23 INFO - ##### 05:16:23 INFO - Running pre-action listener: _resource_record_pre_action 05:16:23 INFO - Running main action method: download_and_extract 05:16:23 INFO - mkdir: /builds/slave/test/build/tests 05:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:23 INFO - https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:16:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/test_packages.json 05:16:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/test_packages.json 05:16:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:16:24 INFO - Downloaded 1277 bytes. 05:16:24 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:16:24 INFO - Using the following test package requirements: 05:16:24 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:16:24 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:24 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:16:24 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:24 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:16:24 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:24 INFO - u'jsshell-mac.zip'], 05:16:24 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:24 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:16:24 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:16:24 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:24 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:16:24 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:24 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:16:24 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:24 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:16:24 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:16:24 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:24 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:16:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:16: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')]} 05:16:24 INFO - https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:16:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:16:25 INFO - Downloaded 17807336 bytes. 05:16:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:16:28 INFO - Return code: 0 05:16:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:28 INFO - https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:16:29 INFO - Downloaded 17807336 bytes. 05:16:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:16:33 INFO - Return code: 0 05:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:33 INFO - https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:16:34 INFO - Downloaded 10707071 bytes. 05:16:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:16:34 INFO - Return code: 0 05:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:34 INFO - https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 05:16:37 INFO - Downloaded 111345279 bytes. 05:16:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:16:37 INFO - mkdir: /builds/slave/test/properties 05:16:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:37 INFO - Contents: 05:16:37 INFO - build_url:https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:16:38 INFO - Running post-action listener: _resource_record_post_action 05:16:38 INFO - Running post-action listener: set_extra_try_arguments 05:16:38 INFO - ##### 05:16:38 INFO - ##### Running populate-webroot step. 05:16:38 INFO - ##### 05:16:38 INFO - Running pre-action listener: _resource_record_pre_action 05:16:38 INFO - Running main action method: populate_webroot 05:16:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:38 INFO - '--tppagecycles', 05:16:38 INFO - '7'], 05:16:38 INFO - 'tests': ['tsvgm']}}, 05:16:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:16:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:16:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:16:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:16:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:38 INFO - 'talos_options': ['--e10s'], 05:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:38 INFO - 'tests': ['damp', 'tps']}, 05:16:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:38 INFO - 'talos_options': ['--e10s'], 05:16:38 INFO - 'tests': ['damp', 'tps']}, 05:16:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:16:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:38 INFO - 'other': {'tests': ['a11yr', 05:16:38 INFO - 'ts_paint', 05:16:38 INFO - 'tpaint', 05:16:38 INFO - 'sessionrestore', 05:16:38 INFO - 'sessionrestore_no_auto_restore']}, 05:16:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:16:38 INFO - 'tests': ['a11yr', 05:16:38 INFO - 'ts_paint', 05:16:38 INFO - 'tpaint', 05:16:38 INFO - 'sessionrestore', 05:16:38 INFO - 'sessionrestore_no_auto_restore']}, 05:16:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:16:38 INFO - 'tests': ['a11yr', 05:16:38 INFO - 'ts_paint', 05:16:38 INFO - 'tpaint', 05:16:38 INFO - 'sessionrestore', 05:16:38 INFO - 'sessionrestore_no_auto_restore']}, 05:16:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:16:38 INFO - 'tests': ['a11yr', 05:16:38 INFO - 'ts_paint', 05:16:38 INFO - 'tpaint', 05:16:38 INFO - 'sessionrestore', 05:16:38 INFO - 'sessionrestore_no_auto_restore']}, 05:16:38 INFO - 'other_l64': {'tests': ['a11yr', 05:16:38 INFO - 'ts_paint', 05:16:38 INFO - 'tpaint', 05:16:38 INFO - 'sessionrestore', 05:16:38 INFO - 'sessionrestore_no_auto_restore']}, 05:16:38 INFO - 'other_nol64': {'tests': ['a11yr', 05:16:38 INFO - 'ts_paint', 05:16:38 INFO - 'tpaint', 05:16:38 INFO - 'sessionrestore', 05:16:38 INFO - 'sessionrestore_no_auto_restore']}, 05:16:38 INFO - 'svgr': {'tests': ['tsvgx', 05:16:38 INFO - 'tsvgr_opacity', 05:16:38 INFO - 'tart', 05:16:38 INFO - 'tscrollx', 05:16:38 INFO - 'cart']}, 05:16:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:16:38 INFO - 'tests': ['tsvgx', 05:16:38 INFO - 'tsvgr_opacity', 05:16:38 INFO - 'tart', 05:16:38 INFO - 'tscrollx', 05:16:38 INFO - 'cart']}, 05:16:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:38 INFO - 'tests': ['tp5o']}, 05:16:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:38 INFO - 'talos_options': ['--e10s'], 05:16:38 INFO - 'tests': ['tp5o']}, 05:16:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:38 INFO - 'talos_options': ['--xperf_path', 05:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:38 INFO - 'tests': ['tp5n']}, 05:16:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:38 INFO - 'talos_options': ['--e10s', 05:16:38 INFO - '--xperf_path', 05:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:38 INFO - 'tests': ['tp5n']}}, 05:16:38 INFO - 'talos.zip': {'path': '', 05:16:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:38 INFO - Running post-action listener: _resource_record_post_action 05:16:38 INFO - ##### 05:16:38 INFO - ##### Running create-virtualenv step. 05:16:38 INFO - ##### 05:16:38 INFO - Running pre-action listener: _resource_record_pre_action 05:16:38 INFO - Running main action method: create_virtualenv 05:16:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:16:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:38 INFO - Using real prefix '/tools/python27' 05:16:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:42 INFO - Installing pip.................done. 05:16:42 INFO - Return code: 0 05:16:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103392a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8934af6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, '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.h3t04WEyOd/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.QNqqsZA96D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16: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', 'pip>=1.5'] in /builds/slave/test/build 05:16: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 pip>=1.5 05:16:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:16:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:42 INFO - 'HOME': '/Users/cltbld', 05:16:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:42 INFO - 'LOGNAME': 'cltbld', 05:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:42 INFO - 'MOZ_NO_REMOTE': '1', 05:16:42 INFO - 'NO_EM_RESTART': '1', 05:16:42 INFO - 'PAGER': '/bin/cat', 05:16:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:42 INFO - 'PWD': '/builds/slave/test', 05:16:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:42 INFO - 'SHELL': '/bin/bash', 05:16:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:16:42 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:16:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:42 INFO - 'USER': 'cltbld', 05:16:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:42 INFO - 'XPC_FLAGS': '0x0', 05:16:42 INFO - 'XPC_SERVICE_NAME': '0', 05:16:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:16:42 INFO - Cleaning up... 05:16:42 INFO - Return code: 0 05:16:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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', '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 0x103392a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8934af6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, '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.h3t04WEyOd/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.QNqqsZA96D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:16: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 psutil>=0.7.1 05:16:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:16:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:42 INFO - 'HOME': '/Users/cltbld', 05:16:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:42 INFO - 'LOGNAME': 'cltbld', 05:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:42 INFO - 'MOZ_NO_REMOTE': '1', 05:16:42 INFO - 'NO_EM_RESTART': '1', 05:16:42 INFO - 'PAGER': '/bin/cat', 05:16:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:42 INFO - 'PWD': '/builds/slave/test', 05:16:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:42 INFO - 'SHELL': '/bin/bash', 05:16:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:16:42 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:16:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:42 INFO - 'USER': 'cltbld', 05:16:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:42 INFO - 'XPC_FLAGS': '0x0', 05:16:42 INFO - 'XPC_SERVICE_NAME': '0', 05:16:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:43 INFO - Downloading/unpacking psutil>=0.7.1 05:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:46 INFO - Installing collected packages: psutil 05:16:46 INFO - Running setup.py install for psutil 05:16:46 INFO - building 'psutil._psutil_osx' extension 05:16:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:16:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:16:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:16:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:16:46 INFO - building 'psutil._psutil_posix' extension 05:16:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:16:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:16:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:16:46 INFO - ^ 05:16:46 INFO - 1 warning generated. 05:16:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:46 INFO - Successfully installed psutil 05:16:46 INFO - Cleaning up... 05:16:46 INFO - Return code: 0 05:16:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103392a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8934af6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, '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.h3t04WEyOd/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.QNqqsZA96D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:16:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:16:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:46 INFO - 'HOME': '/Users/cltbld', 05:16:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:46 INFO - 'LOGNAME': 'cltbld', 05:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:46 INFO - 'MOZ_NO_REMOTE': '1', 05:16:46 INFO - 'NO_EM_RESTART': '1', 05:16:46 INFO - 'PAGER': '/bin/cat', 05:16:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:46 INFO - 'PWD': '/builds/slave/test', 05:16:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:46 INFO - 'SHELL': '/bin/bash', 05:16:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:16:46 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:16:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:46 INFO - 'USER': 'cltbld', 05:16:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:46 INFO - 'XPC_FLAGS': '0x0', 05:16:46 INFO - 'XPC_SERVICE_NAME': '0', 05:16:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:16:49 INFO - Installing collected packages: mozsystemmonitor 05:16:49 INFO - Running setup.py install for mozsystemmonitor 05:16:49 INFO - Successfully installed mozsystemmonitor 05:16:49 INFO - Cleaning up... 05:16:49 INFO - Return code: 0 05:16:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103392a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8934af6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, '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.h3t04WEyOd/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.QNqqsZA96D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:16:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:16:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:49 INFO - 'HOME': '/Users/cltbld', 05:16:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:49 INFO - 'LOGNAME': 'cltbld', 05:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:49 INFO - 'MOZ_NO_REMOTE': '1', 05:16:49 INFO - 'NO_EM_RESTART': '1', 05:16:49 INFO - 'PAGER': '/bin/cat', 05:16:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:49 INFO - 'PWD': '/builds/slave/test', 05:16:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:49 INFO - 'SHELL': '/bin/bash', 05:16:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:16:49 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:16:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:49 INFO - 'USER': 'cltbld', 05:16:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:49 INFO - 'XPC_FLAGS': '0x0', 05:16:49 INFO - 'XPC_SERVICE_NAME': '0', 05:16:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:50 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:53 INFO - Downloading docopt-0.6.1.tar.gz 05:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:53 INFO - Running setup.py install for blobuploader 05:16:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:53 INFO - Running setup.py install for requests 05:16:54 INFO - Running setup.py install for docopt 05:16:54 INFO - Successfully installed blobuploader requests docopt 05:16:54 INFO - Cleaning up... 05:16:54 INFO - Return code: 0 05:16:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:54 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 0x103392a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8934af6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, '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.h3t04WEyOd/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.QNqqsZA96D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:16:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:54 INFO - 'HOME': '/Users/cltbld', 05:16:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:54 INFO - 'LOGNAME': 'cltbld', 05:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:54 INFO - 'MOZ_NO_REMOTE': '1', 05:16:54 INFO - 'NO_EM_RESTART': '1', 05:16:54 INFO - 'PAGER': '/bin/cat', 05:16:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:54 INFO - 'PWD': '/builds/slave/test', 05:16:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:54 INFO - 'SHELL': '/bin/bash', 05:16:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:16:54 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:16:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:54 INFO - 'USER': 'cltbld', 05:16:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:54 INFO - 'XPC_FLAGS': '0x0', 05:16:54 INFO - 'XPC_SERVICE_NAME': '0', 05:16:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:54 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-PQ3fCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:54 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-C1FYFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:54 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-eNizuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-1wXopK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-aohK9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-dDB27o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-2pAaF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-x4kYeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-L944hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-7FM9bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-zBI2Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-h5wvUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:55 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-CRddyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:56 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-I9obSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:56 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-oHgjT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:56 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Sjba_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:56 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OL3mDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:56 INFO - Running setup.py install for manifestparser 05:16:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Running setup.py install for mozcrash 05:16:56 INFO - Running setup.py install for mozdebug 05:16:56 INFO - Running setup.py install for mozdevice 05:16:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozfile 05:16:57 INFO - Running setup.py install for mozhttpd 05:16:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozinfo 05:16:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozInstall 05:16:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozleak 05:16:57 INFO - Running setup.py install for mozlog 05:16:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for moznetwork 05:16:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Running setup.py install for mozprocess 05:16:58 INFO - Running setup.py install for mozprofile 05:16:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Running setup.py install for mozrunner 05:16:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Running setup.py install for mozscreenshot 05:16:58 INFO - Running setup.py install for moztest 05:16:58 INFO - Running setup.py install for mozversion 05:16:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:59 INFO - Cleaning up... 05:16:59 INFO - Return code: 0 05:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:59 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 0x103392a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8934af6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, '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.h3t04WEyOd/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.QNqqsZA96D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:59 INFO - 'HOME': '/Users/cltbld', 05:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:59 INFO - 'LOGNAME': 'cltbld', 05:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:59 INFO - 'MOZ_NO_REMOTE': '1', 05:16:59 INFO - 'NO_EM_RESTART': '1', 05:16:59 INFO - 'PAGER': '/bin/cat', 05:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:59 INFO - 'PWD': '/builds/slave/test', 05:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:59 INFO - 'SHELL': '/bin/bash', 05:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:16:59 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:59 INFO - 'USER': 'cltbld', 05:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:59 INFO - 'XPC_FLAGS': '0x0', 05:16:59 INFO - 'XPC_SERVICE_NAME': '0', 05:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:59 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-jp3MHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:59 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Ir0XEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:59 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-WchbDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:59 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-lwSEAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:59 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-lT4gGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:59 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-eMIqSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:59 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-V3yYPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:00 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OuW6S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:00 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-4IwyHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:00 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-6Ky71N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:00 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Xk1THG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:00 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-m_LDEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:00 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-FwggrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:00 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-7qd2Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:00 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-1z_weO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:00 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-VlmxXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:01 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-yZjUQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:03 INFO - Downloading blessings-1.6.tar.gz 05:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:03 INFO - Installing collected packages: blessings 05:17:03 INFO - Running setup.py install for blessings 05:17:03 INFO - Successfully installed blessings 05:17:03 INFO - Cleaning up... 05:17:03 INFO - Return code: 0 05:17:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:04 INFO - Reading from file tmpfile_stdout 05:17:04 INFO - Current package versions: 05:17:04 INFO - blessings == 1.6 05:17:04 INFO - blobuploader == 1.2.4 05:17:04 INFO - docopt == 0.6.1 05:17:04 INFO - manifestparser == 1.1 05:17:04 INFO - mozInstall == 1.12 05:17:04 INFO - mozcrash == 0.16 05:17:04 INFO - mozdebug == 0.1 05:17:04 INFO - mozdevice == 0.48 05:17:04 INFO - mozfile == 1.2 05:17:04 INFO - mozhttpd == 0.7 05:17:04 INFO - mozinfo == 0.9 05:17:04 INFO - mozleak == 0.1 05:17:04 INFO - mozlog == 3.1 05:17:04 INFO - moznetwork == 0.27 05:17:04 INFO - mozprocess == 0.22 05:17:04 INFO - mozprofile == 0.28 05:17:04 INFO - mozrunner == 6.11 05:17:04 INFO - mozscreenshot == 0.1 05:17:04 INFO - mozsystemmonitor == 0.0 05:17:04 INFO - moztest == 0.7 05:17:04 INFO - mozversion == 1.4 05:17:04 INFO - psutil == 3.1.1 05:17:04 INFO - requests == 1.2.3 05:17:04 INFO - wsgiref == 0.1.2 05:17:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 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 0x103392a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8934af6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, '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.h3t04WEyOd/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.QNqqsZA96D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:04 INFO - 'HOME': '/Users/cltbld', 05:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PAGER': '/bin/cat', 05:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:17:04 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - 'XPC_FLAGS': '0x0', 05:17:04 INFO - 'XPC_SERVICE_NAME': '0', 05:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:04 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 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 0x103392a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8934af6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, '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.h3t04WEyOd/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.QNqqsZA96D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:04 INFO - 'HOME': '/Users/cltbld', 05:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PAGER': '/bin/cat', 05:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:17:04 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - 'XPC_FLAGS': '0x0', 05:17:04 INFO - 'XPC_SERVICE_NAME': '0', 05:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:04 INFO - Downloading/unpacking jsonschema 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:06 INFO - Downloading/unpacking functools32 (from jsonschema) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:07 INFO - warning: no files found matching '*.txt' 05:17:07 INFO - no previously-included directories found matching 'build' 05:17:07 INFO - no previously-included directories found matching 'dist' 05:17:07 INFO - no previously-included directories found matching '.git*' 05:17:07 INFO - Installing collected packages: jsonschema, functools32 05:17:07 INFO - Running setup.py install for functools32 05:17:07 INFO - warning: no files found matching '*.txt' 05:17:07 INFO - no previously-included directories found matching 'build' 05:17:07 INFO - no previously-included directories found matching 'dist' 05:17:07 INFO - no previously-included directories found matching '.git*' 05:17:07 INFO - Successfully installed jsonschema functools32 05:17:07 INFO - Cleaning up... 05:17:07 INFO - Return code: 0 05:17:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:07 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 0x103392a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8934af6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, '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.h3t04WEyOd/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.QNqqsZA96D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:17:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:17:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:07 INFO - 'HOME': '/Users/cltbld', 05:17:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:07 INFO - 'LOGNAME': 'cltbld', 05:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:07 INFO - 'MOZ_NO_REMOTE': '1', 05:17:07 INFO - 'NO_EM_RESTART': '1', 05:17:07 INFO - 'PAGER': '/bin/cat', 05:17:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:07 INFO - 'PWD': '/builds/slave/test', 05:17:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:07 INFO - 'SHELL': '/bin/bash', 05:17:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:17:07 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:17:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:07 INFO - 'USER': 'cltbld', 05:17:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:07 INFO - 'XPC_FLAGS': '0x0', 05:17:07 INFO - 'XPC_SERVICE_NAME': '0', 05:17:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:07 INFO - Downloading/unpacking flake8 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:17:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:17:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:11 INFO - no previously-included directories found matching 'docs/_build' 05:17:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:17:11 INFO - Running setup.py install for pep8 05:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:11 INFO - no previously-included directories found matching 'docs/_build' 05:17:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:17:11 INFO - Cleaning up... 05:17:11 INFO - Return code: 0 05:17:11 INFO - Running post-action listener: _resource_record_post_action 05:17:11 INFO - Running post-action listener: _start_resource_monitoring 05:17:11 INFO - Starting resource monitoring. 05:17:11 INFO - ##### 05:17:11 INFO - ##### Running install step. 05:17:11 INFO - ##### 05:17:11 INFO - Running pre-action listener: _resource_record_pre_action 05:17:11 INFO - Running main action method: install 05:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:12 INFO - Reading from file tmpfile_stdout 05:17:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:12 INFO - Reading from file tmpfile_stdout 05:17:12 INFO - Output received: 05:17:12 INFO - Usage: mozinstall [options] installer 05:17:12 INFO - Options: 05:17:12 INFO - -h, --help show this help message and exit 05:17:12 INFO - -d DEST, --destination=DEST 05:17:12 INFO - Directory to install application into. [default: 05:17:12 INFO - "/builds/slave/test"] 05:17:12 INFO - --app=APP Application being installed. [default: firefox] 05:17:12 INFO - mkdir: /builds/slave/test/build/application 05:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:17:46 INFO - Reading from file tmpfile_stdout 05:17:46 INFO - Output received: 05:17:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:17:46 INFO - Running post-action listener: _resource_record_post_action 05:17:46 INFO - ##### 05:17:46 INFO - ##### Running run-tests step. 05:17:46 INFO - ##### 05:17:46 INFO - Running pre-action listener: _resource_record_pre_action 05:17:46 INFO - Running main action method: run_tests 05:17:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:46 INFO - 2016-02-18 05:17:46.334 screenresolution[2220:12682] starting screenresolution argv=screenresolution get 05:17:46 INFO - 2016-02-18 05:17:46.337 screenresolution[2220:12682] Display 0: 1600x1200x32@60 05:17:46 INFO - 2016-02-18 05:17:46.343 screenresolution[2221:12684] starting screenresolution argv=screenresolution list 05:17:46 INFO - Available Modes on Display 0 05:17:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:46 INFO - Intel Iris: 05:17:46 INFO - Chipset Model: Intel Iris 05:17:46 INFO - Type: GPU 05:17:46 INFO - Bus: Built-In 05:17:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:46 INFO - Vendor: Intel (0x8086) 05:17:46 INFO - Device ID: 0x0a2e 05:17:46 INFO - Revision ID: 0x0009 05:17:46 INFO - Displays: 05:17:46 INFO - Display: 05:17:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:46 INFO - Display Serial Number: 1600x1200 60 05:17:46 INFO - Main Display: Yes 05:17:46 INFO - Mirror: Off 05:17:46 INFO - Online: Yes 05:17:46 INFO - Rotation: Supported 05:17:46 INFO - Return code: 0 05:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:46 INFO - Python 2.7.3 05:17:46 INFO - Return code: 0 05:17:46 INFO - grabbing minidump binary from tooltool 05:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:46 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 0x103236d30>, '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 0x10305adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10322db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:17:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:17:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:46 INFO - Return code: 0 05:17:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:17:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:17:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:17:47 INFO - Return code: 0 05:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3t04WEyOd/Render', 05:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:47 INFO - 'HOME': '/Users/cltbld', 05:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:47 INFO - 'LOGNAME': 'cltbld', 05:17:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:47 INFO - 'MOZ_NO_REMOTE': '1', 05:17:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:47 INFO - 'NO_EM_RESTART': '1', 05:17:47 INFO - 'PAGER': '/bin/cat', 05:17:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:47 INFO - 'PWD': '/builds/slave/test', 05:17:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:47 INFO - 'SHELL': '/bin/bash', 05:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNqqsZA96D/Listeners', 05:17:47 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:47 INFO - 'USER': 'cltbld', 05:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:47 INFO - 'XPC_FLAGS': '0x0', 05:17:47 INFO - 'XPC_SERVICE_NAME': '0', 05:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:17:48 INFO - mozversion application_buildid: 20160218030343 05:17:48 INFO - mozversion application_changeset: 1150ac4755c7bb35df4fc7504f6f1b6c257f400e 05:17:48 INFO - mozversion application_display_name: Nightly 05:17:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:48 INFO - mozversion application_name: Firefox 05:17:48 INFO - mozversion application_remotingname: firefox 05:17:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:17:48 INFO - mozversion application_vendor: Mozilla 05:17:48 INFO - mozversion application_version: 47.0a1 05:17:48 INFO - mozversion platform_buildid: 20160218030343 05:17:48 INFO - mozversion platform_changeset: 1150ac4755c7bb35df4fc7504f6f1b6c257f400e 05:17:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:17:48 INFO - mozversion platform_version: 47.0a1 05:17:48 INFO - using testdate: 1455801468 05:17:48 INFO - actual date: 1455801468 05:17:48 INFO - starting webserver on 'localhost:49748' 05:17:48 INFO - SUITE-START | Running 2 tests 05:17:48 INFO - TEST-START | dromaeo_css 05:17:48 INFO - operating with platform_type : mac_ 05:17:48 INFO - Initialising browser for dromaeo_css test... 05:17:48 INFO - TEST-INFO | started process 2239 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp8bUqMu/profile http://localhost:49748/getInfo.html) 05:17:50 INFO - PROCESS | 2239 | __metrics Screen width/height:1600/1200 05:17:50 INFO - PROCESS | 2239 | colorDepth:24 05:17:50 INFO - PROCESS | 2239 | Browser inner width/height: 1024/689 05:17:50 INFO - PROCESS | 2239 | __metrics 05:17:51 ERROR - PROCESS | 2239 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 05:17:51 INFO - TEST-INFO | 2239: exit 0 05:17:51 INFO - Browser initialized. 05:17:51 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:51 INFO - TEST-INFO | started process 2243 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp8bUqMu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:03 INFO - PROCESS | 2243 | RSS: Main: 255774720 05:18:03 INFO - PROCESS | 2243 | 05:18:53 INFO - PROCESS | 2243 | 1455801533242 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:21:03 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49748/tests/dromaeo/cssquery-ext.html) 05:21:05 INFO - PROCESS | 2243 | RSS: Main: 271220736 05:21:05 INFO - PROCESS | 2243 | 05:24:07 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-ext.html (next: http://localhost:49748/tests/dromaeo/cssquery-jquery.html) 05:24:07 INFO - PROCESS | 2243 | RSS: Main: 283725824 05:24:07 INFO - PROCESS | 2243 | 05:27:09 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49748/tests/dromaeo/cssquery-mootools.html) 05:27:10 INFO - PROCESS | 2243 | RSS: Main: 284266496 05:27:10 INFO - PROCESS | 2243 | 05:30:11 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49748/tests/dromaeo/cssquery-prototype.html) 05:30:12 INFO - PROCESS | 2243 | RSS: Main: 287199232 05:30:12 INFO - PROCESS | 2243 | 05:33:14 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49748/tests/dromaeo/cssquery-yui.html) 05:33:15 INFO - PROCESS | 2243 | RSS: Main: 288419840 05:33:15 INFO - PROCESS | 2243 | 05:36:17 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-yui.html (next: http://localhost:49748/tests/dromaeo/cssquery-dojo.html) 05:36:18 INFO - PROCESS | 2243 | RSS: Main: 291282944 05:36:18 INFO - PROCESS | 2243 | 05:36:18 INFO - PROCESS | 2243 | __start_tp_report 05:36:18 INFO - PROCESS | 2243 | _x_x_mozilla_page_load 05:36:18 INFO - PROCESS | 2243 | _x_x_mozilla_page_load_details 05:36:18 INFO - PROCESS | 2243 | |i|pagename|runs| 05:36:18 INFO - PROCESS | 2243 | |0;dojo.html;3513.7891726496405;3545.1314427965153;3578.92842143157;3601.351756683797;3611.3499570077392;5802.854928626781;5858.560607954404;5865.560082993771;5880.882382352361;5898.262717160355;5834.533237341013;5847.532197424206;5966.850828729284;6037;6048.788292409767;5307.2039194121;5318.441563635821;5373.973130134344;5417.160340147264;5505.504504594585;5286.867828304304;5309.601779866525;5348.277982472356;5367.221752845835;5368.785248590052;5206.635535512516;5286.550643195333;5340.145576707747;5395.622306438551;5403.675779453245;5368.872536767283;5388.191771234307;5389.245505629176;5400.189971504266;5420.566354691655;5208.427073021964;5287.629865909388;5368.516833485005;5370.033393989081;5408.107662235727;5738.139279108125;5812.622179558315;5875.588708790387;5888.293404791452;5898.7640494380175;6263.561550691454;6280.9685951569945;6282.905756413657;6306.337834527354;6307.148534947769;6203.689815509251;6263.592866463711;6276.905846412307;6304.968475157641;6324.873502529969;6018.939810601882;6040.697965101727;6052.092186172109;6056.394360563952;6094.969525152346;6222.751089956441;6358.205224346957;6398.328175541595;6403.295637479873;6403.359664033559;6219;6263.592866463757;6296.811095667137;6308.873822523616;6340.175777148941;6270.435660790551;6293.716782744787;6312.463440607508;6315.747370105144;6323.810285691345;5199;5408.8377348679605;6218.5647004709235;6250.624962502265;6271.27880293763;6234.314225435199;6277.560570760094;6293.748250069946;6297.338779428185;6300.3699630037545;4977.129002424561;5007.874803129951;5010.724410157476;5013.724245166551;5015.899682006339;4414.933775993362;4416.072624748838;4418.690691651618;4486.371907932892;4549.431321084864;4894.412670479494;4948.233023881232;5850.707464626752;5874.530037597067;5887.293524777054;6206.255249370014;6248.562600617913;6292.150559674477;6309.432151106423;6324.209473815773;5394.595405344615;5599.440055994368;5915.1718759373725;5938.49522790559;5947.256592925884;5506.201600767866;5520.696361700145;5521;5525.696086715269;5532.5297349724915;5263.710495922761;6331.68341582919;6395.6482393468805;6428.067930150196;6492.156019717407;5786.971065144648;6142.201513803177;6316.115743795965;6318.715657795502;6320.6839658016;6296.5277604178955;6462.256840463407;6533.379328963741;6573.816712991707;6586.308437614173;6119.07606531266;6150.892839288971;6208.751649933952;6214.5960512566535;6219.844503887439;6229.470495007794;6261;6263.4362907338555;6263.530235232284;6269.749210031548;5965.403459654;6129.358790882775;6235.625862448268;6238.282597501164;6268.341824108403;6189.566730328834;6244.968775156095;6252.9062064069985;6280.560360774702;6317.273513545817;6031.457168854824;6146.969265153645;6153.569250152446;6165.660888651168;6168.845778855564;6132.264128304453;6168.136460895388;6247.96876015617;6269.937300627118;6274.403931626488;6104.938950610437;6119.418655227746;6124.050772130327;6134.969325153525;6135.570510064431 05:36:18 INFO - PROCESS | 2243 | |1;ext.html;439.2379222049745;443.23320655266366;453.75497231494984;459.60703598423345;515.3274976156117;30456.84771576139;37547.06132346693;37937.62062379379;38023.61976380235;38165.61834381655;39022.21955560894;39225.803870980606;39243.60756392435;39324.80337598308;39357.40963885544;9428.350038743243;9554.901186363588;9607.711768646952;9636.229101671885;9639.566219520104;9345.2991025673;9490.098440648128;9505.762355941122;9527.333086683935;9577.616895324214;8407.45351552147;9557.808843823119;9602.807943841119;9655.46894920779;9689.757756056084;9531.618735250582;9563.80872382552;9585.185259252938;9619.615215391412;9623.278254130968;9577.425354478684;9613.51932403377;9684.370515916444;9725.805483890283;9731.41611503312;37994.050148746224;38132.61867381319;38194.809025954695;38232.80883595592;38341.80829095837;2737.86310684465;3020.9848950755104;3602.513660655804;3682.2635472905527;3932.252871954348;26550.6017409739;26722.732772672218;27301;27400.451990960268;27680.031198907942;2801.9719802801915;2836.1349788314556;2848.900288489893;2874.453853767777;2887.942241155165;348110;387416;395739;400294;400353;56896;61268.38731612627;62735.68632156901;64911;67820.32179678239;53294.200586991225;64899.67550162219;64924.675376622814;65209;66078.33921660818;16053.518394448185;16237.59406014859;16511.09188994617;16569;16615.50153495397;12481.93903518193;12562.560310389092;12575.308358040396;12643.87356126427;12798.808017879739;17097;19865.404037878885;20451;20792.48018799512;20810.79189208119;8795.692150774692;8972.730818075468;9005.767289373984;9009.23421509179;9031.412958157698;940.7930255343813;959.7072892767633;979.774651830083;988.17981075707;1057.5716834681966;25766.613500797503;29400.970966016088;29597.964071257404;29839.85080074586;30101.698983010327;1039.4802598700649;1080.8811030786608;1107.595727559451;1185.6028230542865;1190.0301254477572;14873.92563037178;15036.699266014619;15038.097714137186;15161;15230.46693365749;527687;528873;530300;532955.3352233215;534141;58343;58758.70620646869;59019.70490147522;59262.407375925686;59308;1368.6167872995577;1372.8627137286192;1373.203541945669;1391.2348208485294;1392.0673148990202;29032.274193145342;29283.85358073196;29444.558331624616;29721.405571888874;29823.254418639706;51533.48466515287;51556;51866.48133518767;51972;52029;492515;495687;497366;498124;498902;33308.333833322715;37871.43192852165;44039.339409908236;44105.89735256644;45470.090598188515;45543;47136.764316178196;47798.76100619475;47926.760366197945;48763;37017.81491092527;37681.62318376781;37922.86231413062;38138.42792358062;38206.61793382031;35198.824005879804;36672.81663591665;37328;37459.87620371393;38005.809970949966;37460.68887588922;37670.434943475324;37955.24089518249;37957.810210948766;38548.843534694;25017.499650007263;30393;31576.842115789274;31616.841915790275;31826.204344890637;22632.547349053257;24018.39954001164;24062.759372406053;24064.87967560151;24353.756462435857 05:36:18 INFO - PROCESS | 2243 | |2;jquery.html;331.45641148516455;358.2333805655897;360.52230794197686;365.95425571803526;366.7561071887195;15593.532194034196;18005.369812056582;19104.808951910476;19471.221151153954;20255.49361265969;19337.226510939545;19362.612747745072;19432.417027489162;19517.316893908715;19658;5515.889682206353;5724.513416359614;5766.279215098113;5835.5915085944;5855.502282306009;5585.609007369486;5844.707764611774;5850.590458667895;5854.619449735775;5861.238039054917;3907.960920390788;5475.0966090595;5739.253896993385;5873.119032145191;5894.764209431618;5764.596478246483;5894.292684877821;5928.258967629046;5961.463468287875;6066.302375226839;5584.553235741131;5587.860303492445;5591.049521581341;5667.744951477152;5702.8289151325525;13167.275799831006;13391.933040334736;13443.932780336134;13471.461141554326;13557.457701691921;1884.2839720905968;1980.4553747719349;2037.7758446570865;2212.148322895681;2527.330257481769;10133.493325333704;10146.847797283046;10365.01532354425;13629.659258518517;14443.638909027253;1746.5109769264627;1774.3346245158066;1794.973075403857;1809.2129923483326;1838.0534024977148;88542;95231;100666.9933300665;101764;102488.48755756248;11006.064484518905;11282.830757538644;11317.981381675689;11327.716807079889;11419.314841109393;13347.799783003262;13380.799288010687;13431.86568134306;13434.596962090958;13446.05877588579;8335.208155225244;8390.077091519928;8396.874046889301;8413.45312554682;8427.28368088707;8203.343732501386;8381.203785640355;8384.832303353898;8403.285720713686;8413.95793021031;3927.703857726943;4350.390945267665;4432.84485043022;4444.8444304449185;4464.241079016575;1568.8077061433394;1687;1902.6955687089999;1926.9325573604856;1936.448112287991;399.09405649176784;404.7308539821045;416.8728537796001;419.6957206025668;428.88986187955334;9372.062793720574;11044.834327485094;11927.284362938251;11992.580259691043;12064.57773977924;434.83476279014405;443.28409618465946;450.4279564952492;451.73573459525886;458.6995517935757;5957.821265362046;8340;9419.62321507132;11310.886891131147;11398;529182;543621;544047;584098;659533;67256;103091.2990655605;109271;112068;113567;998.5805961496189;1027.1628622672497;1044.216837371971;1048.9527971241312;1052.1004541117388;17920;17966.461006169837;18055.277788888296;18074.728879067086;18355.990420527;35715;46904.06191876075;47605.761971189924;47850.5214947846;50853.49146508487;68025.31974680189;69022;69544.3045569558;69600;69679.30320696728;6480.6435646038035;7649.732259370895;7822.921770782219;7879.0151231096115;7886.921130788619;10201.38791672502;12083.818742719042;12265.202761820454;12351.073669475005;12395.380230988234;7594.886374932881;9844.704658860246;10237.232207584311;10617.1506279499;10846.728831779268;10419.322744021614;10488.00363965422;10699.732506687395;10741.301815381976;10860.674179774303;11003.779924401628;11019.173561982723;11173.776524469627;11305.378204198849;11327.886721132683;7449.779568712816;7794.337481314152;7848.175941526286;7885.6451459685595;7894.092179399443;10223.335483193569;10289.536970836181;10438;11100.61147859821;11157.330560166416 05:36:18 INFO - PROCESS | 2243 | |3;mootools.html;1516.476815498653;1524.5883611424915;1744.1192197940038;1849.4081893793982;1854.3602457152278;7825.960870195641;8425.78935526612;8520.872186917193;8687.695930642429;8732.08313127122;8458.703945361913;8521.105283945173;8580.485170889751;8630.568471576427;8643.87034194486;2437.2688193541953;2439.1097249503982;2447.8531288122767;2477.0339567568662;2479.6776419065495;2427.8421902576365;2472.9629055564183;2487.166799122296;2492.6510288559616;2501.9249422517264;2147.6563749800034;2384.988075059622;2415.070197973784;2418.806495480357;2502.249325202441;1965.5872266823912;2017.3241963942096;2428.0530593068715;2455.5702752018506;2467.814913881466;2379.892904819287;2435.403326185078;2449.9877500612383;2450.8652024138664;2453.4970331082086;7545.622718864035;7782.027246594176;8599.699010534601;8601.827963440695;8639.52482613456;5034.823781167642;5436.809711660112;5452.972735136339;5469.507744302992;5486.698231597261;3022.9244268893453;3525.9294814103832;3536.1336472564385;3617.94573081404;3637.9272414551824;1061.0238580505952;1066.9359838409644;1076.590895459728;1078.9514471848786;1091.9344839309667;11805.704857378549;11852.34812085335;11858.229215100991;11868;11883.524659013628;4762.357081793983;4842.927356089662;4863.610911127102;4879.780409881564;4896.804127834846;10031.147352474976;10042.347247428894;10056.296059275926;10072.697819065439;10103.949480252551;5477.424870388551;5480.91778623321;5501.614886957875;5501.972490137524;5503.889922201613;5005.049040682259;5031.421386540522;5033.748312584356;5035.345405097314;5038.697678139323;3893.357595996629;3914.4715463412645;3940.2907476654477;3969.4839670842607;3971.3050216212046;1311.4426368793224;1313.9408726607326;1314.5070598525554;1325.562564353761;1342.154442701092;954.4130359828655;1111.111111111124;1132.5413207650915;1184.727512672073;1230.4647478346947;7946.245106714853;7963.8805417918775;8018.879716804253;8024;8028.678852845937;1150.8791576884473;1166.5217260922982;1167.0721776187952;1172.302480024384;1202.8316035755001;6118.235220597426;6226;6236.251649802053;6239.656818874914;6256.186695729617;10315.742106447398;10325.9483702581;10512.842307365396;10641.574337026586;10661.84007239892;10301.227407944285;10403.895961040444;10496.212784041074;10531.684049478528;10579.206559508068;7462;8086.43394962347;8189.181081891882;8237.341012718967;8268.462549934235;7705.499142555716;7721.6139193039;7740.612969351622;7758.8448231033935;7810.6485208166905;9183.448993060438;9427.387219830689;9507.572159252712;9628.47043412619;9683.176929961031;9672.806543869225;9793.804123917624;9812.558434870305;9965.900340996497;9980;7487.288707572772;7599.772006839804;7613.847723045397;7621.809454763454;7628.504147230412;8096.757097287091;8244.464109832841;8274.958625206835;8291.58542072906;8292.2951549119;6250.874982500415;7437.256274372519;7473.813154671177;7488.5506869588;7497.400207983457;6591.868162636624;6996.0905082341005;7016.36852683261;7082.716691332495;7186.46101542376;5629.577781666309;7373.63131843395;7403.546912459002;7460.3658689012045;7469.775906722807;5772.7690892363835;6858.588484690935;6882.518223724492;6897.7240910365035;6906.723731050702;6917.308269173042;6920.550164239308;6958.165020197609;7003;7022.964885175746 05:36:18 INFO - PROCESS | 2243 | |4;prototype.html;304.36387949186195;310.9113902537776;324.40147927074554;330.67758935038324;335.85893924551686;6253.218347706531;6307.653079080649;6880.518363714542;7021.8595628087405;7034.155901291846;7042.330978557042;7045.5772653640815;7057;7085.822854428629;7114.146302443714;4189.476315460567;4245.872623821283;5233.319668443097;5238.292830467876;5252.894942101156;4861.416630004404;5149.407818100929;5225.921611175835;5248.6588371755715;5267.683938963655;4971.279164521142;4973.428055773578;4975.975120124413;4977.104121258172;4981.178105612569;4969.552740253376;4970.87572810679;4971.179755340382;4985.775640096204;5003.799848006075;4038.030872590557;4134.565870583606;4221.092465119983;4234.830606775725;4243.702940794145;6566.704498297588;6624.205095388585;6636.535442519025;6636.73453061877;6695.732170713166;5937.970310148465;5946.167536544887;5950.285965684102;5950.7322170502;5968.4031596840405;7106.147262328554;7342.15565209997;7362.484626076177;7444.032275804111;7444.776656700307;4355.760433176174;4690.9530904690855;4694.342792009122;4695.765211739399;4701.506341834092;6937.340952609545;7788.961055194744;7883.921160788376;7924.405669574748;7945.284924356778;4613.792379342937;4763.2140696784645;4770.976145119253;4773.498782627844;4789.3294938708605;4837.177679794443;4860.076585448754;4863.148948933923;4869.732164730974;4878.487758785347;5808.912866307009;5864.618799778001;5885.323187833454;5927.911081333784;5930.258717660293;7288.610795979895;7523.7366692165515;7542.47202695806;7558.168601453835;7573.545587264782;1694.7627332173506;1723.4743403261875;1724.862011039114;1729.092226581055;1732.1512458895302;1070.29895418501;1071.0735214039955;1075.6611667324767;1083.918706097046;1089.2484185911696;7190.173130090002;7202.675879585431;7223.27767223284;7227.241139680363;7231.132264128339;6461.579997300254;8056.436049476481;8061.234182752629;8113.472624279521;8124.878126828103;6936.895946560806;7144.678489467882;7194.928050719531;7218;7225.060742103598;4111.054457474797;4174.812133453941;4195.202911446815;4242.639375653104;4259.5101563319995;8406.201410865959;8410.915890841135;8423.241908228289;8454.196851299117;8458.534780587004;7893.447458677952;8474.703385381483;8474.74575762728;8486.830263394697;8491.830163396697;8260.83478330442;8274.089850116483;8277.668893244203;8291.253787159185;8305.916940830635;6239.344868788712;6569.737210511526;7651.693932242871;7919.366450684047;7921.762347129596;5483.917741233964;6234.719437625408;7465.4027677786735;7539.8492030157995;7758.107817600822;6676.966615167087;8275.917240827515;8291.419600627898;8297.875531866906;8298.087210406971;4779.211430113992;4847.254988204173;4850;4859.149648811514;4869.732164730832;6418.807435776934;6904.4131248842405;7125;7825.1783562725095;7883.448158628841;7555.8866616999685;7560.470767046254;7570.659320330488;7573.734919277799;7585.962070189614;5773.624714393719;7345.861391484328;7547.132079810892;7552.207018263223;7557.130929942907;7369.852602948018;7381.298776616213;7388.445866559922;7392.852142957003;7423.925760742323;6302.401271879165;7401.259874012771;7552.169261381134;7570.962145189239;7576.583287919218;7160.964195179199;7311.4516411268305;7367.557946523226;7370.77887663371;7395.223501532261 05:36:18 INFO - PROCESS | 2243 | |5;yui.html;650.2002536879638;665.5673812022186;681.9079424277725;713.2368365848542;724.8115489972605;13993.440262389518;14691.632709182275;14767.335469903866;14929.850701492982;17390.913045434787;15951.963122397035;16009.359625614961;16036.43872464464;16100.872938894283;16107.43623973161;695.5235663570445;846.809467869729;847.7456762971115;855.0423525651248;874.9737507874773;860.0754189246585;867.6269204242205;869.9739007829776;870.1689886158734;873.4235404632943;883.801144742431;884.1644645809712;911.9316051296146;915.0254978447965;917.9127982841653;892.955352232389;902.580300160422;910.3854897943894;910.4855756497558;911.1435250864166;647.7700416352221;673.4208580620663;674.1741366825648;675.1931441926899;675.2774531251563;14956;15093.773593396108;15202.239888005666;15235.162066086361;15296.311665975058;12556.372181390894;12565.371731413392;12664.620061398173;12684;13099.08306418551;10213.540390682363;10337.534810933526;10935.671929842038;11353.545858165664;11478.942605287004;3525.7531972761917;3529.4529347951107;3552.87564935226;3565.750397472178;3641.890743277706;84369.15630843674;84634.30731385338;84702.57648711778;85937.14062859354;86629.56685216534;9325.020872808258;9400;9562.039781844705;9608.231341492663;9967.651132210338;19944.401667949984;20118.59762804736;20196.899015504827;20216.292429764886;20250.189992400137;7380.261973802577;7387.704491820267;7664.80837979055;7791.610419479117;7855.332296754726;3196.0411876436974;4058.979705101515;4061.5126184858004;4068.0846809468226;4093.205896130061;2952.867120979561;3534.4698295255916;3571.196480791853;3574.964250357515;3587.982060089683;564.6927363154284;604.4680681000779;648.1962366665301;663.5653646861314;675.6351570152161;497.2044728434548;529.534010071135;624.1168746224042;634.8381162803455;652.5790864892118;8064.677412903536;8447.873281900776;8503.914960850312;8606.31149508038;8716.477011379338;487.8438101698996;544.7984245829068;622.181830892375;626.0649047034142;636.8216899268213;3937.27160475313;3943.4479172915817;3979.7015223858325;4002.639762421396;4056.127932494528;94194.52902735579;94890;95087;95641;98817.50591247142;63455;75482;79173;79810.20189798143;80464;68005;68073.99999999901;69159;70452.29547704458;71753.64123179455;7872.153288842831;8073.475224110649;8097.595120244082;8240.21717936795;8346.833063338578;48667.783305417644;52002;52372;52375.476245238584;52847.47152528426;68005.65997169983;70565;71918.56162876818;72628.27371726427;73304.26695732975;10260.743481413025;10437.634682786065;10660;10777.515011824644;11126.998570128728;11158;11353.205275630626;11363.318200907972;11412.02997745201;11419.257748246337;10230.181585472996;10405.427701476492;10668.73328166771;10705.571777129138;10767.946160269148;10532.631357902437;10706.304090234109;10727.356358618508;10759.569617215224;10823.783524329627;10318.690439286833;10390.532426040998;10583.576656933945;10586.682399528027;10676.092532134855;8125.919828381803;8408.663653453794;8945.865812012695;9011.459312441013;9108.681196158102;9080.682176123804;9985.494546840766;10023.200011922952;10038.19694424459;10078.305757247132 05:36:18 INFO - PROCESS | 2243 | __end_tp_report 05:36:18 INFO - PROCESS | 2243 | __start_cc_report 05:36:18 INFO - PROCESS | 2243 | _x_x_mozilla_cycle_collect,361 05:36:18 INFO - PROCESS | 2243 | __end_cc_report 05:36:18 INFO - PROCESS | 2243 | __startTimestamp1455802578254__endTimestamp 05:36:18 INFO - PROCESS | 2243 | 05:36:18 INFO - PROCESS | 2243 | ------- Summary: start ------- 05:36:18 INFO - PROCESS | 2243 | Number of tests: 6 05:36:18 INFO - PROCESS | 2243 | 05:36:18 INFO - PROCESS | 2243 | [#0] dojo.html Cycles:165 Average:5830.35 Median:6119.08 stddev:630.65 (10.3%) stddev-sans-first:605.84 05:36:18 INFO - PROCESS | 2243 | Values: 3513.8 3545.1 3578.9 3601.4 3611.3 5802.9 5858.6 5865.6 5880.9 5898.3 5834.5 5847.5 5966.9 6037.0 6048.8 5307.2 5318.4 5374.0 5417.2 5505.5 5286.9 5309.6 5348.3 5367.2 5368.8 5206.6 5286.6 5340.1 5395.6 5403.7 5368.9 5388.2 5389.2 5400.2 5420.6 5208.4 5287.6 5368.5 5370.0 5408.1 5738.1 5812.6 5875.6 5888.3 5898.8 6263.6 6281.0 6282.9 6306.3 6307.1 6203.7 6263.6 6276.9 6305.0 6324.9 6018.9 6040.7 6052.1 6056.4 6095.0 6222.8 6358.2 6398.3 6403.3 6403.4 6219.0 6263.6 6296.8 6308.9 6340.2 6270.4 6293.7 6312.5 6315.7 6323.8 5199.0 5408.8 6218.6 6250.6 6271.3 6234.3 6277.6 6293.7 6297.3 6300.4 4977.1 5007.9 5010.7 5013.7 5015.9 4414.9 4416.1 4418.7 4486.4 4549.4 4894.4 4948.2 5850.7 5874.5 5887.3 6206.3 6248.6 6292.2 6309.4 6324.2 5394.6 5599.4 5915.2 5938.5 5947.3 5506.2 5520.7 5521.0 5525.7 5532.5 5263.7 6331.7 6395.6 6428.1 6492.2 5787.0 6142.2 6316.1 6318.7 6320.7 6296.5 6462.3 6533.4 6573.8 6586.3 6119.1 6150.9 6208.8 6214.6 6219.8 6229.5 6261.0 6263.4 6263.5 6269.7 5965.4 6129.4 6235.6 6238.3 6268.3 6189.6 6245.0 6252.9 6280.6 6317.3 6031.5 6147.0 6153.6 6165.7 6168.8 6132.3 6168.1 6248.0 6269.9 6274.4 6104.9 6119.4 6124.1 6135.0 6135.6 05:36:18 INFO - PROCESS | 2243 | 05:36:18 INFO - PROCESS | 2243 | [#1] ext.html Cycles:180 Average:62085.75 Median:38287.31 stddev:126327.98 (329.9%) stddev-sans-first:126597.57 05:36:18 INFO - PROCESS | 2243 | Values: 439.2 443.2 453.8 459.6 515.3 30456.8 37547.1 37937.6 38023.6 38165.6 39022.2 39225.8 39243.6 39324.8 39357.4 9428.4 9554.9 9607.7 9636.2 9639.6 9345.3 9490.1 9505.8 9527.3 9577.6 8407.5 9557.8 9602.8 9655.5 9689.8 9531.6 9563.8 9585.2 9619.6 9623.3 9577.4 9613.5 9684.4 9725.8 9731.4 37994.1 38132.6 38194.8 38232.8 38341.8 2737.9 3021.0 3602.5 3682.3 3932.3 26550.6 26722.7 27301.0 27400.5 27680.0 2802.0 2836.1 2848.9 2874.5 2887.9 348110.0 387416.0 395739.0 400294.0 400353.0 56896.0 61268.4 62735.7 64911.0 67820.3 53294.2 64899.7 64924.7 65209.0 66078.3 16053.5 16237.6 16511.1 16569.0 16615.5 12481.9 12562.6 12575.3 12643.9 12798.8 17097.0 19865.4 20451.0 20792.5 20810.8 8795.7 8972.7 9005.8 9009.2 9031.4 940.8 959.7 979.8 988.2 1057.6 25766.6 29401.0 29598.0 29839.9 30101.7 1039.5 1080.9 1107.6 1185.6 1190.0 14873.9 15036.7 15038.1 15161.0 15230.5 527687.0 528873.0 530300.0 532955.3 534141.0 58343.0 58758.7 59019.7 59262.4 59308.0 1368.6 1372.9 1373.2 1391.2 1392.1 29032.3 29283.9 29444.6 29721.4 29823.3 51533.5 51556.0 51866.5 51972.0 52029.0 492515.0 495687.0 497366.0 498124.0 498902.0 33308.3 37871.4 44039.3 44105.9 45470.1 45543.0 47136.8 47798.8 47926.8 48763.0 37017.8 37681.6 37922.9 38138.4 38206.6 35198.8 36672.8 37328.0 37459.9 38005.8 37460.7 37670.4 37955.2 37957.8 38548.8 25017.5 30393.0 31576.8 31616.8 31826.2 22632.5 24018.4 24062.8 24064.9 24353.8 05:36:18 INFO - PROCESS | 2243 | 05:36:18 INFO - PROCESS | 2243 | [#2] jquery.html Cycles:180 Average:31645.44 Median:18023.23 stddev:95048.73 (527.4%) stddev-sans-first:95286.28 05:36:18 INFO - PROCESS | 2243 | Values: 331.5 358.2 360.5 366.0 366.8 15593.5 18005.4 19104.8 19471.2 20255.5 19337.2 19362.6 19432.4 19517.3 19658.0 5515.9 5724.5 5766.3 5835.6 5855.5 5585.6 5844.7 5850.6 5854.6 5861.2 3908.0 5475.1 5739.3 5873.1 5894.8 5764.6 5894.3 5928.3 5961.5 6066.3 5584.6 5587.9 5591.0 5667.7 5702.8 13167.3 13391.9 13443.9 13471.5 13557.5 1884.3 1980.5 2037.8 2212.1 2527.3 10133.5 10146.8 10365.0 13629.7 14443.6 1746.5 1774.3 1795.0 1809.2 1838.1 88542.0 95231.0 100667.0 101764.0 102488.5 11006.1 11282.8 11318.0 11327.7 11419.3 13347.8 13380.8 13431.9 13434.6 13446.1 8335.2 8390.1 8396.9 8413.5 8427.3 8203.3 8381.2 8384.8 8403.3 8414.0 3927.7 4350.4 4432.8 4444.8 4464.2 1568.8 1687.0 1902.7 1926.9 1936.4 399.1 404.7 416.9 419.7 428.9 9372.1 11044.8 11927.3 11992.6 12064.6 434.8 443.3 450.4 451.7 458.7 5957.8 8340.0 9419.6 11310.9 11398.0 529182.0 543621.0 544047.0 584098.0 659533.0 67256.0 103091.3 109271.0 112068.0 113567.0 998.6 1027.2 1044.2 1049.0 1052.1 17920.0 17966.5 18055.3 18074.7 18356.0 35715.0 46904.1 47605.8 47850.5 50853.5 68025.3 69022.0 69544.3 69600.0 69679.3 6480.6 7649.7 7822.9 7879.0 7886.9 10201.4 12083.8 12265.2 12351.1 12395.4 7594.9 9844.7 10237.2 10617.2 10846.7 10419.3 10488.0 10699.7 10741.3 10860.7 11003.8 11019.2 11173.8 11305.4 11327.9 7449.8 7794.3 7848.2 7885.6 7894.1 10223.3 10289.5 10438.0 11100.6 11157.3 05:36:18 INFO - PROCESS | 2243 | 05:36:18 INFO - PROCESS | 2243 | [#3] mootools.html Cycles:180 Average:5964.62 Median:5444.89 stddev:3130.60 (57.5%) stddev-sans-first:3121.53 05:36:18 INFO - PROCESS | 2243 | Values: 1516.5 1524.6 1744.1 1849.4 1854.4 7826.0 8425.8 8520.9 8687.7 8732.1 8458.7 8521.1 8580.5 8630.6 8643.9 2437.3 2439.1 2447.9 2477.0 2479.7 2427.8 2473.0 2487.2 2492.7 2501.9 2147.7 2385.0 2415.1 2418.8 2502.2 1965.6 2017.3 2428.1 2455.6 2467.8 2379.9 2435.4 2450.0 2450.9 2453.5 7545.6 7782.0 8599.7 8601.8 8639.5 5034.8 5436.8 5453.0 5469.5 5486.7 3022.9 3525.9 3536.1 3617.9 3637.9 1061.0 1066.9 1076.6 1079.0 1091.9 11805.7 11852.3 11858.2 11868.0 11883.5 4762.4 4842.9 4863.6 4879.8 4896.8 10031.1 10042.3 10056.3 10072.7 10103.9 5477.4 5480.9 5501.6 5502.0 5503.9 5005.0 5031.4 5033.7 5035.3 5038.7 3893.4 3914.5 3940.3 3969.5 3971.3 1311.4 1313.9 1314.5 1325.6 1342.2 954.4 1111.1 1132.5 1184.7 1230.5 7946.2 7963.9 8018.9 8024.0 8028.7 1150.9 1166.5 1167.1 1172.3 1202.8 6118.2 6226.0 6236.3 6239.7 6256.2 10315.7 10325.9 10512.8 10641.6 10661.8 10301.2 10403.9 10496.2 10531.7 10579.2 7462.0 8086.4 8189.2 8237.3 8268.5 7705.5 7721.6 7740.6 7758.8 7810.6 9183.4 9427.4 9507.6 9628.5 9683.2 9672.8 9793.8 9812.6 9965.9 9980.0 7487.3 7599.8 7613.8 7621.8 7628.5 8096.8 8244.5 8275.0 8291.6 8292.3 6250.9 7437.3 7473.8 7488.6 7497.4 6591.9 6996.1 7016.4 7082.7 7186.5 5629.6 7373.6 7403.5 7460.4 7469.8 5772.8 6858.6 6882.5 6897.7 6906.7 6917.3 6920.6 6958.2 7003.0 7023.0 05:36:18 INFO - PROCESS | 2243 | 05:36:18 INFO - PROCESS | 2243 | [#4] prototype.html Cycles:180 Average:6070.65 Median:6788.13 stddev:2004.06 (29.5%) stddev-sans-first:1962.39 05:36:18 INFO - PROCESS | 2243 | Values: 304.4 310.9 324.4 330.7 335.9 6253.2 6307.7 6880.5 7021.9 7034.2 7042.3 7045.6 7057.0 7085.8 7114.1 4189.5 4245.9 5233.3 5238.3 5252.9 4861.4 5149.4 5225.9 5248.7 5267.7 4971.3 4973.4 4976.0 4977.1 4981.2 4969.6 4970.9 4971.2 4985.8 5003.8 4038.0 4134.6 4221.1 4234.8 4243.7 6566.7 6624.2 6636.5 6636.7 6695.7 5938.0 5946.2 5950.3 5950.7 5968.4 7106.1 7342.2 7362.5 7444.0 7444.8 4355.8 4691.0 4694.3 4695.8 4701.5 6937.3 7789.0 7883.9 7924.4 7945.3 4613.8 4763.2 4771.0 4773.5 4789.3 4837.2 4860.1 4863.1 4869.7 4878.5 5808.9 5864.6 5885.3 5927.9 5930.3 7288.6 7523.7 7542.5 7558.2 7573.5 1694.8 1723.5 1724.9 1729.1 1732.2 1070.3 1071.1 1075.7 1083.9 1089.2 7190.2 7202.7 7223.3 7227.2 7231.1 6461.6 8056.4 8061.2 8113.5 8124.9 6936.9 7144.7 7194.9 7218.0 7225.1 4111.1 4174.8 4195.2 4242.6 4259.5 8406.2 8410.9 8423.2 8454.2 8458.5 7893.4 8474.7 8474.7 8486.8 8491.8 8260.8 8274.1 8277.7 8291.3 8305.9 6239.3 6569.7 7651.7 7919.4 7921.8 5483.9 6234.7 7465.4 7539.8 7758.1 6677.0 8275.9 8291.4 8297.9 8298.1 4779.2 4847.3 4850.0 4859.1 4869.7 6418.8 6904.4 7125.0 7825.2 7883.4 7555.9 7560.5 7570.7 7573.7 7586.0 5773.6 7345.9 7547.1 7552.2 7557.1 7369.9 7381.3 7388.4 7392.9 7423.9 6302.4 7401.3 7552.2 7571.0 7576.6 7161.0 7311.5 7367.6 7370.8 7395.2 05:36:18 INFO - PROCESS | 2243 | 05:36:18 INFO - PROCESS | 2243 | [#5] yui.html Cycles:180 Average:18522.75 Median:625.09 stddev:26394.93 (4222.6%) stddev-sans-first:26434.86 05:36:18 INFO - PROCESS | 2243 | Values: 650.2 665.6 681.9 713.2 724.8 13993.4 14691.6 14767.3 14929.9 17390.9 15952.0 16009.4 16036.4 16100.9 16107.4 695.5 846.8 847.7 855.0 875.0 860.1 867.6 870.0 870.2 873.4 883.8 884.2 911.9 915.0 917.9 893.0 902.6 910.4 910.5 911.1 647.8 673.4 674.2 675.2 675.3 14956.0 15093.8 15202.2 15235.2 15296.3 12556.4 12565.4 12664.6 12684.0 13099.1 10213.5 10337.5 10935.7 11353.5 11478.9 3525.8 3529.5 3552.9 3565.8 3641.9 84369.2 84634.3 84702.6 85937.1 86629.6 9325.0 9400.0 9562.0 9608.2 9967.7 19944.4 20118.6 20196.9 20216.3 20250.2 7380.3 7387.7 7664.8 7791.6 7855.3 3196.0 4059.0 4061.5 4068.1 4093.2 2952.9 3534.5 3571.2 3575.0 3588.0 564.7 604.5 648.2 663.6 675.6 497.2 529.5 624.1 634.8 652.6 8064.7 8447.9 8503.9 8606.3 8716.5 487.8 544.8 622.2 626.1 636.8 3937.3 3943.4 3979.7 4002.6 4056.1 94194.5 94890.0 95087.0 95641.0 98817.5 63455.0 75482.0 79173.0 79810.2 80464.0 68005.0 68074.0 69159.0 70452.3 71753.6 7872.2 8073.5 8097.6 8240.2 8346.8 48667.8 52002.0 52372.0 52375.5 52847.5 68005.7 70565.0 71918.6 72628.3 73304.3 10260.7 10437.6 10660.0 10777.5 11127.0 11158.0 11353.2 11363.3 11412.0 11419.3 10230.2 10405.4 10668.7 10705.6 10767.9 10532.6 10706.3 10727.4 10759.6 10823.8 10318.7 10390.5 10583.6 10586.7 10676.1 8125.9 8408.7 8945.9 9011.5 9108.7 9080.7 9985.5 10023.2 10038.2 10078.3 05:36:18 INFO - PROCESS | 2243 | -------- Summary: end -------- 05:36:18 INFO - PROCESS | 2243 | 05:36:18 INFO - TEST-INFO | 2243: exit 0 05:36:18 INFO - TEST-OK | dromaeo_css | took 1110631ms 05:36:18 INFO - TEST-START | kraken 05:36:18 INFO - operating with platform_type : mac_ 05:36:18 INFO - Initialising browser for kraken test... 05:36:18 INFO - TEST-INFO | started process 2248 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpm35i0M/profile http://localhost:49748/getInfo.html) 05:36:21 INFO - PROCESS | 2248 | __metrics Screen width/height:1600/1200 05:36:21 INFO - PROCESS | 2248 | colorDepth:24 05:36:21 INFO - PROCESS | 2248 | Browser inner width/height: 1024/689 05:36:21 INFO - PROCESS | 2248 | __metrics 05:36:21 ERROR - PROCESS | 2248 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 05:36:22 INFO - TEST-INFO | 2248: exit 0 05:36:22 INFO - Browser initialized. 05:36:22 INFO - Running cycle 1/1 for kraken test... 05:36:22 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpm35i0M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:34 INFO - PROCESS | 2251 | RSS: Main: 257155072 05:36:34 INFO - PROCESS | 2251 | 05:36:36 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49748/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:37 INFO - PROCESS | 2251 | RSS: Main: 268734464 05:36:37 INFO - PROCESS | 2251 | 05:36:40 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49748/tests/kraken/driver.html?testName=audio-dft) 05:36:40 INFO - PROCESS | 2251 | RSS: Main: 277884928 05:36:40 INFO - PROCESS | 2251 | 05:36:44 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49748/tests/kraken/driver.html?testName=audio-fft) 05:36:44 INFO - PROCESS | 2251 | RSS: Main: 280858624 05:36:44 INFO - PROCESS | 2251 | 05:36:52 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49748/tests/kraken/driver.html?testName=audio-oscillator) 05:36:53 INFO - PROCESS | 2251 | RSS: Main: 280543232 05:36:53 INFO - PROCESS | 2251 | 05:36:55 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49748/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:55 INFO - PROCESS | 2251 | RSS: Main: 281616384 05:36:55 INFO - PROCESS | 2251 | 05:36:58 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49748/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:59 INFO - PROCESS | 2251 | RSS: Main: 282656768 05:36:59 INFO - PROCESS | 2251 | 05:37:02 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49748/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:02 INFO - PROCESS | 2251 | RSS: Main: 282390528 05:37:02 INFO - PROCESS | 2251 | 05:37:05 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49748/tests/kraken/driver.html?testName=json-parse-financial) 05:37:06 INFO - PROCESS | 2251 | RSS: Main: 282279936 05:37:06 INFO - PROCESS | 2251 | 05:37:07 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49748/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:08 INFO - PROCESS | 2251 | RSS: Main: 283594752 05:37:08 INFO - PROCESS | 2251 | 05:37:10 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:10 INFO - PROCESS | 2251 | RSS: Main: 283611136 05:37:10 INFO - PROCESS | 2251 | 05:37:12 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:13 INFO - PROCESS | 2251 | RSS: Main: 284049408 05:37:13 INFO - PROCESS | 2251 | 05:37:15 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:16 INFO - PROCESS | 2251 | RSS: Main: 283000832 05:37:16 INFO - PROCESS | 2251 | 05:37:19 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:19 INFO - PROCESS | 2251 | RSS: Main: 284647424 05:37:19 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49748/tests/kraken/driver.html?testName=ai-astar) 05:37:21 INFO - PROCESS | 2251 | RSS: Main: 284438528 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | __start_tp_report 05:37:21 INFO - PROCESS | 2251 | _x_x_mozilla_page_load 05:37:21 INFO - PROCESS | 2251 | _x_x_mozilla_page_load_details 05:37:21 INFO - PROCESS | 2251 | |i|pagename|runs| 05:37:21 INFO - PROCESS | 2251 | |0;ai-astar;111;106;114;114;114;129;112;114;112;141 05:37:21 INFO - PROCESS | 2251 | |1;audio-beat-detection;155;122;143;151;126;144;147;121;156;124 05:37:21 INFO - PROCESS | 2251 | |2;audio-dft;195;195;197;200;209;214;195;198;208;202 05:37:21 INFO - PROCESS | 2251 | |3;audio-fft;72;78;70;111;68;88;89;88;122;56 05:37:21 INFO - PROCESS | 2251 | |4;audio-oscillator;86;92;114;78;81;79;114;78;79;114 05:37:21 INFO - PROCESS | 2251 | |5;imaging-gaussian-blur;89;95;88;94;88;96;88;95;88;94 05:37:21 INFO - PROCESS | 2251 | |6;imaging-darkroom;97;97;97;97;97;99;99;98;97;133 05:37:21 INFO - PROCESS | 2251 | |7;imaging-desaturate;92;93;91;91;96;99;121;94;92;92 05:37:21 INFO - PROCESS | 2251 | |8;json-parse-financial;57;56;56;57;57;57;55;64;56;56 05:37:21 INFO - PROCESS | 2251 | |9;json-stringify-tinderbox;66;69;69;71;75;71;58;79;100;97 05:37:21 INFO - PROCESS | 2251 | |10;stanford-crypto-aes;86;87;86;84;87;84;89;86;85;86 05:37:21 INFO - PROCESS | 2251 | |11;stanford-crypto-ccm;128;137;130;125;130;138;133;116;130;120 05:37:21 INFO - PROCESS | 2251 | |12;stanford-crypto-pbkdf2;132;144;140;142;147;144;166;180;151;142 05:37:21 INFO - PROCESS | 2251 | |13;stanford-crypto-sha256-iterative;67;74;90;61;74;81;56;89;92;94 05:37:21 INFO - PROCESS | 2251 | __end_tp_report 05:37:21 INFO - PROCESS | 2251 | __start_cc_report 05:37:21 INFO - PROCESS | 2251 | _x_x_mozilla_cycle_collect,869 05:37:21 INFO - PROCESS | 2251 | __end_cc_report 05:37:21 INFO - PROCESS | 2251 | __startTimestamp1455802641763__endTimestamp 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | ------- Summary: start ------- 05:37:21 INFO - PROCESS | 2251 | Number of tests: 14 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#0] ai-astar Cycles:10 Average:116.70 Median:114.00 stddev:10.34 (9.1%) stddev-sans-first:10.76 05:37:21 INFO - PROCESS | 2251 | Values: 111.0 106.0 114.0 114.0 114.0 129.0 112.0 114.0 112.0 141.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:145.50 stddev:14.15 (9.7%) stddev-sans-first:13.75 05:37:21 INFO - PROCESS | 2251 | Values: 155.0 122.0 143.0 151.0 126.0 144.0 147.0 121.0 156.0 124.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#2] audio-dft Cycles:10 Average:201.30 Median:201.00 stddev:6.80 (3.4%) stddev-sans-first:6.82 05:37:21 INFO - PROCESS | 2251 | Values: 195.0 195.0 197.0 200.0 209.0 214.0 195.0 198.0 208.0 202.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#3] audio-fft Cycles:10 Average:84.20 Median:75.00 stddev:20.13 (26.8%) stddev-sans-first:20.86 05:37:21 INFO - PROCESS | 2251 | Values: 72.0 78.0 70.0 111.0 68.0 88.0 89.0 88.0 122.0 56.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:79.00 stddev:16.11 (20.4%) stddev-sans-first:16.97 05:37:21 INFO - PROCESS | 2251 | Values: 86.0 92.0 114.0 78.0 81.0 79.0 114.0 78.0 79.0 114.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:94.00 stddev:3.54 (3.8%) stddev-sans-first:3.63 05:37:21 INFO - PROCESS | 2251 | Values: 89.0 95.0 88.0 94.0 88.0 96.0 88.0 95.0 88.0 94.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:97.00 stddev:11.24 (11.6%) stddev-sans-first:11.82 05:37:21 INFO - PROCESS | 2251 | Values: 97.0 97.0 97.0 97.0 97.0 99.0 99.0 98.0 97.0 133.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:92.50 stddev:9.10 (9.8%) stddev-sans-first:9.53 05:37:21 INFO - PROCESS | 2251 | Values: 92.0 93.0 91.0 91.0 96.0 99.0 121.0 94.0 92.0 92.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:2.51 (4.4%) stddev-sans-first:2.67 05:37:21 INFO - PROCESS | 2251 | Values: 57.0 56.0 56.0 57.0 57.0 57.0 55.0 64.0 56.0 56.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#9] json-stringify-tinderbox Cycles:10 Average:75.50 Median:71.00 stddev:13.32 (18.8%) stddev-sans-first:13.68 05:37:21 INFO - PROCESS | 2251 | Values: 66.0 69.0 69.0 71.0 75.0 71.0 58.0 79.0 100.0 97.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:1.49 (1.7%) stddev-sans-first:1.58 05:37:21 INFO - PROCESS | 2251 | Values: 86.0 87.0 86.0 84.0 87.0 84.0 89.0 86.0 85.0 86.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:130.00 stddev:6.91 (5.3%) stddev-sans-first:7.33 05:37:21 INFO - PROCESS | 2251 | Values: 128.0 137.0 130.0 125.0 130.0 138.0 133.0 116.0 130.0 120.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:145.50 stddev:14.05 (9.7%) stddev-sans-first:13.52 05:37:21 INFO - PROCESS | 2251 | Values: 132.0 144.0 140.0 142.0 147.0 144.0 166.0 180.0 151.0 142.0 05:37:21 INFO - PROCESS | 2251 | 05:37:21 INFO - PROCESS | 2251 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:85.00 stddev:13.55 (15.9%) stddev-sans-first:13.79 05:37:21 INFO - PROCESS | 2251 | Values: 67.0 74.0 90.0 61.0 74.0 81.0 56.0 89.0 92.0 94.0 05:37:21 INFO - PROCESS | 2251 | -------- Summary: end -------- 05:37:21 INFO - PROCESS | 2251 | 05:37:22 INFO - TEST-INFO | 2251: exit 0 05:37:22 INFO - TEST-OK | kraken | took 63738ms 05:37:22 INFO - SUITE-END | took 1174s 05:37:22 INFO - Completed test suite (00:19:34) 05:37:22 INFO - Working with test: dromaeo_css 05:37:22 INFO - Generating results file: dromaeo_css 05:37:22 INFO - Working with test: kraken 05:37:22 INFO - Generating results file: kraken 05:37:22 INFO - javascript benchmark 05:37:22 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:37:22 INFO - process_Request line: dromaeo_css 7458.67 graph.html#tests=[[72,1,61]] 05:37:22 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:23 INFO - process_Request line: kraken 1495.20 graph.html#tests=[[232,1,61]] 05:37:23 INFO - RETURN: dromaeo_css: 7458.67 05:37:23 INFO - RETURN: kraken: 1495.20 05:37:23 INFO - javascript benchmark 05:37:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3513.7891726496405, 3545.1314427965153, 3578.92842143157, 3601.351756683797, 3611.3499570077392, 5802.854928626781, 5858.560607954404, 5865.560082993771, 5880.882382352361, 5898.262717160355, 5834.533237341013, 5847.532197424206, 5966.850828729284, 6037.0, 6048.788292409767, 5307.2039194121, 5318.441563635821, 5373.973130134344, 5417.160340147264, 5505.504504594585, 5286.867828304304, 5309.601779866525, 5348.277982472356, 5367.221752845835, 5368.785248590052, 5206.635535512516, 5286.550643195333, 5340.145576707747, 5395.622306438551, 5403.675779453245, 5368.872536767283, 5388.191771234307, 5389.245505629176, 5400.189971504266, 5420.566354691655, 5208.427073021964, 5287.629865909388, 5368.516833485005, 5370.033393989081, 5408.107662235727, 5738.139279108125, 5812.622179558315, 5875.588708790387, 5888.293404791452, 5898.7640494380175, 6263.561550691454, 6280.9685951569945, 6282.905756413657, 6306.337834527354, 6307.148534947769, 6203.689815509251, 6263.592866463711, 6276.905846412307, 6304.968475157641, 6324.873502529969, 6018.939810601882, 6040.697965101727, 6052.092186172109, 6056.394360563952, 6094.969525152346, 6222.751089956441, 6358.205224346957, 6398.328175541595, 6403.295637479873, 6403.359664033559, 6219.0, 6263.592866463757, 6296.811095667137, 6308.873822523616, 6340.175777148941, 6270.435660790551, 6293.716782744787, 6312.463440607508, 6315.747370105144, 6323.810285691345, 5199.0, 5408.8377348679605, 6218.5647004709235, 6250.624962502265, 6271.27880293763, 6234.314225435199, 6277.560570760094, 6293.748250069946, 6297.338779428185, 6300.3699630037545, 4977.129002424561, 5007.874803129951, 5010.724410157476, 5013.724245166551, 5015.899682006339, 4414.933775993362, 4416.072624748838, 4418.690691651618, 4486.371907932892, 4549.431321084864, 4894.412670479494, 4948.233023881232, 5850.707464626752, 5874.530037597067, 5887.293524777054, 6206.255249370014, 6248.562600617913, 6292.150559674477, 6309.432151106423, 6324.209473815773, 5394.595405344615, 5599.440055994368, 5915.1718759373725, 5938.49522790559, 5947.256592925884, 5506.201600767866, 5520.696361700145, 5521.0, 5525.696086715269, 5532.5297349724915, 5263.710495922761, 6331.68341582919, 6395.6482393468805, 6428.067930150196, 6492.156019717407, 5786.971065144648, 6142.201513803177, 6316.115743795965, 6318.715657795502, 6320.6839658016, 6296.5277604178955, 6462.256840463407, 6533.379328963741, 6573.816712991707, 6586.308437614173, 6119.07606531266, 6150.892839288971, 6208.751649933952, 6214.5960512566535, 6219.844503887439, 6229.470495007794, 6261.0, 6263.4362907338555, 6263.530235232284, 6269.749210031548, 5965.403459654, 6129.358790882775, 6235.625862448268, 6238.282597501164, 6268.341824108403, 6189.566730328834, 6244.968775156095, 6252.9062064069985, 6280.560360774702, 6317.273513545817, 6031.457168854824, 6146.969265153645, 6153.569250152446, 6165.660888651168, 6168.845778855564, 6132.264128304453, 6168.136460895388, 6247.96876015617, 6269.937300627118, 6274.403931626488, 6104.938950610437, 6119.418655227746, 6124.050772130327, 6134.969325153525, 6135.570510064431], "unit": "score", "name": "dojo.html", "value": 5792.90488810367}, {"lowerIsBetter": false, "replicates": [439.2379222049745, 443.23320655266366, 453.75497231494984, 459.60703598423345, 515.3274976156117, 30456.84771576139, 37547.06132346693, 37937.62062379379, 38023.61976380235, 38165.61834381655, 39022.21955560894, 39225.803870980606, 39243.60756392435, 39324.80337598308, 39357.40963885544, 9428.350038743243, 9554.901186363588, 9607.711768646952, 9636.229101671885, 9639.566219520104, 9345.2991025673, 9490.098440648128, 9505.762355941122, 9527.333086683935, 9577.616895324214, 8407.45351552147, 9557.808843823119, 9602.807943841119, 9655.46894920779, 9689.757756056084, 9531.618735250582, 9563.80872382552, 9585.185259252938, 9619.615215391412, 9623.278254130968, 9577.425354478684, 9613.51932403377, 9684.370515916444, 9725.805483890283, 9731.41611503312, 37994.050148746224, 38132.61867381319, 38194.809025954695, 38232.80883595592, 38341.80829095837, 2737.86310684465, 3020.9848950755104, 3602.513660655804, 3682.2635472905527, 3932.252871954348, 26550.6017409739, 26722.732772672218, 27301.0, 27400.451990960268, 27680.031198907942, 2801.9719802801915, 2836.1349788314556, 2848.900288489893, 2874.453853767777, 2887.942241155165, 348110.0, 387416.0, 395739.0, 400294.0, 400353.0, 56896.0, 61268.38731612627, 62735.68632156901, 64911.0, 67820.32179678239, 53294.200586991225, 64899.67550162219, 64924.675376622814, 65209.0, 66078.33921660818, 16053.518394448185, 16237.59406014859, 16511.09188994617, 16569.0, 16615.50153495397, 12481.93903518193, 12562.560310389092, 12575.308358040396, 12643.87356126427, 12798.808017879739, 17097.0, 19865.404037878885, 20451.0, 20792.48018799512, 20810.79189208119, 8795.692150774692, 8972.730818075468, 9005.767289373984, 9009.23421509179, 9031.412958157698, 940.7930255343813, 959.7072892767633, 979.774651830083, 988.17981075707, 1057.5716834681966, 25766.613500797503, 29400.970966016088, 29597.964071257404, 29839.85080074586, 30101.698983010327, 1039.4802598700649, 1080.8811030786608, 1107.595727559451, 1185.6028230542865, 1190.0301254477572, 14873.92563037178, 15036.699266014619, 15038.097714137186, 15161.0, 15230.46693365749, 527687.0, 528873.0, 530300.0, 532955.3352233215, 534141.0, 58343.0, 58758.70620646869, 59019.70490147522, 59262.407375925686, 59308.0, 1368.6167872995577, 1372.8627137286192, 1373.203541945669, 1391.2348208485294, 1392.0673148990202, 29032.274193145342, 29283.85358073196, 29444.558331624616, 29721.405571888874, 29823.254418639706, 51533.48466515287, 51556.0, 51866.48133518767, 51972.0, 52029.0, 492515.0, 495687.0, 497366.0, 498124.0, 498902.0, 33308.333833322715, 37871.43192852165, 44039.339409908236, 44105.89735256644, 45470.090598188515, 45543.0, 47136.764316178196, 47798.76100619475, 47926.760366197945, 48763.0, 37017.81491092527, 37681.62318376781, 37922.86231413062, 38138.42792358062, 38206.61793382031, 35198.824005879804, 36672.81663591665, 37328.0, 37459.87620371393, 38005.809970949966, 37460.68887588922, 37670.434943475324, 37955.24089518249, 37957.810210948766, 38548.843534694, 25017.499650007263, 30393.0, 31576.842115789274, 31616.841915790275, 31826.204344890637, 22632.547349053257, 24018.39954001164, 24062.759372406053, 24064.87967560151, 24353.756462435857], "unit": "score", "name": "ext.html", "value": 19614.724702544536}, {"lowerIsBetter": false, "replicates": [331.45641148516455, 358.2333805655897, 360.52230794197686, 365.95425571803526, 366.7561071887195, 15593.532194034196, 18005.369812056582, 19104.808951910476, 19471.221151153954, 20255.49361265969, 19337.226510939545, 19362.612747745072, 19432.417027489162, 19517.316893908715, 19658.0, 5515.889682206353, 5724.513416359614, 5766.279215098113, 5835.5915085944, 5855.502282306009, 5585.609007369486, 5844.707764611774, 5850.590458667895, 5854.619449735775, 5861.238039054917, 3907.960920390788, 5475.0966090595, 5739.253896993385, 5873.119032145191, 5894.764209431618, 5764.596478246483, 5894.292684877821, 5928.258967629046, 5961.463468287875, 6066.302375226839, 5584.553235741131, 5587.860303492445, 5591.049521581341, 5667.744951477152, 5702.8289151325525, 13167.275799831006, 13391.933040334736, 13443.932780336134, 13471.461141554326, 13557.457701691921, 1884.2839720905968, 1980.4553747719349, 2037.7758446570865, 2212.148322895681, 2527.330257481769, 10133.493325333704, 10146.847797283046, 10365.01532354425, 13629.659258518517, 14443.638909027253, 1746.5109769264627, 1774.3346245158066, 1794.973075403857, 1809.2129923483326, 1838.0534024977148, 88542.0, 95231.0, 100666.9933300665, 101764.0, 102488.48755756248, 11006.064484518905, 11282.830757538644, 11317.981381675689, 11327.716807079889, 11419.314841109393, 13347.799783003262, 13380.799288010687, 13431.86568134306, 13434.596962090958, 13446.05877588579, 8335.208155225244, 8390.077091519928, 8396.874046889301, 8413.45312554682, 8427.28368088707, 8203.343732501386, 8381.203785640355, 8384.832303353898, 8403.285720713686, 8413.95793021031, 3927.703857726943, 4350.390945267665, 4432.84485043022, 4444.8444304449185, 4464.241079016575, 1568.8077061433394, 1687.0, 1902.6955687089999, 1926.9325573604856, 1936.448112287991, 399.09405649176784, 404.7308539821045, 416.8728537796001, 419.6957206025668, 428.88986187955334, 9372.062793720574, 11044.834327485094, 11927.284362938251, 11992.580259691043, 12064.57773977924, 434.83476279014405, 443.28409618465946, 450.4279564952492, 451.73573459525886, 458.6995517935757, 5957.821265362046, 8340.0, 9419.62321507132, 11310.886891131147, 11398.0, 529182.0, 543621.0, 544047.0, 584098.0, 659533.0, 67256.0, 103091.2990655605, 109271.0, 112068.0, 113567.0, 998.5805961496189, 1027.1628622672497, 1044.216837371971, 1048.9527971241312, 1052.1004541117388, 17920.0, 17966.461006169837, 18055.277788888296, 18074.728879067086, 18355.990420527, 35715.0, 46904.06191876075, 47605.761971189924, 47850.5214947846, 50853.49146508487, 68025.31974680189, 69022.0, 69544.3045569558, 69600.0, 69679.30320696728, 6480.6435646038035, 7649.732259370895, 7822.921770782219, 7879.0151231096115, 7886.921130788619, 10201.38791672502, 12083.818742719042, 12265.202761820454, 12351.073669475005, 12395.380230988234, 7594.886374932881, 9844.704658860246, 10237.232207584311, 10617.1506279499, 10846.728831779268, 10419.322744021614, 10488.00363965422, 10699.732506687395, 10741.301815381976, 10860.674179774303, 11003.779924401628, 11019.173561982723, 11173.776524469627, 11305.378204198849, 11327.886721132683, 7449.779568712816, 7794.337481314152, 7848.175941526286, 7885.6451459685595, 7894.092179399443, 10223.335483193569, 10289.536970836181, 10438.0, 11100.61147859821, 11157.330560166416], "unit": "score", "name": "jquery.html", "value": 8431.686345189648}, {"lowerIsBetter": false, "replicates": [1516.476815498653, 1524.5883611424915, 1744.1192197940038, 1849.4081893793982, 1854.3602457152278, 7825.960870195641, 8425.78935526612, 8520.872186917193, 8687.695930642429, 8732.08313127122, 8458.703945361913, 8521.105283945173, 8580.485170889751, 8630.568471576427, 8643.87034194486, 2437.2688193541953, 2439.1097249503982, 2447.8531288122767, 2477.0339567568662, 2479.6776419065495, 2427.8421902576365, 2472.9629055564183, 2487.166799122296, 2492.6510288559616, 2501.9249422517264, 2147.6563749800034, 2384.988075059622, 2415.070197973784, 2418.806495480357, 2502.249325202441, 1965.5872266823912, 2017.3241963942096, 2428.0530593068715, 2455.5702752018506, 2467.814913881466, 2379.892904819287, 2435.403326185078, 2449.9877500612383, 2450.8652024138664, 2453.4970331082086, 7545.622718864035, 7782.027246594176, 8599.699010534601, 8601.827963440695, 8639.52482613456, 5034.823781167642, 5436.809711660112, 5452.972735136339, 5469.507744302992, 5486.698231597261, 3022.9244268893453, 3525.9294814103832, 3536.1336472564385, 3617.94573081404, 3637.9272414551824, 1061.0238580505952, 1066.9359838409644, 1076.590895459728, 1078.9514471848786, 1091.9344839309667, 11805.704857378549, 11852.34812085335, 11858.229215100991, 11868.0, 11883.524659013628, 4762.357081793983, 4842.927356089662, 4863.610911127102, 4879.780409881564, 4896.804127834846, 10031.147352474976, 10042.347247428894, 10056.296059275926, 10072.697819065439, 10103.949480252551, 5477.424870388551, 5480.91778623321, 5501.614886957875, 5501.972490137524, 5503.889922201613, 5005.049040682259, 5031.421386540522, 5033.748312584356, 5035.345405097314, 5038.697678139323, 3893.357595996629, 3914.4715463412645, 3940.2907476654477, 3969.4839670842607, 3971.3050216212046, 1311.4426368793224, 1313.9408726607326, 1314.5070598525554, 1325.562564353761, 1342.154442701092, 954.4130359828655, 1111.111111111124, 1132.5413207650915, 1184.727512672073, 1230.4647478346947, 7946.245106714853, 7963.8805417918775, 8018.879716804253, 8024.0, 8028.678852845937, 1150.8791576884473, 1166.5217260922982, 1167.0721776187952, 1172.302480024384, 1202.8316035755001, 6118.235220597426, 6226.0, 6236.251649802053, 6239.656818874914, 6256.186695729617, 10315.742106447398, 10325.9483702581, 10512.842307365396, 10641.574337026586, 10661.84007239892, 10301.227407944285, 10403.895961040444, 10496.212784041074, 10531.684049478528, 10579.206559508068, 7462.0, 8086.43394962347, 8189.181081891882, 8237.341012718967, 8268.462549934235, 7705.499142555716, 7721.6139193039, 7740.612969351622, 7758.8448231033935, 7810.6485208166905, 9183.448993060438, 9427.387219830689, 9507.572159252712, 9628.47043412619, 9683.176929961031, 9672.806543869225, 9793.804123917624, 9812.558434870305, 9965.900340996497, 9980.0, 7487.288707572772, 7599.772006839804, 7613.847723045397, 7621.809454763454, 7628.504147230412, 8096.757097287091, 8244.464109832841, 8274.958625206835, 8291.58542072906, 8292.2951549119, 6250.874982500415, 7437.256274372519, 7473.813154671177, 7488.5506869588, 7497.400207983457, 6591.868162636624, 6996.0905082341005, 7016.36852683261, 7082.716691332495, 7186.46101542376, 5629.577781666309, 7373.63131843395, 7403.546912459002, 7460.3658689012045, 7469.775906722807, 5772.7690892363835, 6858.588484690935, 6882.518223724492, 6897.7240910365035, 6906.723731050702, 6917.308269173042, 6920.550164239308, 6958.165020197609, 7003.0, 7022.964885175746], "unit": "score", "name": "mootools.html", "value": 4874.208327247299}, {"lowerIsBetter": false, "replicates": [304.36387949186195, 310.9113902537776, 324.40147927074554, 330.67758935038324, 335.85893924551686, 6253.218347706531, 6307.653079080649, 6880.518363714542, 7021.8595628087405, 7034.155901291846, 7042.330978557042, 7045.5772653640815, 7057.0, 7085.822854428629, 7114.146302443714, 4189.476315460567, 4245.872623821283, 5233.319668443097, 5238.292830467876, 5252.894942101156, 4861.416630004404, 5149.407818100929, 5225.921611175835, 5248.6588371755715, 5267.683938963655, 4971.279164521142, 4973.428055773578, 4975.975120124413, 4977.104121258172, 4981.178105612569, 4969.552740253376, 4970.87572810679, 4971.179755340382, 4985.775640096204, 5003.799848006075, 4038.030872590557, 4134.565870583606, 4221.092465119983, 4234.830606775725, 4243.702940794145, 6566.704498297588, 6624.205095388585, 6636.535442519025, 6636.73453061877, 6695.732170713166, 5937.970310148465, 5946.167536544887, 5950.285965684102, 5950.7322170502, 5968.4031596840405, 7106.147262328554, 7342.15565209997, 7362.484626076177, 7444.032275804111, 7444.776656700307, 4355.760433176174, 4690.9530904690855, 4694.342792009122, 4695.765211739399, 4701.506341834092, 6937.340952609545, 7788.961055194744, 7883.921160788376, 7924.405669574748, 7945.284924356778, 4613.792379342937, 4763.2140696784645, 4770.976145119253, 4773.498782627844, 4789.3294938708605, 4837.177679794443, 4860.076585448754, 4863.148948933923, 4869.732164730974, 4878.487758785347, 5808.912866307009, 5864.618799778001, 5885.323187833454, 5927.911081333784, 5930.258717660293, 7288.610795979895, 7523.7366692165515, 7542.47202695806, 7558.168601453835, 7573.545587264782, 1694.7627332173506, 1723.4743403261875, 1724.862011039114, 1729.092226581055, 1732.1512458895302, 1070.29895418501, 1071.0735214039955, 1075.6611667324767, 1083.918706097046, 1089.2484185911696, 7190.173130090002, 7202.675879585431, 7223.27767223284, 7227.241139680363, 7231.132264128339, 6461.579997300254, 8056.436049476481, 8061.234182752629, 8113.472624279521, 8124.878126828103, 6936.895946560806, 7144.678489467882, 7194.928050719531, 7218.0, 7225.060742103598, 4111.054457474797, 4174.812133453941, 4195.202911446815, 4242.639375653104, 4259.5101563319995, 8406.201410865959, 8410.915890841135, 8423.241908228289, 8454.196851299117, 8458.534780587004, 7893.447458677952, 8474.703385381483, 8474.74575762728, 8486.830263394697, 8491.830163396697, 8260.83478330442, 8274.089850116483, 8277.668893244203, 8291.253787159185, 8305.916940830635, 6239.344868788712, 6569.737210511526, 7651.693932242871, 7919.366450684047, 7921.762347129596, 5483.917741233964, 6234.719437625408, 7465.4027677786735, 7539.8492030157995, 7758.107817600822, 6676.966615167087, 8275.917240827515, 8291.419600627898, 8297.875531866906, 8298.087210406971, 4779.211430113992, 4847.254988204173, 4850.0, 4859.149648811514, 4869.732164730832, 6418.807435776934, 6904.4131248842405, 7125.0, 7825.1783562725095, 7883.448158628841, 7555.8866616999685, 7560.470767046254, 7570.659320330488, 7573.734919277799, 7585.962070189614, 5773.624714393719, 7345.861391484328, 7547.132079810892, 7552.207018263223, 7557.130929942907, 7369.852602948018, 7381.298776616213, 7388.445866559922, 7392.852142957003, 7423.925760742323, 6302.401271879165, 7401.259874012771, 7552.169261381134, 7570.962145189239, 7576.583287919218, 7160.964195179199, 7311.4516411268305, 7367.557946523226, 7370.77887663371, 7395.223501532261], "unit": "score", "name": "prototype.html", "value": 5394.188963180738}, {"lowerIsBetter": false, "replicates": [650.2002536879638, 665.5673812022186, 681.9079424277725, 713.2368365848542, 724.8115489972605, 13993.440262389518, 14691.632709182275, 14767.335469903866, 14929.850701492982, 17390.913045434787, 15951.963122397035, 16009.359625614961, 16036.43872464464, 16100.872938894283, 16107.43623973161, 695.5235663570445, 846.809467869729, 847.7456762971115, 855.0423525651248, 874.9737507874773, 860.0754189246585, 867.6269204242205, 869.9739007829776, 870.1689886158734, 873.4235404632943, 883.801144742431, 884.1644645809712, 911.9316051296146, 915.0254978447965, 917.9127982841653, 892.955352232389, 902.580300160422, 910.3854897943894, 910.4855756497558, 911.1435250864166, 647.7700416352221, 673.4208580620663, 674.1741366825648, 675.1931441926899, 675.2774531251563, 14956.0, 15093.773593396108, 15202.239888005666, 15235.162066086361, 15296.311665975058, 12556.372181390894, 12565.371731413392, 12664.620061398173, 12684.0, 13099.08306418551, 10213.540390682363, 10337.534810933526, 10935.671929842038, 11353.545858165664, 11478.942605287004, 3525.7531972761917, 3529.4529347951107, 3552.87564935226, 3565.750397472178, 3641.890743277706, 84369.15630843674, 84634.30731385338, 84702.57648711778, 85937.14062859354, 86629.56685216534, 9325.020872808258, 9400.0, 9562.039781844705, 9608.231341492663, 9967.651132210338, 19944.401667949984, 20118.59762804736, 20196.899015504827, 20216.292429764886, 20250.189992400137, 7380.261973802577, 7387.704491820267, 7664.80837979055, 7791.610419479117, 7855.332296754726, 3196.0411876436974, 4058.979705101515, 4061.5126184858004, 4068.0846809468226, 4093.205896130061, 2952.867120979561, 3534.4698295255916, 3571.196480791853, 3574.964250357515, 3587.982060089683, 564.6927363154284, 604.4680681000779, 648.1962366665301, 663.5653646861314, 675.6351570152161, 497.2044728434548, 529.534010071135, 624.1168746224042, 634.8381162803455, 652.5790864892118, 8064.677412903536, 8447.873281900776, 8503.914960850312, 8606.31149508038, 8716.477011379338, 487.8438101698996, 544.7984245829068, 622.181830892375, 626.0649047034142, 636.8216899268213, 3937.27160475313, 3943.4479172915817, 3979.7015223858325, 4002.639762421396, 4056.127932494528, 94194.52902735579, 94890.0, 95087.0, 95641.0, 98817.50591247142, 63455.0, 75482.0, 79173.0, 79810.20189798143, 80464.0, 68005.0, 68073.99999999901, 69159.0, 70452.29547704458, 71753.64123179455, 7872.153288842831, 8073.475224110649, 8097.595120244082, 8240.21717936795, 8346.833063338578, 48667.783305417644, 52002.0, 52372.0, 52375.476245238584, 52847.47152528426, 68005.65997169983, 70565.0, 71918.56162876818, 72628.27371726427, 73304.26695732975, 10260.743481413025, 10437.634682786065, 10660.0, 10777.515011824644, 11126.998570128728, 11158.0, 11353.205275630626, 11363.318200907972, 11412.02997745201, 11419.257748246337, 10230.181585472996, 10405.427701476492, 10668.73328166771, 10705.571777129138, 10767.946160269148, 10532.631357902437, 10706.304090234109, 10727.356358618508, 10759.569617215224, 10823.783524329627, 10318.690439286833, 10390.532426040998, 10583.576656933945, 10586.682399528027, 10676.092532134855, 8125.919828381803, 8408.663653453794, 8945.865812012695, 9011.459312441013, 9108.681196158102, 9080.682176123804, 9985.494546840766, 10023.200011922952, 10038.19694424459, 10078.305757247132], "unit": "score", "name": "yui.html", "value": 6834.595831619522}], "name": "dromaeo_css", "value": 7458.670537425184}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 114.0, 114.0, 114.0, 129.0, 112.0, 114.0, 112.0, 141.0], "unit": "score", "name": "ai-astar", "value": 116.7}, {"lowerIsBetter": true, "replicates": [155.0, 122.0, 143.0, 151.0, 126.0, 144.0, 147.0, 121.0, 156.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 138.9}, {"lowerIsBetter": true, "replicates": [195.0, 195.0, 197.0, 200.0, 209.0, 214.0, 195.0, 198.0, 208.0, 202.0], "unit": "score", "name": "audio-dft", "value": 201.3}, {"lowerIsBetter": true, "replicates": [72.0, 78.0, 70.0, 111.0, 68.0, 88.0, 89.0, 88.0, 122.0, 56.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 114.0, 78.0, 81.0, 79.0, 114.0, 78.0, 79.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 91.5}, {"lowerIsBetter": true, "replicates": [89.0, 95.0, 88.0, 94.0, 88.0, 96.0, 88.0, 95.0, 88.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.5}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 99.0, 99.0, 98.0, 97.0, 133.0], "unit": "score", "name": "imaging-darkroom", "value": 101.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 91.0, 91.0, 96.0, 99.0, 121.0, 94.0, 92.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 57.0, 57.0, 57.0, 55.0, 64.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 69.0, 71.0, 75.0, 71.0, 58.0, 79.0, 100.0, 97.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 75.5}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 84.0, 87.0, 84.0, 89.0, 86.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [128.0, 137.0, 130.0, 125.0, 130.0, 138.0, 133.0, 116.0, 130.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [132.0, 144.0, 140.0, 142.0, 147.0, 144.0, 166.0, 180.0, 151.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [67.0, 74.0, 90.0, 61.0, 74.0, 81.0, 56.0, 89.0, 92.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.8}], "name": "kraken", "value": 1495.2}]} 05:37:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1495.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7458.67"}}} 05:37:23 INFO - Return code: 0 05:37:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:23 ERROR - # TBPL SUCCESS # 05:37:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:23 INFO - 2016-02-18 05:37:23.180 screenresolution[2256:15192] starting screenresolution argv=screenresolution get 05:37:23 INFO - 2016-02-18 05:37:23.183 screenresolution[2256:15192] Display 0: 1600x1200x32@60 05:37:23 INFO - 2016-02-18 05:37:23.189 screenresolution[2257:15195] starting screenresolution argv=screenresolution list 05:37:23 INFO - Available Modes on Display 0 05:37:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:23 INFO - Intel Iris: 05:37:23 INFO - Chipset Model: Intel Iris 05:37:23 INFO - Type: GPU 05:37:23 INFO - Bus: Built-In 05:37:23 INFO - VRAM (Dynamic, Max): 1536 MB 05:37:23 INFO - Vendor: Intel (0x8086) 05:37:23 INFO - Device ID: 0x0a2e 05:37:23 INFO - Revision ID: 0x0009 05:37:23 INFO - Displays: 05:37:23 INFO - Display: 05:37:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:23 INFO - Display Serial Number: 1600x1200 60 05:37:23 INFO - Main Display: Yes 05:37:23 INFO - Mirror: Off 05:37:23 INFO - Online: Yes 05:37:23 INFO - Rotation: Supported 05:37:23 INFO - Return code: 0 05:37:23 INFO - Running post-action listener: _resource_record_post_action 05:37:23 INFO - Running post-run listener: _resource_record_post_run 05:37:24 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 303104; Write bytes: 710600704; Read time: 4; Write time: 2197 05:37:24 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397576704; Write bytes: 393033728; Read time: 30002; Write time: 774 05:37:24 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 303104; Write bytes: 301809664; Read time: 4; Write time: 1381 05:37:24 INFO - Running post-run listener: _upload_blobber_files 05:37:24 INFO - Blob upload gear active. 05:37:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:24 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'] 05:37:24 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 05:37:24 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:37:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:26 INFO - (blobuploader) - INFO - Done attempting. 05:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:26 INFO - (blobuploader) - INFO - Done attempting. 05:37:26 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:27 INFO - Return code: 0 05:37:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1dd98eebca55d67771ed5aabb3489c00c3ec93d258f23cf7a527915e446294caf9231bcc23f620a95ccbb8aac6fc54fdfc7af94356d3dfea1bf9093c96536b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f311934d6775efd7249554e764d6a1cdd52754cc2569cb7bcb6e459ef50fbc037726015637110a8c5827a028bab5f40b1012e3a09a836714d72f82ebb0bbb763"} 05:37:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:27 INFO - Contents: 05:37:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1dd98eebca55d67771ed5aabb3489c00c3ec93d258f23cf7a527915e446294caf9231bcc23f620a95ccbb8aac6fc54fdfc7af94356d3dfea1bf9093c96536b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f311934d6775efd7249554e764d6a1cdd52754cc2569cb7bcb6e459ef50fbc037726015637110a8c5827a028bab5f40b1012e3a09a836714d72f82ebb0bbb763"} 05:37:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:27 INFO - Copying logs to upload dir... 05:37:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.852057 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-18 05:37:27.218003) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 05:37:27.221565) ========= 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.h3t04WEyOd/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.QNqqsZA96D/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1dd98eebca55d67771ed5aabb3489c00c3ec93d258f23cf7a527915e446294caf9231bcc23f620a95ccbb8aac6fc54fdfc7af94356d3dfea1bf9093c96536b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f311934d6775efd7249554e764d6a1cdd52754cc2569cb7bcb6e459ef50fbc037726015637110a8c5827a028bab5f40b1012e3a09a836714d72f82ebb0bbb763"} build_url:https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/V0J6Mn_iQJGp7yGeExYqtw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1dd98eebca55d67771ed5aabb3489c00c3ec93d258f23cf7a527915e446294caf9231bcc23f620a95ccbb8aac6fc54fdfc7af94356d3dfea1bf9093c96536b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f311934d6775efd7249554e764d6a1cdd52754cc2569cb7bcb6e459ef50fbc037726015637110a8c5827a028bab5f40b1012e3a09a836714d72f82ebb0bbb763"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 05:37:27.248325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:37:27.248659) ========= 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.h3t04WEyOd/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.QNqqsZA96D/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005186 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:37:27.296732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 05:37:27.297039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 05:37:27.297391) ========= ========= Total master_lag: 0.32 =========