builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0054 starttime: 1460561519.03 results: success (0) buildid: 20160413072445 builduid: e5bfafaaf5544b7d9fbd14bc6181de11 revision: 08693317e6581716cc6a8c3d95ed7ff6e16d2886 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 08:31:59.030986) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 08:31:59.031460) ========= ========= Started set props: basedir (results: 0, elapsed: 11 secs) (at 2016-04-13 08:31:59.031788) ========= 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.INttTzbOGt/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.bDmIPepH3p/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005437 basedir: '/builds/slave/test' ========= master_lag: 11.55 ========= ========= Finished set props: basedir (results: 0, elapsed: 11 secs) (at 2016-04-13 08:32:10.583910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-13 08:32:10.587817) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-13 08:32:11.674091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:11.674396) ========= 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.INttTzbOGt/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.bDmIPepH3p/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005840 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:11.877662) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:11.877969) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:11.878344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 08:32:11.878614) ========= 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.INttTzbOGt/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.bDmIPepH3p/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-13 08:32:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-04-13 08:32:12 (37.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.533361 ========= master_lag: 1.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 08:32:13.702648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:13.703067) ========= 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.INttTzbOGt/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.bDmIPepH3p/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.026652 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:13.767233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-13 08:32:13.767668) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08693317e6581716cc6a8c3d95ed7ff6e16d2886 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08693317e6581716cc6a8c3d95ed7ff6e16d2886 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.INttTzbOGt/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.bDmIPepH3p/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-13 08:32:13,844 truncating revision to first 12 chars 2016-04-13 08:32:13,844 Setting DEBUG logging. 2016-04-13 08:32:13,844 attempt 1/10 2016-04-13 08:32:13,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/08693317e658?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 08:32:15,229 unpacking tar archive at: mozilla-aurora-08693317e658/testing/mozharness/ program finished with exit code 0 elapsedTime=1.635404 ========= master_lag: 1.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-13 08:32:16.424657) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:16.425033) ========= echo 08693317e6581716cc6a8c3d95ed7ff6e16d2886 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'08693317e6581716cc6a8c3d95ed7ff6e16d2886'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.INttTzbOGt/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.bDmIPepH3p/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08693317e6581716cc6a8c3d95ed7ff6e16d2886 program finished with exit code 0 elapsedTime=0.006308 script_repo_revision: '08693317e6581716cc6a8c3d95ed7ff6e16d2886' ========= master_lag: 0.82 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:17.254494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:17.254818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 08:32:17.298136) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-13 08:32:17.298609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.INttTzbOGt/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.bDmIPepH3p/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:32:17 INFO - MultiFileLogger online at 20160413 08:32:17 in /builds/slave/test 08:32:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:32:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:17 INFO - {'append_to_log': False, 08:32:17 INFO - 'base_work_dir': '/builds/slave/test', 08:32:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:32:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:17 INFO - 'branch': 'Mozilla-Aurora', 08:32:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:17 INFO - 'config_files': ('talos/mac_config.py',), 08:32:17 INFO - 'default_actions': ('clobber', 08:32:17 INFO - 'read-buildbot-config', 08:32:17 INFO - 'download-and-extract', 08:32:17 INFO - 'populate-webroot', 08:32:17 INFO - 'create-virtualenv', 08:32:17 INFO - 'install', 08:32:17 INFO - 'run-tests'), 08:32:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:17 INFO - 'download_minidump_stackwalk': True, 08:32:17 INFO - 'download_symbols': 'ondemand', 08:32:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:17 INFO - 'installer_path': 'installer.exe', 08:32:17 INFO - 'log_level': 'info', 08:32:17 INFO - 'log_name': 'talos', 08:32:17 INFO - 'log_to_console': True, 08:32:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:32:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:32:17 INFO - 'opt_config_files': (), 08:32:17 INFO - 'pip_index': False, 08:32:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:17 INFO - 'cmd': ('bash', 08:32:17 INFO - '-c', 08:32:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:17 INFO - 'enabled': True, 08:32:17 INFO - 'halt_on_failure': False, 08:32:17 INFO - 'name': 'check_screen_resolution'},), 08:32:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:17 INFO - 'cmd': ('bash', 08:32:17 INFO - '-c', 08:32:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:17 INFO - 'enabled': True, 08:32:17 INFO - 'halt_on_failure': False, 08:32:17 INFO - 'name': 'check_screen_resolution'},), 08:32:17 INFO - 'run_cmd_checks_enabled': True, 08:32:17 INFO - 'sps_profile': False, 08:32:17 INFO - 'sps_profile_interval': 0, 08:32:17 INFO - 'suite': 'dromaeojs', 08:32:17 INFO - 'system_bits': '32', 08:32:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:17 INFO - 'title': 't-yosemite-r7-0054', 08:32:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:17 INFO - 'use_talos_json': True, 08:32:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:17 INFO - 'work_dir': 'build'} 08:32:17 INFO - ##### 08:32:17 INFO - ##### Running clobber step. 08:32:17 INFO - ##### 08:32:17 INFO - Running pre-action listener: _resource_record_pre_action 08:32:17 INFO - Running main action method: clobber 08:32:17 INFO - rmtree: /builds/slave/test/build 08:32:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:19 INFO - Running post-action listener: _resource_record_post_action 08:32:19 INFO - ##### 08:32:19 INFO - ##### Running read-buildbot-config step. 08:32:19 INFO - ##### 08:32:19 INFO - Running pre-action listener: _resource_record_pre_action 08:32:19 INFO - Running main action method: read_buildbot_config 08:32:19 INFO - Using buildbot properties: 08:32:19 INFO - { 08:32:19 INFO - "project": "", 08:32:19 INFO - "product": "firefox", 08:32:19 INFO - "script_repo_revision": "production", 08:32:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:32:19 INFO - "repository": "", 08:32:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:32:19 INFO - "buildid": "20160413072445", 08:32:19 INFO - "pgo_build": "False", 08:32:19 INFO - "basedir": "/builds/slave/test", 08:32:19 INFO - "buildnumber": 170, 08:32:19 INFO - "slavename": "t-yosemite-r7-0054", 08:32:19 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:32:19 INFO - "platform": "yosemite_r7", 08:32:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:32:19 INFO - "branch": "mozilla-aurora", 08:32:19 INFO - "repo_path": "releases/mozilla-aurora", 08:32:19 INFO - "revision": "08693317e6581716cc6a8c3d95ed7ff6e16d2886", 08:32:19 INFO - "stage_platform": "macosx64", 08:32:19 INFO - "builduid": "e5bfafaaf5544b7d9fbd14bc6181de11", 08:32:19 INFO - "slavebuilddir": "test" 08:32:19 INFO - } 08:32:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 08:32:19 INFO - Running post-action listener: _resource_record_post_action 08:32:19 INFO - ##### 08:32:19 INFO - ##### Running download-and-extract step. 08:32:19 INFO - ##### 08:32:19 INFO - Running pre-action listener: _resource_record_pre_action 08:32:19 INFO - Running main action method: download_and_extract 08:32:19 INFO - mkdir: /builds/slave/test/build/tests 08:32:19 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')]} 08:32:19 INFO - https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:32:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:32:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:32:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 08:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 08:32:22 INFO - Downloaded 1277 bytes. 08:32:22 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 08:32:22 INFO - Using the following test package requirements: 08:32:22 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:32:22 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:32:22 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 08:32:22 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:32:22 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 08:32:22 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:32:22 INFO - u'jsshell-mac.zip'], 08:32:22 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:32:22 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 08:32:22 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:32:22 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:32:22 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 08:32:22 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:32:22 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 08:32:22 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:32:22 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 08:32:22 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:32:22 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:32:22 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 08:32:22 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:22 INFO - https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:32:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:32:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:32:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:32:25 INFO - Downloaded 17910943 bytes. 08:32:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:32:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:32:29 INFO - Return code: 0 08:32:29 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:32:29 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')]} 08:32:29 INFO - https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:32:32 INFO - Downloaded 17910943 bytes. 08:32:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:32:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:32:36 INFO - Return code: 0 08:32:36 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')]} 08:32:36 INFO - https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:32:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:32:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:32:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:32:38 INFO - Downloaded 10845168 bytes. 08:32:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:32:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:32:38 INFO - Return code: 0 08:32:38 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')]} 08:32:38 INFO - https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:32:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:32:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:32:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 08:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 08:32:42 INFO - Downloaded 115213091 bytes. 08:32:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:32:42 INFO - mkdir: /builds/slave/test/properties 08:32:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:42 INFO - Contents: 08:32:42 INFO - build_url:https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:32:43 INFO - Running post-action listener: _resource_record_post_action 08:32:43 INFO - Running post-action listener: set_extra_try_arguments 08:32:43 INFO - ##### 08:32:43 INFO - ##### Running populate-webroot step. 08:32:43 INFO - ##### 08:32:43 INFO - Running pre-action listener: _resource_record_pre_action 08:32:43 INFO - Running main action method: populate_webroot 08:32:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:43 INFO - '--tppagecycles', 08:32:43 INFO - '7'], 08:32:43 INFO - 'tests': ['tsvgm']}}, 08:32:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:32:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:32:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:32:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:32:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:43 INFO - 'talos_options': ['--e10s'], 08:32:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:43 INFO - 'tests': ['damp', 'tps']}, 08:32:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:43 INFO - 'talos_options': ['--e10s'], 08:32:43 INFO - 'tests': ['damp', 'tps']}, 08:32:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:32:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:43 INFO - 'other': {'tests': ['a11yr', 08:32:43 INFO - 'ts_paint', 08:32:43 INFO - 'tpaint', 08:32:43 INFO - 'sessionrestore', 08:32:43 INFO - 'sessionrestore_no_auto_restore', 08:32:43 INFO - 'tabpaint']}, 08:32:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:32:43 INFO - 'tests': ['a11yr', 08:32:43 INFO - 'ts_paint', 08:32:43 INFO - 'tpaint', 08:32:43 INFO - 'sessionrestore', 08:32:43 INFO - 'sessionrestore_no_auto_restore', 08:32:43 INFO - 'tabpaint']}, 08:32:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:32:43 INFO - 'tests': ['a11yr', 08:32:43 INFO - 'ts_paint', 08:32:43 INFO - 'tpaint', 08:32:43 INFO - 'sessionrestore', 08:32:43 INFO - 'sessionrestore_no_auto_restore', 08:32:43 INFO - 'tabpaint']}, 08:32:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:32:43 INFO - 'tests': ['a11yr', 08:32:43 INFO - 'ts_paint', 08:32:43 INFO - 'tpaint', 08:32:43 INFO - 'sessionrestore', 08:32:43 INFO - 'sessionrestore_no_auto_restore', 08:32:43 INFO - 'tabpaint']}, 08:32:43 INFO - 'other_l64': {'tests': ['a11yr', 08:32:43 INFO - 'ts_paint', 08:32:43 INFO - 'tpaint', 08:32:43 INFO - 'sessionrestore', 08:32:43 INFO - 'sessionrestore_no_auto_restore', 08:32:43 INFO - 'tabpaint']}, 08:32:43 INFO - 'other_nol64': {'tests': ['a11yr', 08:32:43 INFO - 'ts_paint', 08:32:43 INFO - 'tpaint', 08:32:43 INFO - 'sessionrestore', 08:32:43 INFO - 'sessionrestore_no_auto_restore', 08:32:43 INFO - 'tabpaint']}, 08:32:43 INFO - 'svgr': {'tests': ['tsvgx', 08:32:43 INFO - 'tsvgr_opacity', 08:32:43 INFO - 'tart', 08:32:43 INFO - 'tscrollx', 08:32:43 INFO - 'cart']}, 08:32:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:32:43 INFO - 'tests': ['tsvgx', 08:32:43 INFO - 'tsvgr_opacity', 08:32:43 INFO - 'tart', 08:32:43 INFO - 'tscrollx', 08:32:43 INFO - 'cart']}, 08:32:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:43 INFO - 'tests': ['tp5o']}, 08:32:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:43 INFO - 'talos_options': ['--e10s'], 08:32:43 INFO - 'tests': ['tp5o']}, 08:32:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:43 INFO - 'talos_options': ['--xperf_path', 08:32:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:43 INFO - 'tests': ['tp5n']}, 08:32:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:43 INFO - 'talos_options': ['--e10s', 08:32:43 INFO - '--xperf_path', 08:32:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:43 INFO - 'tests': ['tp5n']}}, 08:32:43 INFO - 'talos.zip': {'path': '', 08:32:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:43 INFO - Running post-action listener: _resource_record_post_action 08:32:43 INFO - ##### 08:32:43 INFO - ##### Running create-virtualenv step. 08:32:43 INFO - ##### 08:32:43 INFO - Running pre-action listener: _resource_record_pre_action 08:32:43 INFO - Running main action method: create_virtualenv 08:32:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:43 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 08:32:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:43 INFO - Using real prefix '/tools/python27' 08:32:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:47 INFO - Installing pip.................done. 08:32:47 INFO - Return code: 0 08:32:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32:47 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')]} 08:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:47 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')]} 08:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:47 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 0x10f8bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9265c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, '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.INttTzbOGt/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.bDmIPepH3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:32:47 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 08:32:47 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 08:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:47 INFO - 'HOME': '/Users/cltbld', 08:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:47 INFO - 'LOGNAME': 'cltbld', 08:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:47 INFO - 'MOZ_NO_REMOTE': '1', 08:32:47 INFO - 'NO_EM_RESTART': '1', 08:32:47 INFO - 'PAGER': '/bin/cat', 08:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:47 INFO - 'PWD': '/builds/slave/test', 08:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:47 INFO - 'SHELL': '/bin/bash', 08:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:32:47 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:47 INFO - 'USER': 'cltbld', 08:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:47 INFO - 'XPC_FLAGS': '0x0', 08:32:47 INFO - 'XPC_SERVICE_NAME': '0', 08:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:47 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 08:32:47 INFO - Cleaning up... 08:32:47 INFO - Return code: 0 08:32:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:32:47 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')]} 08:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:47 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')]} 08:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:47 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 0x10f8bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9265c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, '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.INttTzbOGt/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.bDmIPepH3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:32:47 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 08:32:47 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 08:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:47 INFO - 'HOME': '/Users/cltbld', 08:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:47 INFO - 'LOGNAME': 'cltbld', 08:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:47 INFO - 'MOZ_NO_REMOTE': '1', 08:32:47 INFO - 'NO_EM_RESTART': '1', 08:32:47 INFO - 'PAGER': '/bin/cat', 08:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:47 INFO - 'PWD': '/builds/slave/test', 08:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:47 INFO - 'SHELL': '/bin/bash', 08:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:32:47 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:47 INFO - 'USER': 'cltbld', 08:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:47 INFO - 'XPC_FLAGS': '0x0', 08:32:47 INFO - 'XPC_SERVICE_NAME': '0', 08:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:48 INFO - Downloading/unpacking psutil>=0.7.1 08:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:51 INFO - Installing collected packages: psutil 08:32:51 INFO - Running setup.py install for psutil 08:32:51 INFO - building 'psutil._psutil_osx' extension 08:32:51 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 08:32:52 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 08:32:52 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 08:32:52 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 08:32:52 INFO - building 'psutil._psutil_posix' extension 08:32:52 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 08:32:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:32:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:32:52 INFO - ^ 08:32:52 INFO - 1 warning generated. 08:32:52 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 08:32:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:52 INFO - Successfully installed psutil 08:32:52 INFO - Cleaning up... 08:32:52 INFO - Return code: 0 08:32:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f8bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9265c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, '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.INttTzbOGt/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.bDmIPepH3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:52 INFO - 'HOME': '/Users/cltbld', 08:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:52 INFO - 'LOGNAME': 'cltbld', 08:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:52 INFO - 'MOZ_NO_REMOTE': '1', 08:32:52 INFO - 'NO_EM_RESTART': '1', 08:32:52 INFO - 'PAGER': '/bin/cat', 08:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:52 INFO - 'PWD': '/builds/slave/test', 08:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:52 INFO - 'SHELL': '/bin/bash', 08:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:32:52 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:52 INFO - 'USER': 'cltbld', 08:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:52 INFO - 'XPC_FLAGS': '0x0', 08:32:52 INFO - 'XPC_SERVICE_NAME': '0', 08:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:32:55 INFO - Installing collected packages: mozsystemmonitor 08:32:55 INFO - Running setup.py install for mozsystemmonitor 08:32:55 INFO - Successfully installed mozsystemmonitor 08:32:55 INFO - Cleaning up... 08:32:55 INFO - Return code: 0 08:32:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:55 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 0x10f8bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9265c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, '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.INttTzbOGt/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.bDmIPepH3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:32:55 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 08:32:55 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 08:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:55 INFO - 'HOME': '/Users/cltbld', 08:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:55 INFO - 'LOGNAME': 'cltbld', 08:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:55 INFO - 'MOZ_NO_REMOTE': '1', 08:32:55 INFO - 'NO_EM_RESTART': '1', 08:32:55 INFO - 'PAGER': '/bin/cat', 08:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:55 INFO - 'PWD': '/builds/slave/test', 08:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:55 INFO - 'SHELL': '/bin/bash', 08:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:32:55 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:55 INFO - 'USER': 'cltbld', 08:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:55 INFO - 'XPC_FLAGS': '0x0', 08:32:55 INFO - 'XPC_SERVICE_NAME': '0', 08:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:55 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:58 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:59 INFO - Downloading docopt-0.6.1.tar.gz 08:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:59 INFO - Running setup.py install for blobuploader 08:32:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:59 INFO - Running setup.py install for requests 08:33:00 INFO - Running setup.py install for docopt 08:33:00 INFO - Successfully installed blobuploader requests docopt 08:33:00 INFO - Cleaning up... 08:33:00 INFO - Return code: 0 08:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:00 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')]} 08:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:00 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')]} 08:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:00 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 0x10f8bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9265c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, '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.INttTzbOGt/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.bDmIPepH3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:33:00 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 08:33:00 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 08:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:00 INFO - 'HOME': '/Users/cltbld', 08:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:00 INFO - 'LOGNAME': 'cltbld', 08:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:00 INFO - 'MOZ_NO_REMOTE': '1', 08:33:00 INFO - 'NO_EM_RESTART': '1', 08:33:00 INFO - 'PAGER': '/bin/cat', 08:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:00 INFO - 'PWD': '/builds/slave/test', 08:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:00 INFO - 'SHELL': '/bin/bash', 08:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:33:00 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:00 INFO - 'USER': 'cltbld', 08:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:00 INFO - 'XPC_FLAGS': '0x0', 08:33:00 INFO - 'XPC_SERVICE_NAME': '0', 08:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:00 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-iYjKqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:00 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-_PhAQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:00 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-o9HDoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:00 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-chAJai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:01 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-qeoOc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:01 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-XTGJ_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:01 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-2nJ_XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:01 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-N379Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:01 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-adBTKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:01 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-ZVu1A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:01 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-4p8i3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:01 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-6edJne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:01 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-hzQR0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:02 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-gmhbwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:02 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-zgqQzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:02 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-n1IyTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:02 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-bWKwPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:02 INFO - Running setup.py install for manifestparser 08:33:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:33:02 INFO - Running setup.py install for mozcrash 08:33:02 INFO - Running setup.py install for mozdebug 08:33:02 INFO - Running setup.py install for mozdevice 08:33:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:33:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:33:03 INFO - Running setup.py install for mozfile 08:33:03 INFO - Running setup.py install for mozhttpd 08:33:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:33:03 INFO - Running setup.py install for mozinfo 08:33:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:33:03 INFO - Running setup.py install for mozInstall 08:33:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:33:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:33:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:33:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:33:03 INFO - Running setup.py install for mozleak 08:33:03 INFO - Running setup.py install for mozlog 08:33:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:03 INFO - Running setup.py install for moznetwork 08:33:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:04 INFO - Running setup.py install for mozprocess 08:33:04 INFO - Running setup.py install for mozprofile 08:33:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:04 INFO - Running setup.py install for mozrunner 08:33:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:04 INFO - Running setup.py install for mozscreenshot 08:33:04 INFO - Running setup.py install for moztest 08:33:04 INFO - Running setup.py install for mozversion 08:33:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:04 INFO - Cleaning up... 08:33:04 INFO - Return code: 0 08:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:05 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 0x10f8bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9265c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, '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.INttTzbOGt/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.bDmIPepH3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:33:05 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 08:33:05 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 08:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:05 INFO - 'HOME': '/Users/cltbld', 08:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:05 INFO - 'LOGNAME': 'cltbld', 08:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:05 INFO - 'MOZ_NO_REMOTE': '1', 08:33:05 INFO - 'NO_EM_RESTART': '1', 08:33:05 INFO - 'PAGER': '/bin/cat', 08:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:05 INFO - 'PWD': '/builds/slave/test', 08:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:05 INFO - 'SHELL': '/bin/bash', 08:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:33:05 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:05 INFO - 'USER': 'cltbld', 08:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:05 INFO - 'XPC_FLAGS': '0x0', 08:33:05 INFO - 'XPC_SERVICE_NAME': '0', 08:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:05 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-6Dvi51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:05 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)) 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:05 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-DpopG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:05 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-RRwdyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:05 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)) 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:05 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Otzxhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:05 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)) 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:05 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-lwjvzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:05 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)) 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:05 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-EbaROt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:05 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)) 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:05 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-SJxOPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-b9KvtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-8oSzpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-cozawb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-FUOivX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-CyxlsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-3UqbaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-HuQ6h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-yrtZi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-KiTUu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:06 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)) 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:06 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-UyUbDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:07 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)) 08:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:07 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)) 08:33:07 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)) 08:33:07 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)) 08:33:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33:09 INFO - Downloading blessings-1.6.tar.gz 08:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:09 INFO - Installing collected packages: blessings 08:33:09 INFO - Running setup.py install for blessings 08:33:09 INFO - Successfully installed blessings 08:33:09 INFO - Cleaning up... 08:33:09 INFO - Return code: 0 08:33:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:10 INFO - Reading from file tmpfile_stdout 08:33:10 INFO - Current package versions: 08:33:10 INFO - blessings == 1.6 08:33:10 INFO - blobuploader == 1.2.4 08:33:10 INFO - docopt == 0.6.1 08:33:10 INFO - manifestparser == 1.1 08:33:10 INFO - mozInstall == 1.12 08:33:10 INFO - mozcrash == 0.17 08:33:10 INFO - mozdebug == 0.1 08:33:10 INFO - mozdevice == 0.48 08:33:10 INFO - mozfile == 1.2 08:33:10 INFO - mozhttpd == 0.7 08:33:10 INFO - mozinfo == 0.9 08:33:10 INFO - mozleak == 0.1 08:33:10 INFO - mozlog == 3.1 08:33:10 INFO - moznetwork == 0.27 08:33:10 INFO - mozprocess == 0.22 08:33:10 INFO - mozprofile == 0.28 08:33:10 INFO - mozrunner == 6.11 08:33:10 INFO - mozscreenshot == 0.1 08:33:10 INFO - mozsystemmonitor == 0.0 08:33:10 INFO - moztest == 0.7 08:33:10 INFO - mozversion == 1.4 08:33:10 INFO - psutil == 3.1.1 08:33:10 INFO - requests == 1.2.3 08:33:10 INFO - wsgiref == 0.1.2 08:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:10 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 0x10f8bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9265c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, '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.INttTzbOGt/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.bDmIPepH3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:33:10 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 08:33:10 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 08:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:10 INFO - 'HOME': '/Users/cltbld', 08:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:10 INFO - 'LOGNAME': 'cltbld', 08:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:10 INFO - 'MOZ_NO_REMOTE': '1', 08:33:10 INFO - 'NO_EM_RESTART': '1', 08:33:10 INFO - 'PAGER': '/bin/cat', 08:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:10 INFO - 'PWD': '/builds/slave/test', 08:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:10 INFO - 'SHELL': '/bin/bash', 08:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:33:10 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:10 INFO - 'USER': 'cltbld', 08:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:10 INFO - 'XPC_FLAGS': '0x0', 08:33:10 INFO - 'XPC_SERVICE_NAME': '0', 08:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:10 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)) 08:33:10 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)) 08:33:10 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)) 08:33:10 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)) 08:33:10 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)) 08:33:10 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)) 08:33:10 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)) 08:33:10 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)) 08:33:10 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)) 08:33:10 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)) 08:33:10 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)) 08:33:10 INFO - Cleaning up... 08:33:10 INFO - Return code: 0 08:33:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9265c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, '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.INttTzbOGt/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.bDmIPepH3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:10 INFO - 'HOME': '/Users/cltbld', 08:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:10 INFO - 'LOGNAME': 'cltbld', 08:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:10 INFO - 'MOZ_NO_REMOTE': '1', 08:33:10 INFO - 'NO_EM_RESTART': '1', 08:33:10 INFO - 'PAGER': '/bin/cat', 08:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:10 INFO - 'PWD': '/builds/slave/test', 08:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:10 INFO - 'SHELL': '/bin/bash', 08:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:33:10 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:10 INFO - 'USER': 'cltbld', 08:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:10 INFO - 'XPC_FLAGS': '0x0', 08:33:10 INFO - 'XPC_SERVICE_NAME': '0', 08:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:10 INFO - Downloading/unpacking jsonschema 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:13 INFO - Downloading/unpacking functools32 (from jsonschema) 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:13 INFO - warning: no files found matching '*.txt' 08:33:13 INFO - no previously-included directories found matching 'build' 08:33:13 INFO - no previously-included directories found matching 'dist' 08:33:13 INFO - no previously-included directories found matching '.git*' 08:33:13 INFO - Installing collected packages: jsonschema, functools32 08:33:13 INFO - Running setup.py install for functools32 08:33:13 INFO - warning: no files found matching '*.txt' 08:33:13 INFO - no previously-included directories found matching 'build' 08:33:13 INFO - no previously-included directories found matching 'dist' 08:33:13 INFO - no previously-included directories found matching '.git*' 08:33:13 INFO - Successfully installed jsonschema functools32 08:33:13 INFO - Cleaning up... 08:33:13 INFO - Return code: 0 08:33:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:33:13 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')]} 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:13 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')]} 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:13 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 0x10f8bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae9265c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, '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.INttTzbOGt/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.bDmIPepH3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 08:33:13 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 08:33:13 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 08:33:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:33:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:13 INFO - 'HOME': '/Users/cltbld', 08:33:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:13 INFO - 'LOGNAME': 'cltbld', 08:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:13 INFO - 'MOZ_NO_REMOTE': '1', 08:33:13 INFO - 'NO_EM_RESTART': '1', 08:33:13 INFO - 'PAGER': '/bin/cat', 08:33:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:13 INFO - 'PWD': '/builds/slave/test', 08:33:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:13 INFO - 'SHELL': '/bin/bash', 08:33:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:33:13 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:33:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:13 INFO - 'USER': 'cltbld', 08:33:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:13 INFO - 'XPC_FLAGS': '0x0', 08:33:13 INFO - 'XPC_SERVICE_NAME': '0', 08:33:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:14 INFO - Downloading/unpacking flake8 08:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:33:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:33:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 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 08:33:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:33:17 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 08:33:17 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 08:33:17 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 08:33:17 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 08:33:17 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 08:33:17 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 08:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:17 INFO - no previously-included directories found matching 'docs/_build' 08:33:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:33:17 INFO - Running setup.py install for pep8 08:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:17 INFO - no previously-included directories found matching 'docs/_build' 08:33:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:33:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:33:17 INFO - Cleaning up... 08:33:18 INFO - Return code: 0 08:33:18 INFO - Running post-action listener: _resource_record_post_action 08:33:18 INFO - Running post-action listener: _start_resource_monitoring 08:33:18 INFO - Starting resource monitoring. 08:33:18 INFO - ##### 08:33:18 INFO - ##### Running install step. 08:33:18 INFO - ##### 08:33:18 INFO - Running pre-action listener: _resource_record_pre_action 08:33:18 INFO - Running main action method: install 08:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:18 INFO - Reading from file tmpfile_stdout 08:33:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:18 INFO - Reading from file tmpfile_stdout 08:33:18 INFO - Output received: 08:33:18 INFO - Usage: mozinstall [options] installer 08:33:18 INFO - Options: 08:33:18 INFO - -h, --help show this help message and exit 08:33:18 INFO - -d DEST, --destination=DEST 08:33:18 INFO - Directory to install application into. [default: 08:33:18 INFO - "/builds/slave/test"] 08:33:18 INFO - --app=APP Application being installed. [default: firefox] 08:33:18 INFO - mkdir: /builds/slave/test/build/application 08:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:33:50 INFO - Reading from file tmpfile_stdout 08:33:50 INFO - Output received: 08:33:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:33:50 INFO - Running post-action listener: _resource_record_post_action 08:33:50 INFO - ##### 08:33:50 INFO - ##### Running run-tests step. 08:33:50 INFO - ##### 08:33:50 INFO - Running pre-action listener: _resource_record_pre_action 08:33:50 INFO - Running main action method: run_tests 08:33:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:33:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:33:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:33:50 INFO - 2016-04-13 08:33:50.489 screenresolution[1654:7747] starting screenresolution argv=screenresolution get 08:33:50 INFO - 2016-04-13 08:33:50.492 screenresolution[1654:7747] Display 0: 1600x1200x32@60 08:33:50 INFO - 2016-04-13 08:33:50.498 screenresolution[1655:7749] starting screenresolution argv=screenresolution list 08:33:50 INFO - Available Modes on Display 0 08:33:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:33:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:33:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:33:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:33:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:33:50 INFO - Intel Iris: 08:33:50 INFO - Chipset Model: Intel Iris 08:33:50 INFO - Type: GPU 08:33:50 INFO - Bus: Built-In 08:33:50 INFO - VRAM (Dynamic, Max): 1536 MB 08:33:50 INFO - Vendor: Intel (0x8086) 08:33:50 INFO - Device ID: 0x0a2e 08:33:50 INFO - Revision ID: 0x0009 08:33:50 INFO - Displays: 08:33:50 INFO - Display: 08:33:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:33:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:33:50 INFO - Display Serial Number: 1600x1200 60 08:33:50 INFO - Main Display: Yes 08:33:50 INFO - Mirror: Off 08:33:50 INFO - Online: Yes 08:33:50 INFO - Rotation: Supported 08:33:50 INFO - Return code: 0 08:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:50 INFO - Python 2.7.3 08:33:50 INFO - Return code: 0 08:33:50 INFO - grabbing minidump binary from tooltool 08:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:50 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 0x10f762d30>, '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 0x10f5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f759b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:50 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 08:33:50 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 08:33:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:50 INFO - Return code: 0 08:33:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:33:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:33:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:33:52 INFO - Return code: 0 08:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:33:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.INttTzbOGt/Render', 08:33:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:52 INFO - 'HOME': '/Users/cltbld', 08:33:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:52 INFO - 'LOGNAME': 'cltbld', 08:33:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:52 INFO - 'MOZ_NO_REMOTE': '1', 08:33:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:52 INFO - 'NO_EM_RESTART': '1', 08:33:52 INFO - 'PAGER': '/bin/cat', 08:33:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:52 INFO - 'PWD': '/builds/slave/test', 08:33:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:52 INFO - 'SHELL': '/bin/bash', 08:33:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bDmIPepH3p/Listeners', 08:33:52 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 08:33:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:52 INFO - 'USER': 'cltbld', 08:33:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:52 INFO - 'XPC_FLAGS': '0x0', 08:33:52 INFO - 'XPC_SERVICE_NAME': '0', 08:33:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:33:52 INFO - mozversion application_buildid: 20160413072445 08:33:52 INFO - mozversion application_changeset: 08693317e6581716cc6a8c3d95ed7ff6e16d2886 08:33:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:33:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:52 INFO - mozversion application_name: Firefox 08:33:52 INFO - mozversion application_remotingname: firefox-dev 08:33:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:33:52 INFO - mozversion application_vendor: Mozilla 08:33:52 INFO - mozversion application_version: 47.0a2 08:33:52 INFO - mozversion platform_buildid: 20160413072445 08:33:52 INFO - mozversion platform_changeset: 08693317e6581716cc6a8c3d95ed7ff6e16d2886 08:33:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:33:52 INFO - mozversion platform_version: 47.0a2 08:33:52 INFO - using testdate: 1460561632 08:33:52 INFO - actual date: 1460561632 08:33:52 INFO - starting webserver on 'localhost:49270' 08:33:52 INFO - SUITE-START | Running 2 tests 08:33:52 INFO - TEST-START | dromaeo_css 08:33:52 INFO - operating with platform_type : mac_ 08:33:52 INFO - Initialising browser for dromaeo_css test... 08:33:52 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpNtxenM/profile http://localhost:49270/getInfo.html) 08:33:54 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 08:33:54 INFO - PROCESS | 1673 | colorDepth:24 08:33:54 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 08:33:54 INFO - PROCESS | 1673 | __metrics 08:33:54 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:33:54 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:55 INFO - TEST-INFO | 1673: exit 0 08:33:55 INFO - Browser initialized. 08:33:55 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:55 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpNtxenM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:07 INFO - PROCESS | 1676 | RSS: Main: 207253504 08:34:07 INFO - PROCESS | 1676 | 08:34:58 INFO - PROCESS | 1676 | 1460561698790 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] 08:37:09 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:37:10 INFO - PROCESS | 1676 | RSS: Main: 338198528 08:37:10 INFO - PROCESS | 1676 | 08:40:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:40:13 INFO - PROCESS | 1676 | RSS: Main: 344854528 08:40:13 INFO - PROCESS | 1676 | 08:43:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 08:43:16 INFO - PROCESS | 1676 | RSS: Main: 348807168 08:43:16 INFO - PROCESS | 1676 | 08:46:18 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 08:46:18 INFO - PROCESS | 1676 | RSS: Main: 306868224 08:46:18 INFO - PROCESS | 1676 | 08:49:21 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 08:49:22 INFO - PROCESS | 1676 | RSS: Main: 308318208 08:49:22 INFO - PROCESS | 1676 | 08:52:25 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 08:52:25 INFO - PROCESS | 1676 | RSS: Main: 351100928 08:52:25 INFO - PROCESS | 1676 | 08:52:25 INFO - PROCESS | 1676 | __start_tp_report 08:52:25 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 08:52:25 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 08:52:25 INFO - PROCESS | 1676 | |i|pagename|runs| 08:52:25 INFO - PROCESS | 1676 | |0;dojo.html;3364.966350336497;3461.723062155027;3464.44568868981;3499.457584074469;3538.9115272118192;5679.829605111853;5686.971565142178;5688.402717714637;5689.345725241593;5705.572082093839;5666.660000399968;5688.544916406688;5709.371969083408;5711.7715291388395;5716.28546431696;5142.7428628568605;5221.791128354871;5222.4255331913455;5300.257963885059;5303.178007408838;5246.658967167141;5249.868753281179;5286.889753151842;5292.894142117156;5292.973535132338;5196.272521846944;5235.267062611238;5239.502247286521;5259.894802103956;5263.499967503081;5200.453952335007;5202.3497062867145;5219.8434046978655;5226.111561034633;5272.393674727417;5030.773615187325;5191.506806853343;5220.060389129955;5240.213967904845;5257.631965762398;5658.0381335173115;5705.5435565154685;5713.3429655589725;5717.9714101429645;5719.48524632785;6091.939080609226;6276.811695649138;6304.306526282106;6315.147455093549;6326.08271800591;6167.013277875563;6235.438810507031;6258.092576576417;6289.7169627366875;6322.810315690491;5851.151583020438;5878.147668588031;5881.500072493843;5887.76448942046;5915.5859089863725;6145.8156255312415;6279.183706118267;6286.49708023357;6291.465225455888;6303.747850086037;6083.9391606084255;6155.84610384744;6184.165137706442;6193.876122477525;6197.597156184834;6273.96863015682;6275.717592708339;6279.277883043508;6284.717187726564;6287.151234583364;6124.326324104345;6186.721597528122;6203.47270482005;6229.626222426578;6244.562880598314;6094.360092190344;6149.2313460817395;6150.354212807681;6163.229596300463;6255.624662520263;4838.588719958843;4844.15227335215;4847.95152048482;4879.999600081975;4886.022795440855;4379.430674012422;4390.648748100144;4398.3842262083335;4417.889552761207;4437.711548749321;5624.015797235467;5648.406917273709;5673.290838645169;5708.9714551427805;5710.600257981901;6184.6598437086395;6230.813075607739;6271.62370257786;6282.528810339243;6286.4342209201395;4751.311059896296;5690.5163061140265;5691.544676425876;5727.0550359190265;5748.827535173951;5389.83830485086;5400.810971616053;5407.351117865881;5411.56707463402;5411.945880541223;6144.2488890665945;6242.469390101892;6291.402316779899;6313.179286692793;6318.368163183737;6190.102435146789;6253.749850005949;6262.060690896402;6277.027060805583;6281.905771413341;6282.3089460158435;6283.37166283368;6333.081703152925;6343.302236754045;6352.0789485525265;6110.7250173741395;6121.7578389577775;6186.628802271878;6229.190205273286;6267.310595834546;6223.657698826608;6231.158793562811;6240.719167637377;6252.437280644764;6273.121762953281;5848.576451312466;6003;6035.426634469718;6068.666223357758;6093.878122437615;5922.466977972003;5925.318588362394;6037.909431358621;6080.3919608040615;6092.75628974836;5929.881402372014;5943.138244954371;5951.791687290924;5964.731587078679;6023.909641355471;6064.727087281171;6144.539159562962;6144.648177400964;6149.7847575334645;6164.137020816999;5664;5831.096180092092;5944.4352786485215;6034.125051867542;6087.026075827846 08:52:25 INFO - PROCESS | 1676 | |1;ext.html;472.35287655911407;589.9174115623811;593.4451288045677;623.8378021714353;626.64281359625;30179.34013629252;31705.365892682134;31723.36553268936;31770.841145794297;31808;40547.98630034243;40895;40973.97565060875;40979.770606881844;41232.76301710946;9532.380395274286;9766.9511652442;9770.560324785401;9770.560324785401;9776.657816976407;9632.855507167398;9771.316007879415;9773.12041916231;9779.853302200472;9782.364146330467;9723.416595004323;9806.019398060173;9806.803863922718;9811.460369679664;9818.803623927517;9694.612215511372;9774.657886973993;9790.412575245507;9792.363496372713;9798.6080556778;9565.713028609152;9686.951565242129;9795.06946840049;9799.804003919953;9818.852717209247;41189.79405102955;41483.58516414827;41492.96267593304;41548.753537393924;41570;3092.458819706565;3229.434848901433;3403.0981789825714;3505.9657401066747;3653.8355773990234;25500;25925.351866203495;26010.609840852212;26242;26344.60483092755;2766.5573508238786;2807.705190954941;2818.1122946271857;2825.1948194764395;2847.2312475631466;418028;418321;418518;418580.999999997;419128;58172.4182758167;65709;65891.67054164794;67093;67198.32801671921;71098;76234;77201.61399192968;77222;77265.61367193128;17718.02550859715;17918.193681284374;17959.910200449176;17963;17980.1009949502;13558.254296013814;13641;13648.590542283748;13657.931710341385;13667.521636742666;18924.33764818225;22118.447038823837;22389.216377427038;22468.550628987654;22472.32583022512;8709;8877.911220887838;8899.599518021705;8913.331500137387;9014.278857691368;954.9713508594754;1021.0453226233495;1062.7715041266165;1069.9572017119383;1086.5979587552497;30245;30555.388892222476;30816.84591577028;31551.89568365096;32485.675143248736;928.5264515097214;1119.658504156224;1129.085440792944;1137.9487923043482;1187.2401662935729;14214.928925355514;16493.752593711102;16568.92302000366;16579.336826527044;16848.32606695743;669279;677406;679499;681367;682732.5863370651;62998;63569;63603;63611.36388636147;63744.68127659332;1405.9086159399606;1523.3449616664718;1540.0143907898953;1558.0885182168558;1565.997761432684;29067.7093229065;29626.851865740533;29716.85141574278;29761.5535766968;30289.93985210507;49808.25287620616;50131.74934125306;50742.23886641629;50801.23798143105;50870.745646271534;411046;412722;413053;413404;414749;29488.705112948595;48023.03953920972;48592.75703621459;48969.75515122402;50352.74823626005;46592;47664.2850357238;49024.50975490199;49226.50773492219;50602.746986264836;38934.026649333995;39237;40372.3944140844;40609.984750381474;40615.455253229564;39352.606473934895;39613.60386396215;39851.2029759409;40138.598614013485;40508;39478.60521394864;39961.60038399695;40260.19479610333;41304;41310.38034429426;34468.65531344755;34982.47526287159;35558.644413555536;35812.641873581975;35854;26479;26571.804268807562;26599;26694;27065.72934270632 08:52:25 INFO - PROCESS | 1676 | |2;jquery.html;326.27725608785613;368.169777152521;372.4692313453329;378.45502476433916;378.87686501886895;14928.328225229863;20306.492337691565;20312.492187695298;20811.959402029912;20838.583228335425;10290.794184116314;19547.315843945464;20803.959802009915;20839;20853.374398768025;5264.210368444745;5381.48875856793;5421.457854214566;5422.2951016368015;5424.674519528821;4095.6313931746135;4293.141371725652;5364.463553644624;7372.483926125174;7693.9615301923695;7326.377257933082;7639.7326093586735;7643.388528917673;7644.6559904804135;7645.273698998586;6557.77047803327;7580.810479737996;7592.544447333123;7601.277878601524;7603.809904752397;4044.7573145611063;6952.478564107661;7265.128184617827;7270.854582908365;7280.4903656744045;27287.45425091507;27371.315717107034;27584.724152758616;29028.854855725796;29043.98346057878;2310.838241323108;2321.3732292281156;2324.3491822289784;2464;2487.4154573675173;14790.321941947559;15825.683486330325;16233.756493652605;16314;16580.50258492235;1559.5867095219776;1803.0443864751703;1837.6232872261155;1863.9720404193947;2022.5449273913398;92936.67658308528;110756.9999999992;119061.80938190594;120482.7951720489;120746;19062.523436914187;19486.610267794564;19519.316823911096;19637.80362196388;19666.508337291398;30146;30166.84916575447;30755.538666920012;30787.69212307893;30908.53637195444;10759.946200268949;11175.497102630401;11207.943960280147;11236.775264494665;11306.982371586597;8234.588270586566;9009.279257659371;9407.764805879771;9415.681804547232;9489.620415183454;8666.86999695005;8732.563371831384;8808.295336373074;8811.339149563808;8814.911850881537;2873.5976963225166;2921.7078292170613;3384.2047118927035;3390.2202493426157;3400.897973060812;929.5491686532026;929.6188562689265;990.7572644702094;1026.2405819693374;1029.6344797596746;19633.607327853362;19716.60566788656;19735.802641973398;20158.39524814258;20291.797082028992;975.7170420577953;979.6718099436769;990.4107056301489;1044.0916402729674;1045.482486169351;7945.364370850318;10970.506327215135;11038;11277.774444511064;11310.547578096784;625866;636008;637097;638553;644022;107126;111087.44456277828;111901;113578;114036.42981785204;1008.82345589523;1017.104947646052;1019.8623185869961;1021.4688362051692;1024.2011231239644;17955.371561995267;18104.547386315448;18190.272389104288;18581.44255672332;18888.905555472684;49340;49740.507784766516;50097.499025010744;50804;51649.741751291;54928.72535637296;68207.31792682009;70142.64928675324;70617.64691176511;71668;8225.682286622416;8258.091609923023;8281.17188281167;8409.95795021021;8609.354298427768;9512.476813775309;12812.55156069533;13196.868031319564;13520.86479135196;13635.977301702611;10528.684139475828;10913.126949844152;11516.884831151916;11717.238379505305;11834.940825295818;10943.233973621771;11024.779504409706;11240.494177762184;11546.76906461883;11679.299242045505;11605.419729013684;11653.6503904883;11719.238249513754;11866.940665296619;12013.81979270329;8258.25675689191;8292.917070829455;8297.543635099886;8362.832743345221;8388.951381077366;8711.303095752199;11529.654110376701;11785.587504437304;11845.23006004607;12022.819657705317 08:52:25 INFO - PROCESS | 1676 | |3;mootools.html;1411.3084588551612;1588.7458006718925;1617.3853935504503;1921.3275353626225;2050.179928028789;8203.26170644642;8732.039475657673;8888.600012999406;8893.510856902867;8894.110588941103;7079.964600177005;9011.053839346856;9026.954865225665;9033.232175265093;9038.231750301216;2244.2930476899805;2481.6153496208117;2534.4170840706647;2550.2986678663424;2567.4351642638685;2387.7254115776645;2392.851431312971;2570.0876188952934;2572.4855028994275;2576.716561178269;2277.851939623919;2375.869327187004;2543.0972004938167;2544.6183072539084;2553.0553695132826;2476.2818782553036;2506.724260331362;2543.4785868896834;2544.478381931718;2549.3754030262703;2508.14722994181;2525.772680458749;2553.1319351420607;2569.678790151231;2569.845809251451;9086.68196613122;9159.542022898828;9184.44893306397;9188.310876684276;9209.677661281823;5558.610897237195;5777.306723193244;5781.277340332458;5802.506786923117;5815.912761308584;3405.3700065487965;3513.2095278562374;3541.2563361694074;3618.330608837347;3703.5926048134684;1037.9273450858443;1061.3578784835217;1064.1965316186229;1072.6567498400516;1105.4196546812907;12073;12093.818592721116;12102.81845772314;12108.878911210862;12117.818232726517;4852.199387101089;4935.432425271068;4981.352424184905;5015.824446144367;5015.899682006339;10349.327293725884;10353.792924141626;10364.326318789255;10370.948145259375;10396.324238924446;5671.546276297886;5671.914921276184;5674.687892165971;5677.659340439587;5685.715714214272;4527.683062185615;4643.976780116078;4656.348111264426;4700.506446823103;4911.901761964812;3631.5279013728045;3810.9047273817823;3877.534695836461;3985.740926839746;4005.1388951375593;1114.2478826791883;1325.9071864969553;1329.8005299205197;1341.2958196946486;1343.7917122845975;1381.3783797291057;1383.4673650644575;1407.1416435974047;1439.6976634906787;1442.5383877159418;8407.201315874981;8588.141185881363;8589.570521473901;8598.699045533376;8609.870851937227;1082.8105081610686;1238.325112813519;1239.6528971887706;1253.7555176740448;1271.1800888426912;6343.55595108338;6351.904721429182;6417.229932408048;6427.164468619143;6431.389018043278;10445.059944605022;10811.78376432467;10928;10957.342559446459;11099.278546894426;10552;10855.294405863593;10892.945535272273;10970.945145274382;10971.122310215163;8427.157284271523;8509.234168924702;8565.314774818;8579.742607721902;8599.183077607617;8077.515349079074;8139.1453897339925;8161.632726527202;8253.587320633824;8292.33661307082;9280.443173409618;9600.423974561549;9603.087706667855;9729;9863.901360986298;9711.56297966579;9850.359726617748;10011.998800120222;10024.599016039569;10025.248106392195;7447.776566703008;7528.322450979438;7600.961995189989;7652.387808975157;7654.387648988179;8416.87374689368;8462.576871156294;8498;8510.914890851012;8517.659293628434;7432.628368581657;7503.137139229058;7592.506487078323;7639.541627502367;7697.0378702662165;7369.926300736924;7383.8154046149275;7434.256574342522;7475.476716629783;7536.547807131589;7963.522188668699;8023.879641805494;8024.197580241929;8025.197480252162;8059.717909873127;6972.616506092011;7143.9285607143265;7152.070230869954;7198.2801719829695;7256.7460138894885;7259.963700181676;7262.164851041986;7297.708091676486;7312.890306645511;7316.817079573053 08:52:25 INFO - PROCESS | 1676 | |4;prototype.html;332.3585480023554;336.85515228451754;338.5243732555757;342.2436415521697;342.8165931226794;6459.257185423678;6471.352864713526;6486.254080780712;6497.480201583874;6501.959686450169;6119.449249567538;6399.616023038621;6478;6486.448651864597;6492.480601551876;4664.416947881515;4730.408698912636;4799.976000120012;4850.9029819403595;4887.486813884544;4850.805967761303;4883.12103821312;4886.462489126193;4892.189889740801;4895.730734809584;4819.2530157825595;4825.662203645747;4828.396450443694;4836.887515871352;4874.220124780036;4571.497135315112;4623.144718227139;4763.404574428197;4778.020505796303;4778.4265888093305;4096.549379568245;4103.261412945669;4114.362273847529;4118.217538667644;4118.320477121271;6122.693865306717;6150.538709596798;6179.258488981351;6182.289036760785;6184.07238914162;5613.550915926716;5614.522765564931;5633.492985631272;5639.436056394369;5646.068398714207;6859.451243900476;6862.313768623148;6863.725450981955;6871;6872.62200578968;4325.913481730379;4511.436070491189;4528.8867778305475;4529.750863702495;4554.225781617133;7124.394426473756;7284.125904891394;7291.598962057138;7295.197528271886;7298.81752956175;4589.242774942164;4599.770011499411;4606.055758569485;4606.470255920545;4617.746023968714;4644.117617652635;4660.487346391894;4660.930086048712;4661.417322834645;4670.392848929618;5489.64317319373;5501.0098182326765;5504.614676972574;5507.228987941691;5512.118061110203;6643;6899.379055884994;6920.653967301615;6927.965360173268;6936.514443988974;1346.219192868134;1606.3333716507752;1622.9431969880998;1623.5859855736712;1625.8455446732542;971.9757006074764;994.8159590475785;1027.712240572641;1028.2339656955617;1053.5891002509027;6413.29453760086;6510.609363438209;6518.315576864456;6522.119513865662;6538;7265;7266.564006159648;7269.709211631475;7270.982062511147;7271.600061996641;6494;6513.218413790375;6513.2509761377105;6515.51133664977;6530;3757.079515518715;3791.2227993261317;3795.6204379562373;3800.600936901641;3801.1447424329303;7237.782866514013;7486.887696684554;7584.393248540214;7620.923790762022;7656.61716914152;6064.4238797315065;7424.888626670604;7472.775816725398;7472.813179670552;7518.173000969889;7561.432892532972;7576.469647124759;7586.468947173756;7586.772396828104;7597.240275972469;6918.688659010256;7223.1693355264815;7242.275772422716;7247.9637601811655;7259.12890453149;7012.824679383056;7089.751858684921;7112.324329188718;7145.285471452813;7146.821329466805;7594.126675432175;7596.8480630388185;7610.238976102345;7619.361837205028;7624.741917583537;4732.077244937204;4787.688800227974;4798.328234047306;4803.855884323476;4804.903901921872;6058;6557.9179435394535;6873.553219040747;7097.503174777716;7117.750878719427;6857.142857142857;6859.9314006859295;6869.278725733726;6872.484563657646;6875.724971001304;6801.863962720817;6841.521093523605;6844.863102737818;6846.623435711083;6863.622500762506;6696.330366963265;6696.933030669631;6702.329767023259;6708.094407254958;6716.29478904708;6598.680263947325;6821.045053692388;6852.965735171292;6867.828304292432;6884.793456196322;5545.334559852843;6307.180066591313;6402.551821372459;6581.572197807127;6727.192736871607 08:52:25 INFO - PROCESS | 1676 | |5;yui.html;752.7327798631486;759.4493991855906;771.44455991686;778.3267473635307;788.1212448120344;14812.629684257885;15118.546443606681;15142.16718080505;15147.697046059073;17495.300187992496;16391.34434622614;16447.58881027975;16450.42423515177;16451.670966580663;16489.34042638293;805.4442434720054;813.6216659253446;985.8866230383491;989.193807047256;1004.8191325561396;998.9960090109466;999.7950420163885;1001.1640280365867;1003.1773945364804;1004.3823048824956;1053.2364036073861;1054.1882750282277;1055.3456856748826;1056.7463808685936;1058.8570542976677;820.5692011693849;825.5005721538473;1012.8227560177013;1030.721705139608;1048.6067724603274;776.2664282253273;776.5340795522698;778.1906816910406;779.1001393390643;779.4933293359362;15584.142872142027;15602.843971560253;15604.063756174552;15629.765553516707;15631.374745010186;12455.314957677325;12500.24998500093;12657.367131643474;12827.615171544869;12890.742185156338;10345.689629311133;10413.739656508647;10665.733356666145;10669.466526673712;10988.670339889735;3512.7892326460496;3518.929621407583;3565.2512972275854;3614.8554057837655;3794.7533410328515;84149;84373.57813210956;84673.15326846714;85114.57442712809;85617;9681.225501959827;9780.755481113029;9790;9792.069753373418;9813.607455701693;21114;21209.36371908845;21230.150793968376;21230.575388492143;21256.681149782766;7432.814179645444;7549.396048316232;7586.734464293723;7678.923210767933;7716.884246736304;4024.6176613221696;4060.451839001697;4078.898027549335;4142.937855932163;4293.549177336335;3711.2391959648207;3748.55017397914;3752.7373083883867;3757.0982964088967;3757.4551690004796;647.1716203259834;655.5771527364823;661.5435349608755;664.9991762397657;673.175360183771;567.324883388766;590.4508806809622;602.2682440834408;609.4058293164129;622.4553515673786;8130.227628375294;8567.314614830799;8608.268297194809;8627.170926691804;8631.6978905738;567.7473524281655;588.153059594183;613.7514306705791;629.1317981185935;638.6232123047424;3837.57786643469;3896.5129358830145;3970.920581588352;4023.839046438168;4052.3111071117983;94725;95096.57355139678;96217.518912405;98490.01509984952;99206;80936;81079.59460202661;81685.59157204175;82574;82747;73242.53514929672;73299.43451979155;74347;74526.62736686281;74688;7236.34872861445;8342.87485687703;8587.785305367166;8773.912260877309;8871;48872.75563622159;48955.510444895095;49078.75460622674;49662.75168624134;49981.75009124931;66275.00587491094;69022.61954760978;69830.65084674544;70797.29202708113;70837;9216.815663686823;11059.447027648746;11225.158113141384;11360.772784544428;11543.307401555934;11956;12162.452689629165;12186.756264874475;12239.938800306298;12515.624531264077;11436.82844757346;11678.591249306233;11848.052155827685;12061.638150855488;12098.334591597546;10371;10792.838107428237;11712.063034957013;11734.765304693688;11929.701757455787;8384.99380074395;10831.783364332512;11191.216614837209;11433.59982400612;11926.821097683369;9871;9910.702678919644;9952.2535809816;10007.049330313608;10169.84745228837;9808;9895.65365212243;9936;10002.899971000488;10007.899921000697 08:52:25 INFO - PROCESS | 1676 | __end_tp_report 08:52:25 INFO - PROCESS | 1676 | __start_cc_report 08:52:25 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1122 08:52:25 INFO - PROCESS | 1676 | __end_cc_report 08:52:25 INFO - PROCESS | 1676 | __startTimestamp1460562745325__endTimestamp 08:52:25 INFO - PROCESS | 1676 | 08:52:25 INFO - PROCESS | 1676 | ------- Summary: start ------- 08:52:25 INFO - PROCESS | 1676 | Number of tests: 6 08:52:25 INFO - PROCESS | 1676 | 08:52:25 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5745.19 Median:5944.44 stddev:631.50 (10.6%) stddev-sans-first:605.20 08:52:25 INFO - PROCESS | 1676 | Values: 3365.0 3461.7 3464.4 3499.5 3538.9 5679.8 5687.0 5688.4 5689.3 5705.6 5666.7 5688.5 5709.4 5711.8 5716.3 5142.7 5221.8 5222.4 5300.3 5303.2 5246.7 5249.9 5286.9 5292.9 5293.0 5196.3 5235.3 5239.5 5259.9 5263.5 5200.5 5202.3 5219.8 5226.1 5272.4 5030.8 5191.5 5220.1 5240.2 5257.6 5658.0 5705.5 5713.3 5718.0 5719.5 6091.9 6276.8 6304.3 6315.1 6326.1 6167.0 6235.4 6258.1 6289.7 6322.8 5851.2 5878.1 5881.5 5887.8 5915.6 6145.8 6279.2 6286.5 6291.5 6303.7 6083.9 6155.8 6184.2 6193.9 6197.6 6274.0 6275.7 6279.3 6284.7 6287.2 6124.3 6186.7 6203.5 6229.6 6244.6 6094.4 6149.2 6150.4 6163.2 6255.6 4838.6 4844.2 4848.0 4880.0 4886.0 4379.4 4390.6 4398.4 4417.9 4437.7 5624.0 5648.4 5673.3 5709.0 5710.6 6184.7 6230.8 6271.6 6282.5 6286.4 4751.3 5690.5 5691.5 5727.1 5748.8 5389.8 5400.8 5407.4 5411.6 5411.9 6144.2 6242.5 6291.4 6313.2 6318.4 6190.1 6253.7 6262.1 6277.0 6281.9 6282.3 6283.4 6333.1 6343.3 6352.1 6110.7 6121.8 6186.6 6229.2 6267.3 6223.7 6231.2 6240.7 6252.4 6273.1 5848.6 6003.0 6035.4 6068.7 6093.9 5922.5 5925.3 6037.9 6080.4 6092.8 5929.9 5943.1 5951.8 5964.7 6023.9 6064.7 6144.5 6144.6 6149.8 6164.1 5664.0 5831.1 5944.4 6034.1 6087.0 08:52:25 INFO - PROCESS | 1676 | 08:52:25 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:66063.35 Median:226012.89 stddev:138316.70 (61.2%) stddev-sans-first:138617.05 08:52:25 INFO - PROCESS | 1676 | Values: 472.4 589.9 593.4 623.8 626.6 30179.3 31705.4 31723.4 31770.8 31808.0 40548.0 40895.0 40974.0 40979.8 41232.8 9532.4 9767.0 9770.6 9770.6 9776.7 9632.9 9771.3 9773.1 9779.9 9782.4 9723.4 9806.0 9806.8 9811.5 9818.8 9694.6 9774.7 9790.4 9792.4 9798.6 9565.7 9687.0 9795.1 9799.8 9818.9 41189.8 41483.6 41493.0 41548.8 41570.0 3092.5 3229.4 3403.1 3506.0 3653.8 25500.0 25925.4 26010.6 26242.0 26344.6 2766.6 2807.7 2818.1 2825.2 2847.2 418028.0 418321.0 418518.0 418581.0 419128.0 58172.4 65709.0 65891.7 67093.0 67198.3 71098.0 76234.0 77201.6 77222.0 77265.6 17718.0 17918.2 17959.9 17963.0 17980.1 13558.3 13641.0 13648.6 13657.9 13667.5 18924.3 22118.4 22389.2 22468.6 22472.3 8709.0 8877.9 8899.6 8913.3 9014.3 955.0 1021.0 1062.8 1070.0 1086.6 30245.0 30555.4 30816.8 31551.9 32485.7 928.5 1119.7 1129.1 1137.9 1187.2 14214.9 16493.8 16568.9 16579.3 16848.3 669279.0 677406.0 679499.0 681367.0 682732.6 62998.0 63569.0 63603.0 63611.4 63744.7 1405.9 1523.3 1540.0 1558.1 1566.0 29067.7 29626.9 29716.9 29761.6 30289.9 49808.3 50131.7 50742.2 50801.2 50870.7 411046.0 412722.0 413053.0 413404.0 414749.0 29488.7 48023.0 48592.8 48969.8 50352.7 46592.0 47664.3 49024.5 49226.5 50602.7 38934.0 39237.0 40372.4 40610.0 40615.5 39352.6 39613.6 39851.2 40138.6 40508.0 39478.6 39961.6 40260.2 41304.0 41310.4 34468.7 34982.5 35558.6 35812.6 35854.0 26479.0 26571.8 26599.0 26694.0 27065.7 08:52:25 INFO - PROCESS | 1676 | 08:52:25 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:36277.95 Median:27329.38 stddev:105066.31 (384.4%) stddev-sans-first:105326.37 08:52:25 INFO - PROCESS | 1676 | Values: 326.3 368.2 372.5 378.5 378.9 14928.3 20306.5 20312.5 20812.0 20838.6 10290.8 19547.3 20804.0 20839.0 20853.4 5264.2 5381.5 5421.5 5422.3 5424.7 4095.6 4293.1 5364.5 7372.5 7694.0 7326.4 7639.7 7643.4 7644.7 7645.3 6557.8 7580.8 7592.5 7601.3 7603.8 4044.8 6952.5 7265.1 7270.9 7280.5 27287.5 27371.3 27584.7 29028.9 29044.0 2310.8 2321.4 2324.3 2464.0 2487.4 14790.3 15825.7 16233.8 16314.0 16580.5 1559.6 1803.0 1837.6 1864.0 2022.5 92936.7 110757.0 119061.8 120482.8 120746.0 19062.5 19486.6 19519.3 19637.8 19666.5 30146.0 30166.8 30755.5 30787.7 30908.5 10759.9 11175.5 11207.9 11236.8 11307.0 8234.6 9009.3 9407.8 9415.7 9489.6 8666.9 8732.6 8808.3 8811.3 8814.9 2873.6 2921.7 3384.2 3390.2 3400.9 929.5 929.6 990.8 1026.2 1029.6 19633.6 19716.6 19735.8 20158.4 20291.8 975.7 979.7 990.4 1044.1 1045.5 7945.4 10970.5 11038.0 11277.8 11310.5 625866.0 636008.0 637097.0 638553.0 644022.0 107126.0 111087.4 111901.0 113578.0 114036.4 1008.8 1017.1 1019.9 1021.5 1024.2 17955.4 18104.5 18190.3 18581.4 18888.9 49340.0 49740.5 50097.5 50804.0 51649.7 54928.7 68207.3 70142.6 70617.6 71668.0 8225.7 8258.1 8281.2 8410.0 8609.4 9512.5 12812.6 13196.9 13520.9 13636.0 10528.7 10913.1 11516.9 11717.2 11834.9 10943.2 11024.8 11240.5 11546.8 11679.3 11605.4 11653.7 11719.2 11866.9 12013.8 8258.3 8292.9 8297.5 8362.8 8389.0 8711.3 11529.7 11785.6 11845.2 12022.8 08:52:25 INFO - PROCESS | 1676 | 08:52:25 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:6197.97 Median:4998.59 stddev:3246.90 (65.0%) stddev-sans-first:3236.07 08:52:25 INFO - PROCESS | 1676 | Values: 1411.3 1588.7 1617.4 1921.3 2050.2 8203.3 8732.0 8888.6 8893.5 8894.1 7080.0 9011.1 9027.0 9033.2 9038.2 2244.3 2481.6 2534.4 2550.3 2567.4 2387.7 2392.9 2570.1 2572.5 2576.7 2277.9 2375.9 2543.1 2544.6 2553.1 2476.3 2506.7 2543.5 2544.5 2549.4 2508.1 2525.8 2553.1 2569.7 2569.8 9086.7 9159.5 9184.4 9188.3 9209.7 5558.6 5777.3 5781.3 5802.5 5815.9 3405.4 3513.2 3541.3 3618.3 3703.6 1037.9 1061.4 1064.2 1072.7 1105.4 12073.0 12093.8 12102.8 12108.9 12117.8 4852.2 4935.4 4981.4 5015.8 5015.9 10349.3 10353.8 10364.3 10370.9 10396.3 5671.5 5671.9 5674.7 5677.7 5685.7 4527.7 4644.0 4656.3 4700.5 4911.9 3631.5 3810.9 3877.5 3985.7 4005.1 1114.2 1325.9 1329.8 1341.3 1343.8 1381.4 1383.5 1407.1 1439.7 1442.5 8407.2 8588.1 8589.6 8598.7 8609.9 1082.8 1238.3 1239.7 1253.8 1271.2 6343.6 6351.9 6417.2 6427.2 6431.4 10445.1 10811.8 10928.0 10957.3 11099.3 10552.0 10855.3 10892.9 10970.9 10971.1 8427.2 8509.2 8565.3 8579.7 8599.2 8077.5 8139.1 8161.6 8253.6 8292.3 9280.4 9600.4 9603.1 9729.0 9863.9 9711.6 9850.4 10012.0 10024.6 10025.2 7447.8 7528.3 7601.0 7652.4 7654.4 8416.9 8462.6 8498.0 8510.9 8517.7 7432.6 7503.1 7592.5 7639.5 7697.0 7369.9 7383.8 7434.3 7475.5 7536.5 7963.5 8023.9 8024.2 8025.2 8059.7 6972.6 7143.9 7152.1 7198.3 7256.7 7260.0 7262.2 7297.7 7312.9 7316.8 08:52:25 INFO - PROCESS | 1676 | 08:52:25 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5679.44 Median:6489.46 stddev:1800.29 (27.7%) stddev-sans-first:1760.04 08:52:25 INFO - PROCESS | 1676 | Values: 332.4 336.9 338.5 342.2 342.8 6459.3 6471.4 6486.3 6497.5 6502.0 6119.4 6399.6 6478.0 6486.4 6492.5 4664.4 4730.4 4800.0 4850.9 4887.5 4850.8 4883.1 4886.5 4892.2 4895.7 4819.3 4825.7 4828.4 4836.9 4874.2 4571.5 4623.1 4763.4 4778.0 4778.4 4096.5 4103.3 4114.4 4118.2 4118.3 6122.7 6150.5 6179.3 6182.3 6184.1 5613.6 5614.5 5633.5 5639.4 5646.1 6859.5 6862.3 6863.7 6871.0 6872.6 4325.9 4511.4 4528.9 4529.8 4554.2 7124.4 7284.1 7291.6 7295.2 7298.8 4589.2 4599.8 4606.1 4606.5 4617.7 4644.1 4660.5 4660.9 4661.4 4670.4 5489.6 5501.0 5504.6 5507.2 5512.1 6643.0 6899.4 6920.7 6928.0 6936.5 1346.2 1606.3 1622.9 1623.6 1625.8 972.0 994.8 1027.7 1028.2 1053.6 6413.3 6510.6 6518.3 6522.1 6538.0 7265.0 7266.6 7269.7 7271.0 7271.6 6494.0 6513.2 6513.3 6515.5 6530.0 3757.1 3791.2 3795.6 3800.6 3801.1 7237.8 7486.9 7584.4 7620.9 7656.6 6064.4 7424.9 7472.8 7472.8 7518.2 7561.4 7576.5 7586.5 7586.8 7597.2 6918.7 7223.2 7242.3 7248.0 7259.1 7012.8 7089.8 7112.3 7145.3 7146.8 7594.1 7596.8 7610.2 7619.4 7624.7 4732.1 4787.7 4798.3 4803.9 4804.9 6058.0 6557.9 6873.6 7097.5 7117.8 6857.1 6859.9 6869.3 6872.5 6875.7 6801.9 6841.5 6844.9 6846.6 6863.6 6696.3 6696.9 6702.3 6708.1 6716.3 6598.7 6821.0 6853.0 6867.8 6884.8 5545.3 6307.2 6402.6 6581.6 6727.2 08:52:25 INFO - PROCESS | 1676 | 08:52:25 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:18944.58 Median:49017.13 stddev:26814.83 (54.7%) stddev-sans-first:26855.26 08:52:25 INFO - PROCESS | 1676 | Values: 752.7 759.4 771.4 778.3 788.1 14812.6 15118.5 15142.2 15147.7 17495.3 16391.3 16447.6 16450.4 16451.7 16489.3 805.4 813.6 985.9 989.2 1004.8 999.0 999.8 1001.2 1003.2 1004.4 1053.2 1054.2 1055.3 1056.7 1058.9 820.6 825.5 1012.8 1030.7 1048.6 776.3 776.5 778.2 779.1 779.5 15584.1 15602.8 15604.1 15629.8 15631.4 12455.3 12500.2 12657.4 12827.6 12890.7 10345.7 10413.7 10665.7 10669.5 10988.7 3512.8 3518.9 3565.3 3614.9 3794.8 84149.0 84373.6 84673.2 85114.6 85617.0 9681.2 9780.8 9790.0 9792.1 9813.6 21114.0 21209.4 21230.2 21230.6 21256.7 7432.8 7549.4 7586.7 7678.9 7716.9 4024.6 4060.5 4078.9 4142.9 4293.5 3711.2 3748.6 3752.7 3757.1 3757.5 647.2 655.6 661.5 665.0 673.2 567.3 590.5 602.3 609.4 622.5 8130.2 8567.3 8608.3 8627.2 8631.7 567.7 588.2 613.8 629.1 638.6 3837.6 3896.5 3970.9 4023.8 4052.3 94725.0 95096.6 96217.5 98490.0 99206.0 80936.0 81079.6 81685.6 82574.0 82747.0 73242.5 73299.4 74347.0 74526.6 74688.0 7236.3 8342.9 8587.8 8773.9 8871.0 48872.8 48955.5 49078.8 49662.8 49981.8 66275.0 69022.6 69830.7 70797.3 70837.0 9216.8 11059.4 11225.2 11360.8 11543.3 11956.0 12162.5 12186.8 12239.9 12515.6 11436.8 11678.6 11848.1 12061.6 12098.3 10371.0 10792.8 11712.1 11734.8 11929.7 8385.0 10831.8 11191.2 11433.6 11926.8 9871.0 9910.7 9952.3 10007.0 10169.8 9808.0 9895.7 9936.0 10002.9 10007.9 08:52:25 INFO - PROCESS | 1676 | -------- Summary: end -------- 08:52:25 INFO - PROCESS | 1676 | 08:52:25 INFO - TEST-INFO | 1676: exit 0 08:52:25 INFO - TEST-OK | dromaeo_css | took 1113588ms 08:52:25 INFO - TEST-START | kraken 08:52:25 INFO - operating with platform_type : mac_ 08:52:25 INFO - Initialising browser for kraken test... 08:52:25 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmprDK1zh/profile http://localhost:49270/getInfo.html) 08:52:27 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 08:52:27 INFO - PROCESS | 1681 | colorDepth:24 08:52:27 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 08:52:27 INFO - PROCESS | 1681 | __metrics 08:52:28 INFO - PROCESS | 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:52:28 INFO - PROCESS | 1681 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:28 INFO - TEST-INFO | 1681: exit 0 08:52:28 INFO - Browser initialized. 08:52:28 INFO - Running cycle 1/1 for kraken test... 08:52:28 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmprDK1zh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:40 INFO - PROCESS | 1683 | RSS: Main: 207712256 08:52:40 INFO - PROCESS | 1683 | 08:52:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:43 INFO - PROCESS | 1683 | RSS: Main: 262160384 08:52:43 INFO - PROCESS | 1683 | 08:52:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 08:52:46 INFO - PROCESS | 1683 | RSS: Main: 272433152 08:52:46 INFO - PROCESS | 1683 | 08:52:50 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 08:52:50 INFO - PROCESS | 1683 | RSS: Main: 262852608 08:52:50 INFO - PROCESS | 1683 | 08:52:52 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 08:52:53 INFO - PROCESS | 1683 | RSS: Main: 265056256 08:52:53 INFO - PROCESS | 1683 | 08:52:55 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:55 INFO - PROCESS | 1683 | RSS: Main: 265281536 08:52:55 INFO - PROCESS | 1683 | 08:52:58 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:59 INFO - PROCESS | 1683 | RSS: Main: 265244672 08:52:59 INFO - PROCESS | 1683 | 08:53:01 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 08:53:02 INFO - PROCESS | 1683 | RSS: Main: 265269248 08:53:02 INFO - PROCESS | 1683 | 08:53:05 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 08:53:05 INFO - PROCESS | 1683 | RSS: Main: 265637888 08:53:05 INFO - PROCESS | 1683 | 08:53:07 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:53:07 INFO - PROCESS | 1683 | RSS: Main: 299184128 08:53:07 INFO - PROCESS | 1683 | 08:53:09 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:53:10 INFO - PROCESS | 1683 | RSS: Main: 300007424 08:53:10 INFO - PROCESS | 1683 | 08:53:12 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:53:12 INFO - PROCESS | 1683 | RSS: Main: 304771072 08:53:12 INFO - PROCESS | 1683 | 08:53:15 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:16 INFO - PROCESS | 1683 | RSS: Main: 307167232 08:53:16 INFO - PROCESS | 1683 | 08:53:18 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:19 INFO - PROCESS | 1683 | RSS: Main: 306966528 08:53:19 INFO - PROCESS | 1683 | 08:53:20 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 08:53:21 INFO - PROCESS | 1683 | RSS: Main: 369192960 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | __start_tp_report 08:53:21 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 08:53:21 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 08:53:21 INFO - PROCESS | 1683 | |i|pagename|runs| 08:53:21 INFO - PROCESS | 1683 | |0;ai-astar;113;111;111;110;113;113;118;113;110;113 08:53:21 INFO - PROCESS | 1683 | |1;audio-beat-detection;153;119;145;157;137;143;119;151;149;126 08:53:21 INFO - PROCESS | 1683 | |2;audio-dft;182;186;184;186;186;188;186;184;187;181 08:53:21 INFO - PROCESS | 1683 | |3;audio-fft;74;77;76;117;56;56;58;59;123;58 08:53:21 INFO - PROCESS | 1683 | |4;audio-oscillator;91;97;130;81;77;85;114;76;78;113 08:53:21 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;87;85;87;85;88;84;88;84;87;84 08:53:21 INFO - PROCESS | 1683 | |6;imaging-darkroom;94;93;94;93;93;93;92;93;93;92 08:53:21 INFO - PROCESS | 1683 | |7;imaging-desaturate;85;86;85;87;89;135;85;86;88;84 08:53:21 INFO - PROCESS | 1683 | |8;json-parse-financial;55;58;58;57;59;59;59;68;52;53 08:53:21 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;62;72;65;73;67;66;67;66;67;66 08:53:21 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;83;81;81;79;82;81;80;81;80;84 08:53:21 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;130;118;121;117;112;123;117;127;118;142 08:53:21 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;136;124;134;134;133;122;133;133;132;132 08:53:21 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;60;96;93;89;75;65;67;66;67;64 08:53:21 INFO - PROCESS | 1683 | __end_tp_report 08:53:21 INFO - PROCESS | 1683 | __start_cc_report 08:53:21 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1266 08:53:21 INFO - PROCESS | 1683 | __end_cc_report 08:53:21 INFO - PROCESS | 1683 | __startTimestamp1460562801194__endTimestamp 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | ------- Summary: start ------- 08:53:21 INFO - PROCESS | 1683 | Number of tests: 14 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:2.32 (2.1%) stddev-sans-first:2.46 08:53:21 INFO - PROCESS | 1683 | Values: 113.0 111.0 111.0 110.0 113.0 113.0 118.0 113.0 110.0 113.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:147.00 stddev:14.07 (9.6%) stddev-sans-first:14.10 08:53:21 INFO - PROCESS | 1683 | Values: 153.0 119.0 145.0 157.0 137.0 143.0 119.0 151.0 149.0 126.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:185.00 Median:186.00 stddev:2.21 (1.2%) stddev-sans-first:2.06 08:53:21 INFO - PROCESS | 1683 | Values: 182.0 186.0 184.0 186.0 186.0 188.0 186.0 184.0 187.0 181.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:75.40 Median:58.50 stddev:25.01 (42.7%) stddev-sans-first:26.52 08:53:21 INFO - PROCESS | 1683 | Values: 74.0 77.0 76.0 117.0 56.0 56.0 58.0 59.0 123.0 58.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.50 stddev:18.84 (23.7%) stddev-sans-first:19.94 08:53:21 INFO - PROCESS | 1683 | Values: 91.0 97.0 130.0 81.0 77.0 85.0 114.0 76.0 78.0 113.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.66 (1.9%) stddev-sans-first:1.72 08:53:21 INFO - PROCESS | 1683 | Values: 87.0 85.0 87.0 85.0 88.0 84.0 88.0 84.0 87.0 84.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 08:53:21 INFO - PROCESS | 1683 | Values: 94.0 93.0 94.0 93.0 93.0 93.0 92.0 93.0 93.0 92.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:91.00 Median:86.00 stddev:15.53 (18.1%) stddev-sans-first:16.32 08:53:21 INFO - PROCESS | 1683 | Values: 85.0 86.0 85.0 87.0 89.0 135.0 85.0 86.0 88.0 84.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.50 stddev:4.39 (7.5%) stddev-sans-first:4.54 08:53:21 INFO - PROCESS | 1683 | Values: 55.0 58.0 58.0 57.0 59.0 59.0 59.0 68.0 52.0 53.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:3.21 (4.8%) stddev-sans-first:2.83 08:53:21 INFO - PROCESS | 1683 | Values: 62.0 72.0 65.0 73.0 67.0 66.0 67.0 66.0 67.0 66.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:1.48 (1.8%) stddev-sans-first:1.41 08:53:21 INFO - PROCESS | 1683 | Values: 83.0 81.0 81.0 79.0 82.0 81.0 80.0 81.0 80.0 84.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:122.00 stddev:8.63 (7.1%) stddev-sans-first:8.72 08:53:21 INFO - PROCESS | 1683 | Values: 130.0 118.0 121.0 117.0 112.0 123.0 117.0 127.0 118.0 142.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.30 Median:133.00 stddev:4.55 (3.4%) stddev-sans-first:4.49 08:53:21 INFO - PROCESS | 1683 | Values: 136.0 124.0 134.0 134.0 133.0 122.0 133.0 133.0 132.0 132.0 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:71.00 stddev:13.37 (18.8%) stddev-sans-first:13.16 08:53:21 INFO - PROCESS | 1683 | Values: 60.0 96.0 93.0 89.0 75.0 65.0 67.0 66.0 67.0 64.0 08:53:21 INFO - PROCESS | 1683 | -------- Summary: end -------- 08:53:21 INFO - PROCESS | 1683 | 08:53:21 INFO - TEST-INFO | 1683: exit 0 08:53:21 INFO - TEST-OK | kraken | took 56127ms 08:53:21 INFO - SUITE-END | took 1169s 08:53:22 INFO - Completed test suite (00:19:30) 08:53:22 INFO - javascript benchmark 08:53:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3364.966350336497, 3461.723062155027, 3464.44568868981, 3499.457584074469, 3538.9115272118192, 5679.829605111853, 5686.971565142178, 5688.402717714637, 5689.345725241593, 5705.572082093839, 5666.660000399968, 5688.544916406688, 5709.371969083408, 5711.7715291388395, 5716.28546431696, 5142.7428628568605, 5221.791128354871, 5222.4255331913455, 5300.257963885059, 5303.178007408838, 5246.658967167141, 5249.868753281179, 5286.889753151842, 5292.894142117156, 5292.973535132338, 5196.272521846944, 5235.267062611238, 5239.502247286521, 5259.894802103956, 5263.499967503081, 5200.453952335007, 5202.3497062867145, 5219.8434046978655, 5226.111561034633, 5272.393674727417, 5030.773615187325, 5191.506806853343, 5220.060389129955, 5240.213967904845, 5257.631965762398, 5658.0381335173115, 5705.5435565154685, 5713.3429655589725, 5717.9714101429645, 5719.48524632785, 6091.939080609226, 6276.811695649138, 6304.306526282106, 6315.147455093549, 6326.08271800591, 6167.013277875563, 6235.438810507031, 6258.092576576417, 6289.7169627366875, 6322.810315690491, 5851.151583020438, 5878.147668588031, 5881.500072493843, 5887.76448942046, 5915.5859089863725, 6145.8156255312415, 6279.183706118267, 6286.49708023357, 6291.465225455888, 6303.747850086037, 6083.9391606084255, 6155.84610384744, 6184.165137706442, 6193.876122477525, 6197.597156184834, 6273.96863015682, 6275.717592708339, 6279.277883043508, 6284.717187726564, 6287.151234583364, 6124.326324104345, 6186.721597528122, 6203.47270482005, 6229.626222426578, 6244.562880598314, 6094.360092190344, 6149.2313460817395, 6150.354212807681, 6163.229596300463, 6255.624662520263, 4838.588719958843, 4844.15227335215, 4847.95152048482, 4879.999600081975, 4886.022795440855, 4379.430674012422, 4390.648748100144, 4398.3842262083335, 4417.889552761207, 4437.711548749321, 5624.015797235467, 5648.406917273709, 5673.290838645169, 5708.9714551427805, 5710.600257981901, 6184.6598437086395, 6230.813075607739, 6271.62370257786, 6282.528810339243, 6286.4342209201395, 4751.311059896296, 5690.5163061140265, 5691.544676425876, 5727.0550359190265, 5748.827535173951, 5389.83830485086, 5400.810971616053, 5407.351117865881, 5411.56707463402, 5411.945880541223, 6144.2488890665945, 6242.469390101892, 6291.402316779899, 6313.179286692793, 6318.368163183737, 6190.102435146789, 6253.749850005949, 6262.060690896402, 6277.027060805583, 6281.905771413341, 6282.3089460158435, 6283.37166283368, 6333.081703152925, 6343.302236754045, 6352.0789485525265, 6110.7250173741395, 6121.7578389577775, 6186.628802271878, 6229.190205273286, 6267.310595834546, 6223.657698826608, 6231.158793562811, 6240.719167637377, 6252.437280644764, 6273.121762953281, 5848.576451312466, 6003.0, 6035.426634469718, 6068.666223357758, 6093.878122437615, 5922.466977972003, 5925.318588362394, 6037.909431358621, 6080.3919608040615, 6092.75628974836, 5929.881402372014, 5943.138244954371, 5951.791687290924, 5964.731587078679, 6023.909641355471, 6064.727087281171, 6144.539159562962, 6144.648177400964, 6149.7847575334645, 6164.137020816999, 5664.0, 5831.096180092092, 5944.4352786485215, 6034.125051867542, 6087.026075827846], "unit": "score", "name": "dojo.html", "value": 5705.368294197327}, {"lowerIsBetter": false, "replicates": [472.35287655911407, 589.9174115623811, 593.4451288045677, 623.8378021714353, 626.64281359625, 30179.34013629252, 31705.365892682134, 31723.36553268936, 31770.841145794297, 31808.0, 40547.98630034243, 40895.0, 40973.97565060875, 40979.770606881844, 41232.76301710946, 9532.380395274286, 9766.9511652442, 9770.560324785401, 9770.560324785401, 9776.657816976407, 9632.855507167398, 9771.316007879415, 9773.12041916231, 9779.853302200472, 9782.364146330467, 9723.416595004323, 9806.019398060173, 9806.803863922718, 9811.460369679664, 9818.803623927517, 9694.612215511372, 9774.657886973993, 9790.412575245507, 9792.363496372713, 9798.6080556778, 9565.713028609152, 9686.951565242129, 9795.06946840049, 9799.804003919953, 9818.852717209247, 41189.79405102955, 41483.58516414827, 41492.96267593304, 41548.753537393924, 41570.0, 3092.458819706565, 3229.434848901433, 3403.0981789825714, 3505.9657401066747, 3653.8355773990234, 25500.0, 25925.351866203495, 26010.609840852212, 26242.0, 26344.60483092755, 2766.5573508238786, 2807.705190954941, 2818.1122946271857, 2825.1948194764395, 2847.2312475631466, 418028.0, 418321.0, 418518.0, 418580.999999997, 419128.0, 58172.4182758167, 65709.0, 65891.67054164794, 67093.0, 67198.32801671921, 71098.0, 76234.0, 77201.61399192968, 77222.0, 77265.61367193128, 17718.02550859715, 17918.193681284374, 17959.910200449176, 17963.0, 17980.1009949502, 13558.254296013814, 13641.0, 13648.590542283748, 13657.931710341385, 13667.521636742666, 18924.33764818225, 22118.447038823837, 22389.216377427038, 22468.550628987654, 22472.32583022512, 8709.0, 8877.911220887838, 8899.599518021705, 8913.331500137387, 9014.278857691368, 954.9713508594754, 1021.0453226233495, 1062.7715041266165, 1069.9572017119383, 1086.5979587552497, 30245.0, 30555.388892222476, 30816.84591577028, 31551.89568365096, 32485.675143248736, 928.5264515097214, 1119.658504156224, 1129.085440792944, 1137.9487923043482, 1187.2401662935729, 14214.928925355514, 16493.752593711102, 16568.92302000366, 16579.336826527044, 16848.32606695743, 669279.0, 677406.0, 679499.0, 681367.0, 682732.5863370651, 62998.0, 63569.0, 63603.0, 63611.36388636147, 63744.68127659332, 1405.9086159399606, 1523.3449616664718, 1540.0143907898953, 1558.0885182168558, 1565.997761432684, 29067.7093229065, 29626.851865740533, 29716.85141574278, 29761.5535766968, 30289.93985210507, 49808.25287620616, 50131.74934125306, 50742.23886641629, 50801.23798143105, 50870.745646271534, 411046.0, 412722.0, 413053.0, 413404.0, 414749.0, 29488.705112948595, 48023.03953920972, 48592.75703621459, 48969.75515122402, 50352.74823626005, 46592.0, 47664.2850357238, 49024.50975490199, 49226.50773492219, 50602.746986264836, 38934.026649333995, 39237.0, 40372.3944140844, 40609.984750381474, 40615.455253229564, 39352.606473934895, 39613.60386396215, 39851.2029759409, 40138.598614013485, 40508.0, 39478.60521394864, 39961.60038399695, 40260.19479610333, 41304.0, 41310.38034429426, 34468.65531344755, 34982.47526287159, 35558.644413555536, 35812.641873581975, 35854.0, 26479.0, 26571.804268807562, 26599.0, 26694.0, 27065.72934270632], "unit": "score", "name": "ext.html", "value": 20612.199154086}, {"lowerIsBetter": false, "replicates": [326.27725608785613, 368.169777152521, 372.4692313453329, 378.45502476433916, 378.87686501886895, 14928.328225229863, 20306.492337691565, 20312.492187695298, 20811.959402029912, 20838.583228335425, 10290.794184116314, 19547.315843945464, 20803.959802009915, 20839.0, 20853.374398768025, 5264.210368444745, 5381.48875856793, 5421.457854214566, 5422.2951016368015, 5424.674519528821, 4095.6313931746135, 4293.141371725652, 5364.463553644624, 7372.483926125174, 7693.9615301923695, 7326.377257933082, 7639.7326093586735, 7643.388528917673, 7644.6559904804135, 7645.273698998586, 6557.77047803327, 7580.810479737996, 7592.544447333123, 7601.277878601524, 7603.809904752397, 4044.7573145611063, 6952.478564107661, 7265.128184617827, 7270.854582908365, 7280.4903656744045, 27287.45425091507, 27371.315717107034, 27584.724152758616, 29028.854855725796, 29043.98346057878, 2310.838241323108, 2321.3732292281156, 2324.3491822289784, 2464.0, 2487.4154573675173, 14790.321941947559, 15825.683486330325, 16233.756493652605, 16314.0, 16580.50258492235, 1559.5867095219776, 1803.0443864751703, 1837.6232872261155, 1863.9720404193947, 2022.5449273913398, 92936.67658308528, 110756.9999999992, 119061.80938190594, 120482.7951720489, 120746.0, 19062.523436914187, 19486.610267794564, 19519.316823911096, 19637.80362196388, 19666.508337291398, 30146.0, 30166.84916575447, 30755.538666920012, 30787.69212307893, 30908.53637195444, 10759.946200268949, 11175.497102630401, 11207.943960280147, 11236.775264494665, 11306.982371586597, 8234.588270586566, 9009.279257659371, 9407.764805879771, 9415.681804547232, 9489.620415183454, 8666.86999695005, 8732.563371831384, 8808.295336373074, 8811.339149563808, 8814.911850881537, 2873.5976963225166, 2921.7078292170613, 3384.2047118927035, 3390.2202493426157, 3400.897973060812, 929.5491686532026, 929.6188562689265, 990.7572644702094, 1026.2405819693374, 1029.6344797596746, 19633.607327853362, 19716.60566788656, 19735.802641973398, 20158.39524814258, 20291.797082028992, 975.7170420577953, 979.6718099436769, 990.4107056301489, 1044.0916402729674, 1045.482486169351, 7945.364370850318, 10970.506327215135, 11038.0, 11277.774444511064, 11310.547578096784, 625866.0, 636008.0, 637097.0, 638553.0, 644022.0, 107126.0, 111087.44456277828, 111901.0, 113578.0, 114036.42981785204, 1008.82345589523, 1017.104947646052, 1019.8623185869961, 1021.4688362051692, 1024.2011231239644, 17955.371561995267, 18104.547386315448, 18190.272389104288, 18581.44255672332, 18888.905555472684, 49340.0, 49740.507784766516, 50097.499025010744, 50804.0, 51649.741751291, 54928.72535637296, 68207.31792682009, 70142.64928675324, 70617.64691176511, 71668.0, 8225.682286622416, 8258.091609923023, 8281.17188281167, 8409.95795021021, 8609.354298427768, 9512.476813775309, 12812.55156069533, 13196.868031319564, 13520.86479135196, 13635.977301702611, 10528.684139475828, 10913.126949844152, 11516.884831151916, 11717.238379505305, 11834.940825295818, 10943.233973621771, 11024.779504409706, 11240.494177762184, 11546.76906461883, 11679.299242045505, 11605.419729013684, 11653.6503904883, 11719.238249513754, 11866.940665296619, 12013.81979270329, 8258.25675689191, 8292.917070829455, 8297.543635099886, 8362.832743345221, 8388.951381077366, 8711.303095752199, 11529.654110376701, 11785.587504437304, 11845.23006004607, 12022.819657705317], "unit": "score", "name": "jquery.html", "value": 10576.304464829274}, {"lowerIsBetter": false, "replicates": [1411.3084588551612, 1588.7458006718925, 1617.3853935504503, 1921.3275353626225, 2050.179928028789, 8203.26170644642, 8732.039475657673, 8888.600012999406, 8893.510856902867, 8894.110588941103, 7079.964600177005, 9011.053839346856, 9026.954865225665, 9033.232175265093, 9038.231750301216, 2244.2930476899805, 2481.6153496208117, 2534.4170840706647, 2550.2986678663424, 2567.4351642638685, 2387.7254115776645, 2392.851431312971, 2570.0876188952934, 2572.4855028994275, 2576.716561178269, 2277.851939623919, 2375.869327187004, 2543.0972004938167, 2544.6183072539084, 2553.0553695132826, 2476.2818782553036, 2506.724260331362, 2543.4785868896834, 2544.478381931718, 2549.3754030262703, 2508.14722994181, 2525.772680458749, 2553.1319351420607, 2569.678790151231, 2569.845809251451, 9086.68196613122, 9159.542022898828, 9184.44893306397, 9188.310876684276, 9209.677661281823, 5558.610897237195, 5777.306723193244, 5781.277340332458, 5802.506786923117, 5815.912761308584, 3405.3700065487965, 3513.2095278562374, 3541.2563361694074, 3618.330608837347, 3703.5926048134684, 1037.9273450858443, 1061.3578784835217, 1064.1965316186229, 1072.6567498400516, 1105.4196546812907, 12073.0, 12093.818592721116, 12102.81845772314, 12108.878911210862, 12117.818232726517, 4852.199387101089, 4935.432425271068, 4981.352424184905, 5015.824446144367, 5015.899682006339, 10349.327293725884, 10353.792924141626, 10364.326318789255, 10370.948145259375, 10396.324238924446, 5671.546276297886, 5671.914921276184, 5674.687892165971, 5677.659340439587, 5685.715714214272, 4527.683062185615, 4643.976780116078, 4656.348111264426, 4700.506446823103, 4911.901761964812, 3631.5279013728045, 3810.9047273817823, 3877.534695836461, 3985.740926839746, 4005.1388951375593, 1114.2478826791883, 1325.9071864969553, 1329.8005299205197, 1341.2958196946486, 1343.7917122845975, 1381.3783797291057, 1383.4673650644575, 1407.1416435974047, 1439.6976634906787, 1442.5383877159418, 8407.201315874981, 8588.141185881363, 8589.570521473901, 8598.699045533376, 8609.870851937227, 1082.8105081610686, 1238.325112813519, 1239.6528971887706, 1253.7555176740448, 1271.1800888426912, 6343.55595108338, 6351.904721429182, 6417.229932408048, 6427.164468619143, 6431.389018043278, 10445.059944605022, 10811.78376432467, 10928.0, 10957.342559446459, 11099.278546894426, 10552.0, 10855.294405863593, 10892.945535272273, 10970.945145274382, 10971.122310215163, 8427.157284271523, 8509.234168924702, 8565.314774818, 8579.742607721902, 8599.183077607617, 8077.515349079074, 8139.1453897339925, 8161.632726527202, 8253.587320633824, 8292.33661307082, 9280.443173409618, 9600.423974561549, 9603.087706667855, 9729.0, 9863.901360986298, 9711.56297966579, 9850.359726617748, 10011.998800120222, 10024.599016039569, 10025.248106392195, 7447.776566703008, 7528.322450979438, 7600.961995189989, 7652.387808975157, 7654.387648988179, 8416.87374689368, 8462.576871156294, 8498.0, 8510.914890851012, 8517.659293628434, 7432.628368581657, 7503.137139229058, 7592.506487078323, 7639.541627502367, 7697.0378702662165, 7369.926300736924, 7383.8154046149275, 7434.256574342522, 7475.476716629783, 7536.547807131589, 7963.522188668699, 8023.879641805494, 8024.197580241929, 8025.197480252162, 8059.717909873127, 6972.616506092011, 7143.9285607143265, 7152.070230869954, 7198.2801719829695, 7256.7460138894885, 7259.963700181676, 7262.164851041986, 7297.708091676486, 7312.890306645511, 7316.817079573053], "unit": "score", "name": "mootools.html", "value": 5066.215157871305}, {"lowerIsBetter": false, "replicates": [332.3585480023554, 336.85515228451754, 338.5243732555757, 342.2436415521697, 342.8165931226794, 6459.257185423678, 6471.352864713526, 6486.254080780712, 6497.480201583874, 6501.959686450169, 6119.449249567538, 6399.616023038621, 6478.0, 6486.448651864597, 6492.480601551876, 4664.416947881515, 4730.408698912636, 4799.976000120012, 4850.9029819403595, 4887.486813884544, 4850.805967761303, 4883.12103821312, 4886.462489126193, 4892.189889740801, 4895.730734809584, 4819.2530157825595, 4825.662203645747, 4828.396450443694, 4836.887515871352, 4874.220124780036, 4571.497135315112, 4623.144718227139, 4763.404574428197, 4778.020505796303, 4778.4265888093305, 4096.549379568245, 4103.261412945669, 4114.362273847529, 4118.217538667644, 4118.320477121271, 6122.693865306717, 6150.538709596798, 6179.258488981351, 6182.289036760785, 6184.07238914162, 5613.550915926716, 5614.522765564931, 5633.492985631272, 5639.436056394369, 5646.068398714207, 6859.451243900476, 6862.313768623148, 6863.725450981955, 6871.0, 6872.62200578968, 4325.913481730379, 4511.436070491189, 4528.8867778305475, 4529.750863702495, 4554.225781617133, 7124.394426473756, 7284.125904891394, 7291.598962057138, 7295.197528271886, 7298.81752956175, 4589.242774942164, 4599.770011499411, 4606.055758569485, 4606.470255920545, 4617.746023968714, 4644.117617652635, 4660.487346391894, 4660.930086048712, 4661.417322834645, 4670.392848929618, 5489.64317319373, 5501.0098182326765, 5504.614676972574, 5507.228987941691, 5512.118061110203, 6643.0, 6899.379055884994, 6920.653967301615, 6927.965360173268, 6936.514443988974, 1346.219192868134, 1606.3333716507752, 1622.9431969880998, 1623.5859855736712, 1625.8455446732542, 971.9757006074764, 994.8159590475785, 1027.712240572641, 1028.2339656955617, 1053.5891002509027, 6413.29453760086, 6510.609363438209, 6518.315576864456, 6522.119513865662, 6538.0, 7265.0, 7266.564006159648, 7269.709211631475, 7270.982062511147, 7271.600061996641, 6494.0, 6513.218413790375, 6513.2509761377105, 6515.51133664977, 6530.0, 3757.079515518715, 3791.2227993261317, 3795.6204379562373, 3800.600936901641, 3801.1447424329303, 7237.782866514013, 7486.887696684554, 7584.393248540214, 7620.923790762022, 7656.61716914152, 6064.4238797315065, 7424.888626670604, 7472.775816725398, 7472.813179670552, 7518.173000969889, 7561.432892532972, 7576.469647124759, 7586.468947173756, 7586.772396828104, 7597.240275972469, 6918.688659010256, 7223.1693355264815, 7242.275772422716, 7247.9637601811655, 7259.12890453149, 7012.824679383056, 7089.751858684921, 7112.324329188718, 7145.285471452813, 7146.821329466805, 7594.126675432175, 7596.8480630388185, 7610.238976102345, 7619.361837205028, 7624.741917583537, 4732.077244937204, 4787.688800227974, 4798.328234047306, 4803.855884323476, 4804.903901921872, 6058.0, 6557.9179435394535, 6873.553219040747, 7097.503174777716, 7117.750878719427, 6857.142857142857, 6859.9314006859295, 6869.278725733726, 6872.484563657646, 6875.724971001304, 6801.863962720817, 6841.521093523605, 6844.863102737818, 6846.623435711083, 6863.622500762506, 6696.330366963265, 6696.933030669631, 6702.329767023259, 6708.094407254958, 6716.29478904708, 6598.680263947325, 6821.045053692388, 6852.965735171292, 6867.828304292432, 6884.793456196322, 5545.334559852843, 6307.180066591313, 6402.551821372459, 6581.572197807127, 6727.192736871607], "unit": "score", "name": "prototype.html", "value": 5075.032085151447}, {"lowerIsBetter": false, "replicates": [752.7327798631486, 759.4493991855906, 771.44455991686, 778.3267473635307, 788.1212448120344, 14812.629684257885, 15118.546443606681, 15142.16718080505, 15147.697046059073, 17495.300187992496, 16391.34434622614, 16447.58881027975, 16450.42423515177, 16451.670966580663, 16489.34042638293, 805.4442434720054, 813.6216659253446, 985.8866230383491, 989.193807047256, 1004.8191325561396, 998.9960090109466, 999.7950420163885, 1001.1640280365867, 1003.1773945364804, 1004.3823048824956, 1053.2364036073861, 1054.1882750282277, 1055.3456856748826, 1056.7463808685936, 1058.8570542976677, 820.5692011693849, 825.5005721538473, 1012.8227560177013, 1030.721705139608, 1048.6067724603274, 776.2664282253273, 776.5340795522698, 778.1906816910406, 779.1001393390643, 779.4933293359362, 15584.142872142027, 15602.843971560253, 15604.063756174552, 15629.765553516707, 15631.374745010186, 12455.314957677325, 12500.24998500093, 12657.367131643474, 12827.615171544869, 12890.742185156338, 10345.689629311133, 10413.739656508647, 10665.733356666145, 10669.466526673712, 10988.670339889735, 3512.7892326460496, 3518.929621407583, 3565.2512972275854, 3614.8554057837655, 3794.7533410328515, 84149.0, 84373.57813210956, 84673.15326846714, 85114.57442712809, 85617.0, 9681.225501959827, 9780.755481113029, 9790.0, 9792.069753373418, 9813.607455701693, 21114.0, 21209.36371908845, 21230.150793968376, 21230.575388492143, 21256.681149782766, 7432.814179645444, 7549.396048316232, 7586.734464293723, 7678.923210767933, 7716.884246736304, 4024.6176613221696, 4060.451839001697, 4078.898027549335, 4142.937855932163, 4293.549177336335, 3711.2391959648207, 3748.55017397914, 3752.7373083883867, 3757.0982964088967, 3757.4551690004796, 647.1716203259834, 655.5771527364823, 661.5435349608755, 664.9991762397657, 673.175360183771, 567.324883388766, 590.4508806809622, 602.2682440834408, 609.4058293164129, 622.4553515673786, 8130.227628375294, 8567.314614830799, 8608.268297194809, 8627.170926691804, 8631.6978905738, 567.7473524281655, 588.153059594183, 613.7514306705791, 629.1317981185935, 638.6232123047424, 3837.57786643469, 3896.5129358830145, 3970.920581588352, 4023.839046438168, 4052.3111071117983, 94725.0, 95096.57355139678, 96217.518912405, 98490.01509984952, 99206.0, 80936.0, 81079.59460202661, 81685.59157204175, 82574.0, 82747.0, 73242.53514929672, 73299.43451979155, 74347.0, 74526.62736686281, 74688.0, 7236.34872861445, 8342.87485687703, 8587.785305367166, 8773.912260877309, 8871.0, 48872.75563622159, 48955.510444895095, 49078.75460622674, 49662.75168624134, 49981.75009124931, 66275.00587491094, 69022.61954760978, 69830.65084674544, 70797.29202708113, 70837.0, 9216.815663686823, 11059.447027648746, 11225.158113141384, 11360.772784544428, 11543.307401555934, 11956.0, 12162.452689629165, 12186.756264874475, 12239.938800306298, 12515.624531264077, 11436.82844757346, 11678.591249306233, 11848.052155827685, 12061.638150855488, 12098.334591597546, 10371.0, 10792.838107428237, 11712.063034957013, 11734.765304693688, 11929.701757455787, 8384.99380074395, 10831.783364332512, 11191.216614837209, 11433.59982400612, 11926.821097683369, 9871.0, 9910.702678919644, 9952.2535809816, 10007.049330313608, 10169.84745228837, 9808.0, 9895.65365212243, 9936.0, 10002.899971000488, 10007.899921000697], "unit": "score", "name": "yui.html", "value": 7149.9201966912}], "name": "dromaeo_css", "value": 7819.88631479184}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 111.0, 111.0, 110.0, 113.0, 113.0, 118.0, 113.0, 110.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [153.0, 119.0, 145.0, 157.0, 137.0, 143.0, 119.0, 151.0, 149.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 139.9}, {"lowerIsBetter": true, "replicates": [182.0, 186.0, 184.0, 186.0, 186.0, 188.0, 186.0, 184.0, 187.0, 181.0], "unit": "score", "name": "audio-dft", "value": 185.0}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 76.0, 117.0, 56.0, 56.0, 58.0, 59.0, 123.0, 58.0], "unit": "score", "name": "audio-fft", "value": 75.4}, {"lowerIsBetter": true, "replicates": [91.0, 97.0, 130.0, 81.0, 77.0, 85.0, 114.0, 76.0, 78.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 85.0, 88.0, 84.0, 88.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.9}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 87.0, 89.0, 135.0, 85.0, 86.0, 88.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 91.0}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 58.0, 57.0, 59.0, 59.0, 59.0, 68.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [62.0, 72.0, 65.0, 73.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 81.0, 79.0, 82.0, 81.0, 80.0, 81.0, 80.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [130.0, 118.0, 121.0, 117.0, 112.0, 123.0, 117.0, 127.0, 118.0, 142.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [136.0, 124.0, 134.0, 134.0, 133.0, 122.0, 133.0, 133.0, 132.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.3}, {"lowerIsBetter": true, "replicates": [60.0, 96.0, 93.0, 89.0, 75.0, 65.0, 67.0, 66.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.2}], "name": "kraken", "value": 1411.0}]} 08:53:22 INFO - Return code: 0 08:53:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:53:22 INFO - # TBPL SUCCESS # 08:53:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:53:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:53:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:53:22 INFO - 2016-04-13 08:53:22.493 screenresolution[1687:9778] starting screenresolution argv=screenresolution get 08:53:22 INFO - 2016-04-13 08:53:22.496 screenresolution[1687:9778] Display 0: 1600x1200x32@60 08:53:22 INFO - 2016-04-13 08:53:22.502 screenresolution[1688:9781] starting screenresolution argv=screenresolution list 08:53:22 INFO - Available Modes on Display 0 08:53:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:53:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:53:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:53:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:53:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:53:22 INFO - Intel Iris: 08:53:22 INFO - Chipset Model: Intel Iris 08:53:22 INFO - Type: GPU 08:53:22 INFO - Bus: Built-In 08:53:22 INFO - VRAM (Dynamic, Max): 1536 MB 08:53:22 INFO - Vendor: Intel (0x8086) 08:53:22 INFO - Device ID: 0x0a2e 08:53:22 INFO - Revision ID: 0x0009 08:53:22 INFO - Displays: 08:53:22 INFO - Display: 08:53:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:53:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:53:22 INFO - Display Serial Number: 1600x1200 60 08:53:22 INFO - Main Display: Yes 08:53:22 INFO - Mirror: Off 08:53:22 INFO - Online: Yes 08:53:22 INFO - Rotation: Supported 08:53:22 INFO - Return code: 0 08:53:22 INFO - Running post-action listener: _resource_record_post_action 08:53:22 INFO - Running post-run listener: _resource_record_post_run 08:53:23 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 31976960; Write bytes: 662270976; Read time: 321; Write time: 2157 08:53:23 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 358353408; Write bytes: 353072640; Read time: 27969; Write time: 628 08:53:23 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30182912; Write bytes: 298024448; Read time: 302; Write time: 1495 08:53:23 INFO - Running post-run listener: _upload_blobber_files 08:53:23 INFO - Blob upload gear active. 08:53:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:53:24 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:25 INFO - (blobuploader) - INFO - Done attempting. 08:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:26 INFO - (blobuploader) - INFO - Done attempting. 08:53:26 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:26 INFO - Return code: 0 08:53:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30465b20706ed85daf030cc3776b8683983704861d861cdd83f598a93ffa0aa2b2856a5766e7e8fae35a2b78d45b5dafb4b7dd8625c3868b51c063cc908faa54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bbc7af3b3adacf699dec526a41e5f8eb3ea23ca208901b11d1a99f774882ce3f6addd6ae756b8771ed8825ac8d73a2bc329760a158a3d747f78b1cace502c43"} 08:53:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:26 INFO - Contents: 08:53:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30465b20706ed85daf030cc3776b8683983704861d861cdd83f598a93ffa0aa2b2856a5766e7e8fae35a2b78d45b5dafb4b7dd8625c3868b51c063cc908faa54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bbc7af3b3adacf699dec526a41e5f8eb3ea23ca208901b11d1a99f774882ce3f6addd6ae756b8771ed8825ac8d73a2bc329760a158a3d747f78b1cace502c43"} 08:53:26 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:26 INFO - Copying logs to upload dir... 08:53:26 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.222938 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-13 08:53:26.602493) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 08:53:26.606176) ========= 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.INttTzbOGt/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.bDmIPepH3p/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30465b20706ed85daf030cc3776b8683983704861d861cdd83f598a93ffa0aa2b2856a5766e7e8fae35a2b78d45b5dafb4b7dd8625c3868b51c063cc908faa54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bbc7af3b3adacf699dec526a41e5f8eb3ea23ca208901b11d1a99f774882ce3f6addd6ae756b8771ed8825ac8d73a2bc329760a158a3d747f78b1cace502c43"} build_url:https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010893 build_url: 'https://queue.taskcluster.net/v1/task/M16kHW1ETTWsTkTZmSOJLQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30465b20706ed85daf030cc3776b8683983704861d861cdd83f598a93ffa0aa2b2856a5766e7e8fae35a2b78d45b5dafb4b7dd8625c3868b51c063cc908faa54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bbc7af3b3adacf699dec526a41e5f8eb3ea23ca208901b11d1a99f774882ce3f6addd6ae756b8771ed8825ac8d73a2bc329760a158a3d747f78b1cace502c43"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 08:53:26.634941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:53:26.635319) ========= 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.INttTzbOGt/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.bDmIPepH3p/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005237 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:53:26.684031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 08:53:26.684540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 08:53:26.685348) ========= ========= Total master_lag: 15.06 =========