builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0082 starttime: 1459158880.88 results: success (0) buildid: 20160328004018 builduid: 85688f16b32d44d39948e9c2c46ad492 revision: 5629a22932f74f3e2d647c3462c32191a791afed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:40.882708) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:40.883095) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:40.883380) ========= 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.Heefau8TxK/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.9UhqpPDdOm/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005423 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:40.944737) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:40.945059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:41.136780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:41.137109) ========= 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.Heefau8TxK/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.9UhqpPDdOm/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005246 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:41.230642) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:41.233948) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:41.234337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:41.234614) ========= 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.Heefau8TxK/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.9UhqpPDdOm/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-28 02:54:41-- 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% 173M=0s 2016-03-28 02:54:41 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136261 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:41.410277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:41.410564) ========= 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.Heefau8TxK/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.9UhqpPDdOm/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026753 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:41.461160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-28 02:54:41.461476) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5629a22932f74f3e2d647c3462c32191a791afed --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 5629a22932f74f3e2d647c3462c32191a791afed --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Heefau8TxK/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.9UhqpPDdOm/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-28 02:54:41,511 truncating revision to first 12 chars 2016-03-28 02:54:41,511 Setting DEBUG logging. 2016-03-28 02:54:41,511 attempt 1/10 2016-03-28 02:54:41,511 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5629a22932f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 02:54:42,711 unpacking tar archive at: mozilla-aurora-5629a22932f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.452215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-28 02:54:42.930853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:42.931149) ========= echo 5629a22932f74f3e2d647c3462c32191a791afed in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5629a22932f74f3e2d647c3462c32191a791afed'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Heefau8TxK/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.9UhqpPDdOm/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 5629a22932f74f3e2d647c3462c32191a791afed program finished with exit code 0 elapsedTime=0.005505 script_repo_revision: '5629a22932f74f3e2d647c3462c32191a791afed' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:42.987498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:42.988031) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 02:54:43.005345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-03-28 02:54:43.005745) ========= /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.Heefau8TxK/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.9UhqpPDdOm/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:54:43 INFO - MultiFileLogger online at 20160328 02:54:43 in /builds/slave/test 02:54:43 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 02:54:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:54:43 INFO - {'append_to_log': False, 02:54:43 INFO - 'base_work_dir': '/builds/slave/test', 02:54:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:54:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:54:43 INFO - 'branch': 'Mozilla-Aurora', 02:54:43 INFO - 'buildbot_json_path': 'buildprops.json', 02:54:43 INFO - 'config_files': ('talos/mac_config.py',), 02:54:43 INFO - 'default_actions': ('clobber', 02:54:43 INFO - 'read-buildbot-config', 02:54:43 INFO - 'download-and-extract', 02:54:43 INFO - 'populate-webroot', 02:54:43 INFO - 'create-virtualenv', 02:54:43 INFO - 'install', 02:54:43 INFO - 'run-tests'), 02:54:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:54:43 INFO - 'download_minidump_stackwalk': True, 02:54:43 INFO - 'download_symbols': 'ondemand', 02:54:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:54:43 INFO - 'tooltool.py': '/tools/tooltool.py', 02:54:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:54:43 INFO - '/tools/misc-python/virtualenv.py')}, 02:54:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:54:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:54:43 INFO - 'installer_path': 'installer.exe', 02:54:43 INFO - 'log_level': 'info', 02:54:43 INFO - 'log_name': 'talos', 02:54:43 INFO - 'log_to_console': True, 02:54:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:54:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:54:43 INFO - 'opt_config_files': (), 02:54:43 INFO - 'pip_index': False, 02:54:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:54:43 INFO - 'cmd': ('bash', 02:54:43 INFO - '-c', 02:54:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:54:43 INFO - 'enabled': True, 02:54:43 INFO - 'halt_on_failure': False, 02:54:43 INFO - 'name': 'check_screen_resolution'},), 02:54:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:54:43 INFO - 'cmd': ('bash', 02:54:43 INFO - '-c', 02:54:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:54:43 INFO - 'enabled': True, 02:54:43 INFO - 'halt_on_failure': False, 02:54:43 INFO - 'name': 'check_screen_resolution'},), 02:54:43 INFO - 'run_cmd_checks_enabled': True, 02:54:43 INFO - 'sps_profile': False, 02:54:43 INFO - 'sps_profile_interval': 0, 02:54:43 INFO - 'suite': 'dromaeojs', 02:54:43 INFO - 'system_bits': '32', 02:54:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:54:43 INFO - 'title': 't-yosemite-r7-0082', 02:54:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:54:43 INFO - 'use_talos_json': True, 02:54:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:54:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:54:43 INFO - 'work_dir': 'build'} 02:54:43 INFO - ##### 02:54:43 INFO - ##### Running clobber step. 02:54:43 INFO - ##### 02:54:43 INFO - Running pre-action listener: _resource_record_pre_action 02:54:43 INFO - Running main action method: clobber 02:54:43 INFO - rmtree: /builds/slave/test/build 02:54:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:54:44 INFO - Running post-action listener: _resource_record_post_action 02:54:44 INFO - ##### 02:54:44 INFO - ##### Running read-buildbot-config step. 02:54:44 INFO - ##### 02:54:44 INFO - Running pre-action listener: _resource_record_pre_action 02:54:44 INFO - Running main action method: read_buildbot_config 02:54:44 INFO - Using buildbot properties: 02:54:44 INFO - { 02:54:44 INFO - "project": "", 02:54:44 INFO - "product": "firefox", 02:54:44 INFO - "script_repo_revision": "production", 02:54:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:54:44 INFO - "repository": "", 02:54:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:54:44 INFO - "buildid": "20160328004018", 02:54:44 INFO - "stage_platform": "macosx64", 02:54:44 INFO - "basedir": "/builds/slave/test", 02:54:44 INFO - "nightly_build": "True", 02:54:44 INFO - "buildnumber": 145, 02:54:44 INFO - "slavename": "t-yosemite-r7-0082", 02:54:44 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:54:44 INFO - "platform": "yosemite_r7", 02:54:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:54:44 INFO - "branch": "mozilla-aurora", 02:54:44 INFO - "repo_path": "releases/mozilla-aurora", 02:54:44 INFO - "revision": "5629a22932f74f3e2d647c3462c32191a791afed", 02:54:44 INFO - "pgo_build": "False", 02:54:44 INFO - "builduid": "85688f16b32d44d39948e9c2c46ad492", 02:54:44 INFO - "slavebuilddir": "test" 02:54:44 INFO - } 02:54:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:54:44 INFO - Running post-action listener: _resource_record_post_action 02:54:44 INFO - ##### 02:54:44 INFO - ##### Running download-and-extract step. 02:54:44 INFO - ##### 02:54:44 INFO - Running pre-action listener: _resource_record_pre_action 02:54:44 INFO - Running main action method: download_and_extract 02:54:44 INFO - mkdir: /builds/slave/test/build/tests 02:54:44 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')]} 02:54:44 INFO - https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:54:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:54:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:54:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/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 02:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/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 02:54:57 INFO - Downloaded 1277 bytes. 02:54:57 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:54:57 INFO - Using the following test package requirements: 02:54:57 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:54:57 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:54:57 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:54:57 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:54:57 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:54:57 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:54:57 INFO - u'jsshell-mac.zip'], 02:54:57 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:54:57 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:54:57 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:54:57 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:54:57 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:54:57 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:54:57 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:54:57 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:54:57 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:54:57 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:54:57 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:54:57 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:54:57 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:54:57 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')]} 02:54:57 INFO - https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:54:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:54:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:54:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/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 02:54:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/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 02:54:59 INFO - Downloaded 17869738 bytes. 02:54:59 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'] 02:54:59 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 02:55:02 INFO - Return code: 0 02:55:02 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 02:55:02 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')]} 02:55:02 INFO - https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:55:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:55:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:55:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/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 02:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/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 02:55:05 INFO - Downloaded 17869738 bytes. 02:55:05 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'] 02:55:05 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 02:55:09 INFO - Return code: 0 02:55:09 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')]} 02:55:09 INFO - https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:55:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:55:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:55:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/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 02:55:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/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 02:55:10 INFO - Downloaded 10845161 bytes. 02:55:10 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'] 02:55:10 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 02:55:10 INFO - Return code: 0 02:55: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')]} 02:55:10 INFO - https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:55:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:55:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:55:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:55:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDCgoyydRACCHOoc6mjhSg/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 02:55:14 INFO - Downloaded 115093550 bytes. 02:55:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:55:14 INFO - mkdir: /builds/slave/test/properties 02:55:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:14 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:14 INFO - Contents: 02:55:14 INFO - build_url:https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:55:16 INFO - Running post-action listener: _resource_record_post_action 02:55:16 INFO - Running post-action listener: set_extra_try_arguments 02:55:16 INFO - ##### 02:55:16 INFO - ##### Running populate-webroot step. 02:55:16 INFO - ##### 02:55:16 INFO - Running pre-action listener: _resource_record_pre_action 02:55:16 INFO - Running main action method: populate_webroot 02:55:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:55:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:55:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:55:16 INFO - '--tppagecycles', 02:55:16 INFO - '7'], 02:55:16 INFO - 'tests': ['tsvgm']}}, 02:55:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:55:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:55:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:55:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:55:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:55:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:55:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:16 INFO - 'talos_options': ['--e10s'], 02:55:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:16 INFO - 'tests': ['damp', 'tps']}, 02:55:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:16 INFO - 'talos_options': ['--e10s'], 02:55:16 INFO - 'tests': ['damp', 'tps']}, 02:55:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:55:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:16 INFO - 'other': {'tests': ['a11yr', 02:55:16 INFO - 'ts_paint', 02:55:16 INFO - 'tpaint', 02:55:16 INFO - 'sessionrestore', 02:55:16 INFO - 'sessionrestore_no_auto_restore', 02:55:16 INFO - 'tabpaint']}, 02:55:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:55:16 INFO - 'tests': ['a11yr', 02:55:16 INFO - 'ts_paint', 02:55:16 INFO - 'tpaint', 02:55:16 INFO - 'sessionrestore', 02:55:16 INFO - 'sessionrestore_no_auto_restore', 02:55:16 INFO - 'tabpaint']}, 02:55:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:55:16 INFO - 'tests': ['a11yr', 02:55:16 INFO - 'ts_paint', 02:55:16 INFO - 'tpaint', 02:55:16 INFO - 'sessionrestore', 02:55:16 INFO - 'sessionrestore_no_auto_restore', 02:55:16 INFO - 'tabpaint']}, 02:55:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:55:16 INFO - 'tests': ['a11yr', 02:55:16 INFO - 'ts_paint', 02:55:16 INFO - 'tpaint', 02:55:16 INFO - 'sessionrestore', 02:55:16 INFO - 'sessionrestore_no_auto_restore', 02:55:16 INFO - 'tabpaint']}, 02:55:16 INFO - 'other_l64': {'tests': ['a11yr', 02:55:16 INFO - 'ts_paint', 02:55:16 INFO - 'tpaint', 02:55:16 INFO - 'sessionrestore', 02:55:16 INFO - 'sessionrestore_no_auto_restore', 02:55:16 INFO - 'tabpaint']}, 02:55:16 INFO - 'other_nol64': {'tests': ['a11yr', 02:55:16 INFO - 'ts_paint', 02:55:16 INFO - 'tpaint', 02:55:16 INFO - 'sessionrestore', 02:55:16 INFO - 'sessionrestore_no_auto_restore', 02:55:16 INFO - 'tabpaint']}, 02:55:16 INFO - 'svgr': {'tests': ['tsvgx', 02:55:16 INFO - 'tsvgr_opacity', 02:55:16 INFO - 'tart', 02:55:16 INFO - 'tscrollx', 02:55:16 INFO - 'cart']}, 02:55:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:55:16 INFO - 'tests': ['tsvgx', 02:55:16 INFO - 'tsvgr_opacity', 02:55:16 INFO - 'tart', 02:55:16 INFO - 'tscrollx', 02:55:16 INFO - 'cart']}, 02:55:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:16 INFO - 'tests': ['tp5o']}, 02:55:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:16 INFO - 'talos_options': ['--e10s'], 02:55:16 INFO - 'tests': ['tp5o']}, 02:55:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:16 INFO - 'talos_options': ['--xperf_path', 02:55:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:16 INFO - 'tests': ['tp5n']}, 02:55:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:16 INFO - 'talos_options': ['--e10s', 02:55:16 INFO - '--xperf_path', 02:55:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:16 INFO - 'tests': ['tp5n']}}, 02:55:16 INFO - 'talos.zip': {'path': '', 02:55:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:55:16 INFO - Running post-action listener: _resource_record_post_action 02:55:16 INFO - ##### 02:55:16 INFO - ##### Running create-virtualenv step. 02:55:16 INFO - ##### 02:55:16 INFO - Running pre-action listener: _resource_record_pre_action 02:55:16 INFO - Running main action method: create_virtualenv 02:55:16 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:16 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 02:55:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:55:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:16 INFO - Using real prefix '/tools/python27' 02:55:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:55:20 INFO - Installing pip.................done. 02:55:20 INFO - Return code: 0 02:55:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:55:20 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')]} 02:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:20 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')]} 02:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:20 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 0x10c20aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39146ede0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, '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.Heefau8TxK/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.9UhqpPDdOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:20 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 02:55:20 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 02:55:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:55:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:20 INFO - 'HOME': '/Users/cltbld', 02:55:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:20 INFO - 'LOGNAME': 'cltbld', 02:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:20 INFO - 'MOZ_NO_REMOTE': '1', 02:55:20 INFO - 'NO_EM_RESTART': '1', 02:55:20 INFO - 'PAGER': '/bin/cat', 02:55:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:20 INFO - 'PWD': '/builds/slave/test', 02:55:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:20 INFO - 'SHELL': '/bin/bash', 02:55:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:55:20 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:55:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:20 INFO - 'USER': 'cltbld', 02:55:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:20 INFO - 'XPC_FLAGS': '0x0', 02:55:20 INFO - 'XPC_SERVICE_NAME': '0', 02:55:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:20 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 02:55:20 INFO - Cleaning up... 02:55:20 INFO - Return code: 0 02:55:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:55:20 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')]} 02:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:20 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')]} 02:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:20 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 0x10c20aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39146ede0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, '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.Heefau8TxK/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.9UhqpPDdOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:20 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 02:55:20 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 02:55:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:55:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:20 INFO - 'HOME': '/Users/cltbld', 02:55:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:20 INFO - 'LOGNAME': 'cltbld', 02:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:20 INFO - 'MOZ_NO_REMOTE': '1', 02:55:20 INFO - 'NO_EM_RESTART': '1', 02:55:20 INFO - 'PAGER': '/bin/cat', 02:55:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:20 INFO - 'PWD': '/builds/slave/test', 02:55:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:20 INFO - 'SHELL': '/bin/bash', 02:55:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:55:20 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:55:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:20 INFO - 'USER': 'cltbld', 02:55:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:20 INFO - 'XPC_FLAGS': '0x0', 02:55:20 INFO - 'XPC_SERVICE_NAME': '0', 02:55:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:21 INFO - Downloading/unpacking psutil>=0.7.1 02:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:55:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:23 INFO - Installing collected packages: psutil 02:55:23 INFO - Running setup.py install for psutil 02:55:23 INFO - building 'psutil._psutil_osx' extension 02:55:23 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 02:55:24 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 02:55:24 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 02:55:24 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 02:55:24 INFO - building 'psutil._psutil_posix' extension 02:55:24 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 02:55:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:55:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:55:24 INFO - ^ 02:55:24 INFO - 1 warning generated. 02:55:24 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 02:55:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:25 INFO - Successfully installed psutil 02:55:25 INFO - Cleaning up... 02:55:25 INFO - Return code: 0 02:55:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:25 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 0x10c20aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39146ede0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, '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.Heefau8TxK/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.9UhqpPDdOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:25 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 02:55:25 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 02:55:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:55:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:25 INFO - 'HOME': '/Users/cltbld', 02:55:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:25 INFO - 'LOGNAME': 'cltbld', 02:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:25 INFO - 'MOZ_NO_REMOTE': '1', 02:55:25 INFO - 'NO_EM_RESTART': '1', 02:55:25 INFO - 'PAGER': '/bin/cat', 02:55:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:25 INFO - 'PWD': '/builds/slave/test', 02:55:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:25 INFO - 'SHELL': '/bin/bash', 02:55:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:55:25 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:55:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:25 INFO - 'USER': 'cltbld', 02:55:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:25 INFO - 'XPC_FLAGS': '0x0', 02:55:25 INFO - 'XPC_SERVICE_NAME': '0', 02:55:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:55:25 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 02:55:25 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 02:55:25 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 02:55:25 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 02:55:25 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 02:55:25 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 02:55:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:55:27 INFO - Installing collected packages: mozsystemmonitor 02:55:27 INFO - Running setup.py install for mozsystemmonitor 02:55:27 INFO - Successfully installed mozsystemmonitor 02:55:27 INFO - Cleaning up... 02:55:28 INFO - Return code: 0 02:55:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c20aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39146ede0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, '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.Heefau8TxK/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.9UhqpPDdOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:55:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:55:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:28 INFO - 'HOME': '/Users/cltbld', 02:55:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:28 INFO - 'LOGNAME': 'cltbld', 02:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:28 INFO - 'MOZ_NO_REMOTE': '1', 02:55:28 INFO - 'NO_EM_RESTART': '1', 02:55:28 INFO - 'PAGER': '/bin/cat', 02:55:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:28 INFO - 'PWD': '/builds/slave/test', 02:55:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:28 INFO - 'SHELL': '/bin/bash', 02:55:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:55:28 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:55:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:28 INFO - 'USER': 'cltbld', 02:55:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:28 INFO - 'XPC_FLAGS': '0x0', 02:55:28 INFO - 'XPC_SERVICE_NAME': '0', 02:55:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:55:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:55:30 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 02:55:30 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 02:55:30 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 02:55:30 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 02:55:30 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 02:55:30 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 02:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:55:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:55:31 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 02:55:31 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 02:55:31 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 02:55:31 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 02:55:31 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 02:55:31 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 02:55:31 INFO - Downloading docopt-0.6.1.tar.gz 02:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:55:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:55:31 INFO - Running setup.py install for blobuploader 02:55:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:55:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:55:32 INFO - Running setup.py install for requests 02:55:32 INFO - Running setup.py install for docopt 02:55:32 INFO - Successfully installed blobuploader requests docopt 02:55:32 INFO - Cleaning up... 02:55:32 INFO - Return code: 0 02:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:32 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')]} 02:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:32 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')]} 02:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:32 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 0x10c20aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39146ede0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, '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.Heefau8TxK/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.9UhqpPDdOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:32 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 02:55:32 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 02:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:32 INFO - 'HOME': '/Users/cltbld', 02:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:32 INFO - 'LOGNAME': 'cltbld', 02:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:32 INFO - 'MOZ_NO_REMOTE': '1', 02:55:32 INFO - 'NO_EM_RESTART': '1', 02:55:32 INFO - 'PAGER': '/bin/cat', 02:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:32 INFO - 'PWD': '/builds/slave/test', 02:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:32 INFO - 'SHELL': '/bin/bash', 02:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:55:32 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:32 INFO - 'USER': 'cltbld', 02:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:32 INFO - 'XPC_FLAGS': '0x0', 02:55:32 INFO - 'XPC_SERVICE_NAME': '0', 02:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-WGcKRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-lX9bM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qe8VQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-CnWwkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Utk2sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-wcC4lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-DXa_K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Uth5Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-YG0N4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:33 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-siC3CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-MpLYfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-NsRULC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-1uNtd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-rWgxaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-hR3nP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-QXcDTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-jnmlD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:55:34 INFO - Running setup.py install for manifestparser 02:55:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:55:34 INFO - Running setup.py install for mozcrash 02:55:35 INFO - Running setup.py install for mozdebug 02:55:35 INFO - Running setup.py install for mozdevice 02:55:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:55:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:55:35 INFO - Running setup.py install for mozfile 02:55:35 INFO - Running setup.py install for mozhttpd 02:55:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:55:35 INFO - Running setup.py install for mozinfo 02:55:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:55:35 INFO - Running setup.py install for mozInstall 02:55:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:55:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:55:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:55:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:55:35 INFO - Running setup.py install for mozleak 02:55:36 INFO - Running setup.py install for mozlog 02:55:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:55:36 INFO - Running setup.py install for moznetwork 02:55:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:55:36 INFO - Running setup.py install for mozprocess 02:55:36 INFO - Running setup.py install for mozprofile 02:55:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:55:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:55:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:55:36 INFO - Running setup.py install for mozrunner 02:55:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:55:36 INFO - Running setup.py install for mozscreenshot 02:55:37 INFO - Running setup.py install for moztest 02:55:37 INFO - Running setup.py install for mozversion 02:55:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:55:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:55:37 INFO - Cleaning up... 02:55:37 INFO - Return code: 0 02:55:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:37 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 0x10c20aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39146ede0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, '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.Heefau8TxK/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.9UhqpPDdOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:37 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 02:55:37 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 02:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:37 INFO - 'HOME': '/Users/cltbld', 02:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:37 INFO - 'LOGNAME': 'cltbld', 02:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:37 INFO - 'MOZ_NO_REMOTE': '1', 02:55:37 INFO - 'NO_EM_RESTART': '1', 02:55:37 INFO - 'PAGER': '/bin/cat', 02:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:37 INFO - 'PWD': '/builds/slave/test', 02:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:37 INFO - 'SHELL': '/bin/bash', 02:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:55:37 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:37 INFO - 'USER': 'cltbld', 02:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:37 INFO - 'XPC_FLAGS': '0x0', 02:55:37 INFO - 'XPC_SERVICE_NAME': '0', 02:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:37 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-U1tX_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:37 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)) 02:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:37 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Ub5whG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:37 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)) 02:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:37 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-I28NjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:37 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)) 02:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:37 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-AetF_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mgaYqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-bMMzlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-E8eyRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-0OcnP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-BRzbY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-KyE52E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-7tFX51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-4hkjQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qfI_PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:38 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)) 02:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-CmJhut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:39 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)) 02:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mquTOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:39 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)) 02:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-JOZvKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:39 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)) 02:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-lKwxD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:39 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)) 02:55:39 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)) 02:55:39 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)) 02:55:39 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)) 02:55:39 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)) 02:55:39 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)) 02:55:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:55:39 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 02:55:39 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 02:55:39 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 02:55:39 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 02:55:39 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 02:55:39 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 02:55:41 INFO - Downloading blessings-1.6.tar.gz 02:55:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:55:41 INFO - Installing collected packages: blessings 02:55:41 INFO - Running setup.py install for blessings 02:55:42 INFO - Successfully installed blessings 02:55:42 INFO - Cleaning up... 02:55:42 INFO - Return code: 0 02:55:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:55:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:55:42 INFO - Reading from file tmpfile_stdout 02:55:42 INFO - Current package versions: 02:55:42 INFO - blessings == 1.6 02:55:42 INFO - blobuploader == 1.2.4 02:55:42 INFO - docopt == 0.6.1 02:55:42 INFO - manifestparser == 1.1 02:55:42 INFO - mozInstall == 1.12 02:55:42 INFO - mozcrash == 0.17 02:55:42 INFO - mozdebug == 0.1 02:55:42 INFO - mozdevice == 0.48 02:55:42 INFO - mozfile == 1.2 02:55:42 INFO - mozhttpd == 0.7 02:55:42 INFO - mozinfo == 0.9 02:55:42 INFO - mozleak == 0.1 02:55:42 INFO - mozlog == 3.1 02:55:42 INFO - moznetwork == 0.27 02:55:42 INFO - mozprocess == 0.22 02:55:42 INFO - mozprofile == 0.28 02:55:42 INFO - mozrunner == 6.11 02:55:42 INFO - mozscreenshot == 0.1 02:55:42 INFO - mozsystemmonitor == 0.0 02:55:42 INFO - moztest == 0.7 02:55:42 INFO - mozversion == 1.4 02:55:42 INFO - psutil == 3.1.1 02:55:42 INFO - requests == 1.2.3 02:55:42 INFO - wsgiref == 0.1.2 02:55:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:42 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 0x10c20aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39146ede0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, '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.Heefau8TxK/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.9UhqpPDdOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:42 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 02:55:42 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 02:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:42 INFO - 'HOME': '/Users/cltbld', 02:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:42 INFO - 'LOGNAME': 'cltbld', 02:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:42 INFO - 'MOZ_NO_REMOTE': '1', 02:55:42 INFO - 'NO_EM_RESTART': '1', 02:55:42 INFO - 'PAGER': '/bin/cat', 02:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:42 INFO - 'PWD': '/builds/slave/test', 02:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:42 INFO - 'SHELL': '/bin/bash', 02:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:55:42 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:42 INFO - 'USER': 'cltbld', 02:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:42 INFO - 'XPC_FLAGS': '0x0', 02:55:42 INFO - 'XPC_SERVICE_NAME': '0', 02:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:42 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)) 02:55:42 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)) 02:55:42 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)) 02:55:42 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)) 02:55:42 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)) 02:55:42 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)) 02:55:42 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)) 02:55:42 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)) 02:55:42 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)) 02:55:42 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)) 02:55:42 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)) 02:55:42 INFO - Cleaning up... 02:55:42 INFO - Return code: 0 02:55:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c20aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39146ede0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, '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.Heefau8TxK/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.9UhqpPDdOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:42 INFO - 'HOME': '/Users/cltbld', 02:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:42 INFO - 'LOGNAME': 'cltbld', 02:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:42 INFO - 'MOZ_NO_REMOTE': '1', 02:55:42 INFO - 'NO_EM_RESTART': '1', 02:55:42 INFO - 'PAGER': '/bin/cat', 02:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:42 INFO - 'PWD': '/builds/slave/test', 02:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:42 INFO - 'SHELL': '/bin/bash', 02:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:55:42 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:42 INFO - 'USER': 'cltbld', 02:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:42 INFO - 'XPC_FLAGS': '0x0', 02:55:42 INFO - 'XPC_SERVICE_NAME': '0', 02:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:42 INFO - Downloading/unpacking jsonschema 02:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:55:45 INFO - Downloading/unpacking functools32 (from jsonschema) 02:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:45 INFO - Downloading functools32-3.2.3-2.tar.gz 02:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:55:45 INFO - warning: no files found matching '*.txt' 02:55:45 INFO - no previously-included directories found matching 'build' 02:55:45 INFO - no previously-included directories found matching 'dist' 02:55:45 INFO - no previously-included directories found matching '.git*' 02:55:45 INFO - Installing collected packages: jsonschema, functools32 02:55:45 INFO - Running setup.py install for functools32 02:55:46 INFO - warning: no files found matching '*.txt' 02:55:46 INFO - no previously-included directories found matching 'build' 02:55:46 INFO - no previously-included directories found matching 'dist' 02:55:46 INFO - no previously-included directories found matching '.git*' 02:55:46 INFO - Successfully installed jsonschema functools32 02:55:46 INFO - Cleaning up... 02:55:46 INFO - Return code: 0 02:55:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c20aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2114c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39146ede0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, '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.Heefau8TxK/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.9UhqpPDdOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:46 INFO - 'HOME': '/Users/cltbld', 02:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:46 INFO - 'LOGNAME': 'cltbld', 02:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:46 INFO - 'MOZ_NO_REMOTE': '1', 02:55:46 INFO - 'NO_EM_RESTART': '1', 02:55:46 INFO - 'PAGER': '/bin/cat', 02:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:46 INFO - 'PWD': '/builds/slave/test', 02:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:46 INFO - 'SHELL': '/bin/bash', 02:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:55:46 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:46 INFO - 'USER': 'cltbld', 02:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:46 INFO - 'XPC_FLAGS': '0x0', 02:55:46 INFO - 'XPC_SERVICE_NAME': '0', 02:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:46 INFO - Downloading/unpacking flake8 02:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:55:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:55:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:55:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:55:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:55:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:55:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:55:50 INFO - no previously-included directories found matching 'docs/_build' 02:55:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:55:50 INFO - Running setup.py install for pep8 02:55:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:55:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:55:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:55:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:55:50 INFO - no previously-included directories found matching 'docs/_build' 02:55:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:55:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:55:50 INFO - Cleaning up... 02:55:50 INFO - Return code: 0 02:55:50 INFO - Running post-action listener: _resource_record_post_action 02:55:50 INFO - Running post-action listener: _start_resource_monitoring 02:55:50 INFO - Starting resource monitoring. 02:55:50 INFO - ##### 02:55:50 INFO - ##### Running install step. 02:55:50 INFO - ##### 02:55:50 INFO - Running pre-action listener: _resource_record_pre_action 02:55:50 INFO - Running main action method: install 02:55:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:55:50 INFO - Reading from file tmpfile_stdout 02:55:50 INFO - Detecting whether we're running mozinstall >=1.0... 02:55:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:55:50 INFO - Reading from file tmpfile_stdout 02:55:50 INFO - Output received: 02:55:50 INFO - Usage: mozinstall [options] installer 02:55:50 INFO - Options: 02:55:50 INFO - -h, --help show this help message and exit 02:55:50 INFO - -d DEST, --destination=DEST 02:55:50 INFO - Directory to install application into. [default: 02:55:50 INFO - "/builds/slave/test"] 02:55:50 INFO - --app=APP Application being installed. [default: firefox] 02:55:50 INFO - mkdir: /builds/slave/test/build/application 02:55:50 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'] 02:55:50 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 02:56:23 INFO - Reading from file tmpfile_stdout 02:56:23 INFO - Output received: 02:56:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:56:23 INFO - Running post-action listener: _resource_record_post_action 02:56:23 INFO - ##### 02:56:23 INFO - ##### Running run-tests step. 02:56:23 INFO - ##### 02:56:23 INFO - Running pre-action listener: _resource_record_pre_action 02:56:23 INFO - Running main action method: run_tests 02:56:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:56:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:56:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:56:23 INFO - 2016-03-28 02:56:23.352 screenresolution[1650:9552] starting screenresolution argv=screenresolution get 02:56:23 INFO - 2016-03-28 02:56:23.355 screenresolution[1650:9552] Display 0: 1600x1200x32@60 02:56:23 INFO - 2016-03-28 02:56:23.360 screenresolution[1651:9555] starting screenresolution argv=screenresolution list 02:56:23 INFO - Available Modes on Display 0 02:56:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:56:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:56:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:56:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:56:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:56:23 INFO - Intel Iris: 02:56:23 INFO - Chipset Model: Intel Iris 02:56:23 INFO - Type: GPU 02:56:23 INFO - Bus: Built-In 02:56:23 INFO - VRAM (Dynamic, Max): 1536 MB 02:56:23 INFO - Vendor: Intel (0x8086) 02:56:23 INFO - Device ID: 0x0a2e 02:56:23 INFO - Revision ID: 0x0009 02:56:23 INFO - Displays: 02:56:23 INFO - Display: 02:56:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:56:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:56:23 INFO - Display Serial Number: 1600x1200 60 02:56:23 INFO - Main Display: Yes 02:56:23 INFO - Mirror: Off 02:56:23 INFO - Online: Yes 02:56:23 INFO - Rotation: Supported 02:56:23 INFO - Return code: 0 02:56:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:23 INFO - Python 2.7.3 02:56:23 INFO - Return code: 0 02:56:23 INFO - grabbing minidump binary from tooltool 02:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:23 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 0x10c0aed30>, '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 0x10bf12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:23 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 02:56:23 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 02:56:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:23 INFO - Return code: 0 02:56:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:56:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:56:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:56:24 INFO - Return code: 0 02:56:24 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/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:56:24 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/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:56:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Heefau8TxK/Render', 02:56:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:24 INFO - 'HOME': '/Users/cltbld', 02:56:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:24 INFO - 'LOGNAME': 'cltbld', 02:56:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:24 INFO - 'MOZ_NO_REMOTE': '1', 02:56:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:24 INFO - 'NO_EM_RESTART': '1', 02:56:24 INFO - 'PAGER': '/bin/cat', 02:56:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:24 INFO - 'PWD': '/builds/slave/test', 02:56:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:24 INFO - 'SHELL': '/bin/bash', 02:56:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9UhqpPDdOm/Listeners', 02:56:24 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 02:56:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:24 INFO - 'USER': 'cltbld', 02:56:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:24 INFO - 'XPC_FLAGS': '0x0', 02:56:24 INFO - 'XPC_SERVICE_NAME': '0', 02:56:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:24 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/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:56:25 INFO - mozversion application_buildid: 20160328004018 02:56:25 INFO - mozversion application_changeset: 5629a22932f74f3e2d647c3462c32191a791afed 02:56:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:56:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:25 INFO - mozversion application_name: Firefox 02:56:25 INFO - mozversion application_remotingname: firefox-dev 02:56:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:56:25 INFO - mozversion application_vendor: Mozilla 02:56:25 INFO - mozversion application_version: 47.0a2 02:56:25 INFO - mozversion platform_buildid: 20160328004018 02:56:25 INFO - mozversion platform_changeset: 5629a22932f74f3e2d647c3462c32191a791afed 02:56:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:56:25 INFO - mozversion platform_version: 47.0a2 02:56:25 INFO - using testdate: 1459158985 02:56:25 INFO - actual date: 1459158985 02:56:25 INFO - starting webserver on 'localhost:49273' 02:56:25 INFO - SUITE-START | Running 2 tests 02:56:25 INFO - TEST-START | dromaeo_css 02:56:25 INFO - operating with platform_type : mac_ 02:56:25 INFO - Initialising browser for dromaeo_css test... 02:56:25 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmplBRCmc/profile http://localhost:49273/getInfo.html) 02:56:27 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 02:56:27 INFO - PROCESS | 1669 | colorDepth:24 02:56:27 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 02:56:27 INFO - PROCESS | 1669 | __metrics 02:56:27 INFO - PROCESS | 1669 | 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" 02:56:27 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:56:28 INFO - TEST-INFO | 1669: exit 0 02:56:28 INFO - Browser initialized. 02:56:28 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:28 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmplBRCmc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:40 INFO - PROCESS | 1673 | RSS: Main: 210698240 02:56:40 INFO - PROCESS | 1673 | 02:57:31 INFO - PROCESS | 1673 | 1459159051509 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] 02:59:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 02:59:42 INFO - PROCESS | 1673 | RSS: Main: 324747264 02:59:42 INFO - PROCESS | 1673 | 03:02:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 03:02:45 INFO - PROCESS | 1673 | RSS: Main: 344645632 03:02:45 INFO - PROCESS | 1673 | 03:05:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 03:05:48 INFO - PROCESS | 1673 | RSS: Main: 344494080 03:05:48 INFO - PROCESS | 1673 | 03:08:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 03:08:51 INFO - PROCESS | 1673 | RSS: Main: 304582656 03:08:51 INFO - PROCESS | 1673 | 03:11:54 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 03:11:54 INFO - PROCESS | 1673 | RSS: Main: 308006912 03:11:54 INFO - PROCESS | 1673 | 03:14:57 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 03:14:57 INFO - PROCESS | 1673 | RSS: Main: 351256576 03:14:57 INFO - PROCESS | 1673 | 03:14:57 INFO - PROCESS | 1673 | __start_tp_report 03:14:57 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 03:14:57 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 03:14:57 INFO - PROCESS | 1673 | |i|pagename|runs| 03:14:57 INFO - PROCESS | 1673 | |0;dojo.html;3437.1578963154025;3493.9650603493974;3534.4874993126014;3536.8054756988363;3574.6782789548934;5680.517156041731;5692.288463942007;5698.943010569898;5707.429257074291;5708.1152421374645;5690;5728.083506638938;5735.971320143404;5743.195952566644;5746.913796293059;5136.974315128437;5160.767765450545;5198.324217851674;5232.502912223333;5235.607329450288;5259.474052594748;5263.368395792491;5267.3942496613;5270.736463176845;5276.630635855492;5185.559227465651;5224.582033437316;5233.528982391584;5242.213667949819;5273.103572392683;5229.058769421503;5274.5780337572905;5277.86805329866;5287.550558202519;5320.6275560710765;4379.299312110079;4783.784729687172;4841.104395686809;5222.268882356473;5229.08491014071;5548.6393384430285;5602.13166959122;5633;5633.295838020247;5642.943570564283;6094.116353128816;6194.318624951252;6263.217097862767;6270.561060725751;6279.623222606612;5246;5600.6079574429805;6174.25908890936;6248.718807653667;6291.245050593912;5762.394948530386;5767.480926716574;5772.134179872969;5772.913406298951;5776.595638305278;6159.84600384994;6190.721417536221;6238.937610623926;6266.279377871512;6277.5605707600025;6172.567920245539;6205.28639206488;6227.408396202353;6232.8130156095385;6233.875322493524;6255.030470277115;6281.8743625127245;6290.056491526216;6290.433860952537;6306.463950564162;5172.301739265226;6024.909626355608;6169.5064394848305;6170.352113028157;6232.8130156095385;6244.531660125509;6261.467775239064;6282.4974002079725;6291.6854157291955;6312.747490100344;4926.802927882844;4931.112399768004;4932.210846264652;4937.654364194472;4944.406671199479;4345.891352716144;4377.890552736143;4452.777361131931;4467.955320446819;4505.459344878635;5741.540676745851;5767.913481297784;5768.3366412862215;5783.190353350535;5790.305163380422;6265.154204182468;6271.560990730696;6274.403931626488;6297.464715499143;6303.621782693053;5614.073677843192;5689.743961521659;5720.48515633595;5745.712714364265;5764.5676574257095;5334.546563542142;5352.812651557177;5373.731313434391;5379.273798037215;5400.756965936543;6252.280987686383;6327.746890124344;6333.714982825784;6340.461060809883;6356.9364306357265;6153.84615384619;6206.627602343874;6254.4996400286955;6257.311695713377;6276.058591211355;5891.263592050994;6343.143675603735;6344.080108384351;6364.554481186273;6377.521685873486;6207.379262073937;6218.9378106218355;6223.315435302023;6233.2208473940755;6236.18929539157;5212.270282160424;6128.19758601264;6153.938460615515;6225.31521532622;6261.373862613702;6099.695015249308;6114.174586430775;6123.84690382744;6127.785527506516;6131.356207598138;4861.295112208781;5992.790252341147;6121.418465245794;6121.816345509642;6163.907541386793;5929;6017.518598512021;6020.367861374492;6022.187004754477;6033.54748393881;4941.629377796751;6028.788992385245;6042.1540984261355;6060.575759696779;6078;5898.734556945034;5937.9406205937385;5953.613015154001;5965.224520812267;5995.2206213192 03:14:57 INFO - PROCESS | 1673 | |1;ext.html;507.1201465457433;589.6462122726365;599.8590331272151;614.3856143856143;655.7934250711027;22374.776252237472;38667.61332386675;38821;38998.41502377463;39016.21967560647;42250.78874605631;42772.57227427725;42780.786096069554;42827.143457130915;42849.78575107128;9556.952215238915;9684.322097453181;9775.511224438786;9795.020497950183;9805.264605154607;9487.335886487948;9651.613935442574;9655.420674759502;9655.855162172573;9681.903180968206;9636.807263854755;9860.457674827881;9869.161121304662;9872.308938374317;9874.703758887244;9723.416595004286;9821.607135714563;9822.066903644178;9827.656032038843;9847.60609575616;9703.514824258758;9851.802963940752;9854.704358869245;9857.605695772161;9875.061869122423;41502;41939.7903010483;41941.370879436836;41987.37018944718;42006.949826254284;3092.1651154188244;3273.8199399033283;3288.490284005983;3788.7644902407774;3855.248226595815;28064;28385.290367740767;29162;29560;30319.69680303213;2777.805553611248;2788.3308006078596;2790.539560972437;2821;2846.1034774046316;484157.99999999645;487530;488990.99999999645;489348.553257235;494156;45472.77263613661;46488.07023859571;46743.29885051727;64357.712845742826;65036.674816625615;40120.799396003415;46542.767286163355;46837.82905427391;46850.53149468462;46969.35607253798;16893;17018.31926722942;17053.48839534791;17065.317387304618;17101.315947362215;13484.730305393838;13573.981951353491;13588.93205533966;13594;13606.59180224575;15184.772228416583;15249.085054896741;15265.847341526665;15318.004329718755;15332.693346133015;6680.799576012728;6815;6852.211995620468;6863.38229559342;6869.107016087976;958.990410095904;972.7762614598682;1042.9634962776267;1065.9680209593726;1138.538891748843;29847.70152298449;30183.547246791317;30610.92861749828;30698;30768.384632307676;1062.9043386095288;1067.9839802402971;1201.171191877619;1220.8840160184768;1254.956076537317;11787.587434439753;12677.809832852514;14013.719725605431;14988.47540336083;16123.67752644964;539828;547041;547326;547566;548089;43783.781081095025;61280.38719612836;61407.07889381663;61539;61569;1393.101449565025;1417.3976060174384;1527.0761189480204;1534.7851300817895;1654.3713388912136;24863.751362486142;28441.857790710914;30420.543691845083;30484.695153048186;31168.376632467676;47657.523424766696;47851.28223076587;48274.793130172024;48320;48435.27347089867;372070;374717.1264143662;375388;375576;375623;29796.255093622833;30321.696783031886;33813.81651642181;34843.65156348404;34881;35501;41761.791191045064;42279.57720422879;42398.36402453904;43565.34651980159;35034.474482883285;35584.7545335912;35585.93242202738;35778.463323050695;36621.816890915376;35661;35700.64299356973;36105;36235;36437.63562364342;36919.44620830743;36977.630223697415;37383.626163738016;37667.43498847465;38231.42652860265;26267.73732262653;31864.68135318617;32328.35343293168;32749;32770.83614581912;22880.542389152455;23599.0560377583;24702;25520.872395637904;25635.743642563335 03:14:57 INFO - PROCESS | 1673 | |2;jquery.html;378.65731512980744;383.3617027648966;386.5361566120656;387.7421514692729;390.45921398862566;20144.798552014476;20705.378838634846;20947.476313092182;21411;21430.678539821874;12075.456604452798;12458.003359731223;21811.890940545276;22174.88912555439;22180.445488862788;5312.495312945273;5447.373552041507;5482.479164479368;5504.779808807642;5505.807296744615;4149.896252593694;4336.761478118702;5835.095560188178;6091.177691011723;6095.359987201325;6001.579889407743;6070.939290607103;6073.331933487313;6086.056661217518;6088.512918966472;5920.348761636216;6029.849253768647;6079.635221886657;6088.238970128734;6089.847753806168;4022.979885100585;5510.862228444281;5747;5748.683822389767;5764.711764411804;13522.053456258065;13655.180689158582;13720.93139534306;13781.310934453237;14001.369938352798;2026.6149431607948;2157.266529380003;2195.9560808783735;2393.0786647140803;2762.668479782439;9851.458169800659;9963;10028.49857507129;10318.071373576415;10503.10723588496;1816.2190258188973;1825;1832.7159290310024;1845.2434501854175;1870.3640762140801;104320;109071.51856665267;109336.4533177329;109957.45021274843;112797.43601282022;11960.760784784256;11995.160338776202;12012.018017027267;12035.458404371824;12059.879401206052;14612.780808287884;14631.561053168421;14675;14712.779308310384;14746.483873064391;9133.725988220363;9198.494082825375;9200.81598368029;9208.585613647401;9300.581473833694;9400.200982916393;9403;9405.589161625674;9452.763680908032;9507.1918886894;4672.159011377985;4706.223473126965;4709.034647897173;4741.5495527924795;4810.735409552438;1733.1334332833583;1839.6136811269516;1841.1462233537964;1899.5725961658793;1906.36136894142;916.5142474488532;937.4000639590668;1027.085893554737;1079.6545105566142;1081.6863109698256;20172.956680988227;20568.971551422368;20804;20885;21008.684869726967;1000.4697510319543;1004.5429329655135;1008.5209525475487;1016.2581315639625;1045.5713157605346;9864.457454839909;11050.950159734812;11145.777084458265;11170.106391488662;11185.272957257752;645387;648442;660262;670217;671885;80859;112649;122751;124514;125858;1045.461587282535;1065.573770491794;1077.3374374759624;1078.735709751116;1079.5142186016324;14922.403103875724;17867.374641887473;17964;18317.633647327246;18324.26702931868;52473.7376313116;55127.173092404446;55911.72044139916;56802.431975681364;56934;78453.4309313822;78636;79709;82633.58683206546;84065;8125.634346454542;8240.66976596021;8313.750587482386;8359.247667709935;8386.580670966305;9048.457092574467;9516.238700903772;12727.299998500172;13650.726985460036;13725.931370343083;8694.739157825275;11439.428028598702;11799.35103569312;12013.219140755822;12114.091443141975;11365.772684546097;11431.256968297033;11610.361430121424;11829.231099978819;11945.581904633296;10923.344599324066;11097.778044439228;11737.119716021503;12171.939140304241;12256.448459819509;8139.430239883388;8192.75421737349;8330.750077497685;8459.06950235486;8545.87181192295;11826;11973.401329933642;12116.636500904988;12212.633620991384;12221.69445763863 03:14:57 INFO - PROCESS | 1673 | |3;mootools.html;1516.014590516165;1633.9346426142954;1663.3346661335465;2008.5681578460637;2087.8329733621304;8189.3857960652895;8743.25682317003;8898.199162075412;8900.732978010654;8908.420952638075;8602.61288242029;8824.117588241188;8839.77900552485;8850;8852.468851868893;2093.874367537945;2452.080469823816;2518.8866501007406;2530.3041663542535;2559.9488010239784;2554.6423500709916;2564.384547708546;2566.358410397401;2569.1393383216646;2570.3445621366527;2439.85360878347;2548.8215824892263;2550.961735573968;2552.374668206283;2555.092942005589;2238.507528343762;2453.411181316489;2507.360623041131;2507.849529028264;2556.169244995375;2502.5745623244093;2514.673092497982;2543.9109631163005;2549.8725063746924;2552.693676758782;8926.196642302224;8944.418612790148;9005.909940900572;9018.954905225432;9019.684311049148;4706.7646617669325;5582.91625625616;5625.959197548466;5629.521490673298;5635.464630860061;3627.782333060025;3726.087108658396;3782.9810850945846;3800.923981520354;3811.3901775715754;1053.8366553184192;1057.984130238047;1064.8562444070028;1078.1051727066595;1104.0229396983648;12350.258984460961;12361.62915112548;12368.319742414164;12372.81440778389;12379.195352302071;5010.5240002199735;5027.346444962204;5043.722595257223;5061.367329083864;5066.214736715815;10325;10341.741456463498;10344.586216551405;10352.896471035194;10370.740731481774;5629.155626655953;5638.323401191801;5638.943610563924;5644.379118296984;5658.236138121383;4202.726822756511;4526.547345265513;4710.26990816424;4923.310736496894;5067.467915868854;3979.6617287530307;3996.7402118862183;4042.0703238255364;4094.385842123705;4116.567760385176;1363.195714528433;1367.384676895381;1369.5480491437802;1369.8424681161594;1371.3211960079825;1125.611663975927;1146.9655910322704;1168.20562017827;1172.9589464368705;1209.6552482542434;8316.750497485085;8359.205875441945;8414.36892233085;8446.704365347307;8547.957260213783;1113.4210210690396;1148.311013391975;1160.4255893332854;1166.288563975974;1219.4024927785322;6369.458596019297;6388.1376014237485;6418.293987661354;6421.550491465552;6427.935720642734;10411.94794026025;10651.733706657396;10768.461576921123;10823.13414926804;10823.512941917632;10239.180865530889;10497.055265026183;10658.520366583522;10661.466926653637;10679.092277156373;8356.456830306131;8504.53225072627;8523.531205783618;8560.357973152039;8602.784930376665;8220.83558328842;8225.876611850706;8278.048024477263;8382.916170838214;8395.076541580544;9476.526173691425;9613.567389467351;9661.806763864824;9880.604775809175;9975.750606234902;9770.218382529238;10068.24488163376;10403.323783954018;10408.219383546415;10413.271071024956;6629.701663425061;7384.37232835215;7609.771706848804;7614.010178676736;7804.84390312202;8375.62309696053;8396.664133434595;8432.620532075949;8443.324534037385;8458;7310.926890731237;7386;7411.888821667571;7528.849423011399;7580.3556697681315;7368.889466657897;7375.778726638209;7381.889271660822;7457.7389791357045;7499.66251518672;7808.336291415066;7826.569538675428;7863.095743989285;7869.803254918673;7876.015498062742;7084.123972169529;7135.785926422215;7164.89252661221;7228.277172282729;7244.746433874789;7227.7831665050135;7254.202037775946;7286.96356518214;7299.452541059548;7304.5252058616015 03:14:57 INFO - PROCESS | 1673 | |4;prototype.html;329.69009131416465;333.6196735721277;340.020740268028;340.6100015482271;344.60542678632964;6524.739010439583;6573.83565410865;6585.374389433002;6594.274629790719;6663.63350015749;5857.355690874011;6496.74013039479;6511.4465270452065;6527.673616319189;6550.5742126761725;4323.762193079379;4619.422572178478;4739.0758802033615;4765.90468190636;4834.299026641135;3913.882583522499;4801.663883528155;4827.251775974712;4828.251620998733;4848.418189817226;4782.354382158416;4818.518148185189;4838.443578988408;4841.854744357657;4865.124277630025;4607.723536587799;4645.187092258858;4807.447143578498;4851.708897466164;4851.805927762885;4156.91686166278;4161.9375709364385;4164;4167.83328666853;4171.3325867860995;6260.248770147566;6273.62358258506;6278.183836101323;6278.686065696743;6281.937180628181;5652.491275785158;5663.377028526858;5666.744996475169;5667.886642267132;5668.319801623831;6764.729410823561;6923.169219693669;6945.583265004066;6954.269801670803;6983.82540436488;4646.558576935186;4670.206064968964;4675.625949923998;4689.695169813951;4702.929456058162;7280.199178090405;7344.706211751577;7347.1550771661405;7355.816104597375;7383.815404614874;4727.7399743013775;4734.4081989751285;4738.241881298975;4738.289256611467;4738.549837765407;4796.37647105874;4805.255185446262;4814.988852341047;4815.3258543803895;4826.638002149783;5684.204211410406;5684.886302274014;5685.204071430003;5710.229119068956;5710.800121995793;6774.525783195228;7027.945808128821;7054.435645148375;7070.964645176844;7071.681774320168;1650.6946214950271;1654.073718717522;1665.6668666266796;1670.5072003758678;1676.1786724505148;1011.3931641015479;1048.109107258824;1071.0200166847403;1074.8065348237392;1100.1308965916835;6300;6439.420452159328;6520.510961677893;6560.606363618198;6597.538172327891;6844.349786770249;7238.457115716343;7348.375388091965;7382.778516644509;7397.334239918433;5599.272094627754;6152.692365381713;6347.428731414195;6543.967280163569;6560;3830.3296923038356;3861.2856621525107;3864.7101467390057;3867.5165604299464;3876.030992251937;7551.622418879034;7616.0099187105325;7623.551525210192;7629.351505122016;7639.274268944441;6084.574079814459;7490.812729681802;7557.962210189024;7570.05374328209;7580.886286705704;7601.695932162652;7618.733344332922;7629.694812207449;7645.388368930472;7646.502977306569;7061.435085193069;7328;7331;7363.595002274927;7367.8158046049275;7119.679614417467;7203.675834587351;7225.674844631899;7236.986821845051;7261.38278246355;7627.122880868771;7637.159912409742;7638.465307428427;7649.082110146818;7663.27198916102;3820.522434695663;4570.702904311209;4615.653825962999;4619.191641462663;4625.861224163281;7004.299570042955;7260.818479538054;7277.126744790659;7282.890756638549;7290.890636640561;5625.296837895263;6930.306969303029;6995.370416662525;6996.650167491707;7013.333733295329;6105.603135796159;6631;7020.543664661781;7036.296370362923;7049.9647501762165;5916.26046744157;6479.740810367721;6848.315168483311;6866.896996544956;6869.278725733926;6829.146356705412;6971.825704357431;7001.404880585207;7012.614306213207;7063.5055546113335;6607.900881486878;6726.192856857013;6747.966260168668;6894.931050689429;6933.791986240421 03:14:57 INFO - PROCESS | 1673 | |5;yui.html;729.8941653460248;786.8190316227272;803.3803544208264;812.1796985045106;813.9186081391858;14624.26878656067;14841.257937103155;14864.925675371622;14897.329620167091;14914.850851491481;11440.427978601057;13506.662333441669;13587;13596.980226483003;13646.044776865598;793.4208028139461;812.7317985064944;972.65470757881;1001.8647482589867;1003.3127307794148;988.4563490080463;998.5905778630763;1000.0749306891097;1003.032074048543;1004.6584161385127;852.799592095857;1065.2915810985724;1069.844872493488;1069.9893001069968;1072.6031368393706;1040.5057597641135;1067.7277294289984;1068.5939343049592;1071;1071.0681706914957;794.7417089445953;795.459087820282;796.2515235678444;797.5135167547792;797.6889013284823;15416.768748468781;15487.845121548753;15500.457483988119;15501.689966200725;15505.379784808594;12580;12637.747245055047;12887.097903146783;13007.764262395152;13173.670658233525;10228.43743594102;10425.113865321457;11083.778324433466;11720.355380454072;11836.171467997243;3533.0990597397754;3550.751447398683;3564.590072141685;3631.891043268706;3769.246150769857;78379.80429437473;80118;90609.54695226482;91372.54313728455;92139.53930230373;9533.189678877234;9557;9754.561044753003;9764.658236961672;10478.580856765644;22053.448663783533;22121;22163.445913852283;22502.887485562795;22524.662130068064;7568.621568921642;7568.8486230276185;7636.236376362319;7647.273509016634;7662.4253181011645;4104.712670113123;4122.031322639177;4169.353750168729;4304.182205380967;4361.80371883266;3686.2627474505207;3720.925581488355;3734.085149138424;3739.3456145174487;3754.8685795997008;653.2487639214846;659.0162467881667;672.8788818012707;677.2313424263497;677.4005005570008;498.6110833549764;570.4466667332681;588.4644973074567;607.2864384348374;637.8761308142879;7851.685932562634;8065.153158918347;8133.739270413095;8170.060443049007;8173.264406203471;530.0406264660899;539.8434454008294;572.4790440698944;594.551113908996;612.2071916867667;3720.162963333228;3810.3141434541494;3883.2815929053218;3888.416737489399;3894.1432884765304;100332;101377.49311253396;103518.48240758899;104134;104451.4777426108;83592.74610880842;84047.5797621008;85291.29417411616;86083.13916860876;86428.70356944652;74782.13044673819;76320.23679763242;76663.23336766561;77358.61320693474;78478.6076069616;7634.847303053797;7676.692932282646;7786.143524212445;8477.95761021191;8532;48458.5154148454;50003.499964999886;50282.2457663128;50936.98126037385;51470.742646286526;70424.59150816852;71152.64423677849;71442;71771;72585;11111.666650000512;11150.832737509107;11425.885741142481;11571.247868888495;11721.413929303671;10234.488275586042;11952.521899123938;12047.759044818878;12174.817377739164;12620.684482887635;11151.163662725166;11386.373749443861;11593.710157246136;11648.242864213798;12191.268523888595;9331.86002209981;11508.340492731935;11726.88273117292;11727.589534366256;11849.466773995364;11196.832047519456;11216.847739255447;11423.314601123959;11613.593524226611;12307.876921230672;9598.32811703174;9652.855207171757;9672;10012.949935250568;10330.741731456774;9827.361221520578;9958.253131015348;9997.800043999225;10041.899581004096;10044.246681498771 03:14:57 INFO - PROCESS | 1673 | __end_tp_report 03:14:57 INFO - PROCESS | 1673 | __start_cc_report 03:14:57 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1088 03:14:57 INFO - PROCESS | 1673 | __end_cc_report 03:14:57 INFO - PROCESS | 1673 | __startTimestamp1459160097506__endTimestamp 03:14:57 INFO - PROCESS | 1673 | 03:14:57 INFO - PROCESS | 1673 | ------- Summary: start ------- 03:14:57 INFO - PROCESS | 1673 | Number of tests: 6 03:14:57 INFO - PROCESS | 1673 | 03:14:57 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5713.97 Median:5898.73 stddev:637.83 (10.8%) stddev-sans-first:614.27 03:14:57 INFO - PROCESS | 1673 | Values: 3437.2 3494.0 3534.5 3536.8 3574.7 5680.5 5692.3 5698.9 5707.4 5708.1 5690.0 5728.1 5736.0 5743.2 5746.9 5137.0 5160.8 5198.3 5232.5 5235.6 5259.5 5263.4 5267.4 5270.7 5276.6 5185.6 5224.6 5233.5 5242.2 5273.1 5229.1 5274.6 5277.9 5287.6 5320.6 4379.3 4783.8 4841.1 5222.3 5229.1 5548.6 5602.1 5633.0 5633.3 5642.9 6094.1 6194.3 6263.2 6270.6 6279.6 5246.0 5600.6 6174.3 6248.7 6291.2 5762.4 5767.5 5772.1 5772.9 5776.6 6159.8 6190.7 6238.9 6266.3 6277.6 6172.6 6205.3 6227.4 6232.8 6233.9 6255.0 6281.9 6290.1 6290.4 6306.5 5172.3 6024.9 6169.5 6170.4 6232.8 6244.5 6261.5 6282.5 6291.7 6312.7 4926.8 4931.1 4932.2 4937.7 4944.4 4345.9 4377.9 4452.8 4468.0 4505.5 5741.5 5767.9 5768.3 5783.2 5790.3 6265.2 6271.6 6274.4 6297.5 6303.6 5614.1 5689.7 5720.5 5745.7 5764.6 5334.5 5352.8 5373.7 5379.3 5400.8 6252.3 6327.7 6333.7 6340.5 6356.9 6153.8 6206.6 6254.5 6257.3 6276.1 5891.3 6343.1 6344.1 6364.6 6377.5 6207.4 6218.9 6223.3 6233.2 6236.2 5212.3 6128.2 6153.9 6225.3 6261.4 6099.7 6114.2 6123.8 6127.8 6131.4 4861.3 5992.8 6121.4 6121.8 6163.9 5929.0 6017.5 6020.4 6022.2 6033.5 4941.6 6028.8 6042.2 6060.6 6078.0 5898.7 5937.9 5953.6 5965.2 5995.2 03:14:57 INFO - PROCESS | 1673 | 03:14:57 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:60777.33 Median:206645.22 stddev:126458.80 (61.2%) stddev-sans-first:126732.59 03:14:57 INFO - PROCESS | 1673 | Values: 507.1 589.6 599.9 614.4 655.8 22374.8 38667.6 38821.0 38998.4 39016.2 42250.8 42772.6 42780.8 42827.1 42849.8 9557.0 9684.3 9775.5 9795.0 9805.3 9487.3 9651.6 9655.4 9655.9 9681.9 9636.8 9860.5 9869.2 9872.3 9874.7 9723.4 9821.6 9822.1 9827.7 9847.6 9703.5 9851.8 9854.7 9857.6 9875.1 41502.0 41939.8 41941.4 41987.4 42006.9 3092.2 3273.8 3288.5 3788.8 3855.2 28064.0 28385.3 29162.0 29560.0 30319.7 2777.8 2788.3 2790.5 2821.0 2846.1 484158.0 487530.0 488991.0 489348.6 494156.0 45472.8 46488.1 46743.3 64357.7 65036.7 40120.8 46542.8 46837.8 46850.5 46969.4 16893.0 17018.3 17053.5 17065.3 17101.3 13484.7 13574.0 13588.9 13594.0 13606.6 15184.8 15249.1 15265.8 15318.0 15332.7 6680.8 6815.0 6852.2 6863.4 6869.1 959.0 972.8 1043.0 1066.0 1138.5 29847.7 30183.5 30610.9 30698.0 30768.4 1062.9 1068.0 1201.2 1220.9 1255.0 11787.6 12677.8 14013.7 14988.5 16123.7 539828.0 547041.0 547326.0 547566.0 548089.0 43783.8 61280.4 61407.1 61539.0 61569.0 1393.1 1417.4 1527.1 1534.8 1654.4 24863.8 28441.9 30420.5 30484.7 31168.4 47657.5 47851.3 48274.8 48320.0 48435.3 372070.0 374717.1 375388.0 375576.0 375623.0 29796.3 30321.7 33813.8 34843.7 34881.0 35501.0 41761.8 42279.6 42398.4 43565.3 35034.5 35584.8 35585.9 35778.5 36621.8 35661.0 35700.6 36105.0 36235.0 36437.6 36919.4 36977.6 37383.6 37667.4 38231.4 26267.7 31864.7 32328.4 32749.0 32770.8 22880.5 23599.1 24702.0 25520.9 25635.7 03:14:57 INFO - PROCESS | 1673 | 03:14:57 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:35901.36 Median:20978.08 stddev:109140.55 (520.3%) stddev-sans-first:109414.12 03:14:57 INFO - PROCESS | 1673 | Values: 378.7 383.4 386.5 387.7 390.5 20144.8 20705.4 20947.5 21411.0 21430.7 12075.5 12458.0 21811.9 22174.9 22180.4 5312.5 5447.4 5482.5 5504.8 5505.8 4149.9 4336.8 5835.1 6091.2 6095.4 6001.6 6070.9 6073.3 6086.1 6088.5 5920.3 6029.8 6079.6 6088.2 6089.8 4023.0 5510.9 5747.0 5748.7 5764.7 13522.1 13655.2 13720.9 13781.3 14001.4 2026.6 2157.3 2196.0 2393.1 2762.7 9851.5 9963.0 10028.5 10318.1 10503.1 1816.2 1825.0 1832.7 1845.2 1870.4 104320.0 109071.5 109336.5 109957.5 112797.4 11960.8 11995.2 12012.0 12035.5 12059.9 14612.8 14631.6 14675.0 14712.8 14746.5 9133.7 9198.5 9200.8 9208.6 9300.6 9400.2 9403.0 9405.6 9452.8 9507.2 4672.2 4706.2 4709.0 4741.5 4810.7 1733.1 1839.6 1841.1 1899.6 1906.4 916.5 937.4 1027.1 1079.7 1081.7 20173.0 20569.0 20804.0 20885.0 21008.7 1000.5 1004.5 1008.5 1016.3 1045.6 9864.5 11051.0 11145.8 11170.1 11185.3 645387.0 648442.0 660262.0 670217.0 671885.0 80859.0 112649.0 122751.0 124514.0 125858.0 1045.5 1065.6 1077.3 1078.7 1079.5 14922.4 17867.4 17964.0 18317.6 18324.3 52473.7 55127.2 55911.7 56802.4 56934.0 78453.4 78636.0 79709.0 82633.6 84065.0 8125.6 8240.7 8313.8 8359.2 8386.6 9048.5 9516.2 12727.3 13650.7 13725.9 8694.7 11439.4 11799.4 12013.2 12114.1 11365.8 11431.3 11610.4 11829.2 11945.6 10923.3 11097.8 11737.1 12171.9 12256.4 8139.4 8192.8 8330.8 8459.1 8545.9 11826.0 11973.4 12116.6 12212.6 12221.7 03:14:57 INFO - PROCESS | 1673 | 03:14:57 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:6185.37 Median:5035.53 stddev:3244.54 (64.4%) stddev-sans-first:3234.66 03:14:57 INFO - PROCESS | 1673 | Values: 1516.0 1633.9 1663.3 2008.6 2087.8 8189.4 8743.3 8898.2 8900.7 8908.4 8602.6 8824.1 8839.8 8850.0 8852.5 2093.9 2452.1 2518.9 2530.3 2559.9 2554.6 2564.4 2566.4 2569.1 2570.3 2439.9 2548.8 2551.0 2552.4 2555.1 2238.5 2453.4 2507.4 2507.8 2556.2 2502.6 2514.7 2543.9 2549.9 2552.7 8926.2 8944.4 9005.9 9019.0 9019.7 4706.8 5582.9 5626.0 5629.5 5635.5 3627.8 3726.1 3783.0 3800.9 3811.4 1053.8 1058.0 1064.9 1078.1 1104.0 12350.3 12361.6 12368.3 12372.8 12379.2 5010.5 5027.3 5043.7 5061.4 5066.2 10325.0 10341.7 10344.6 10352.9 10370.7 5629.2 5638.3 5638.9 5644.4 5658.2 4202.7 4526.5 4710.3 4923.3 5067.5 3979.7 3996.7 4042.1 4094.4 4116.6 1363.2 1367.4 1369.5 1369.8 1371.3 1125.6 1147.0 1168.2 1173.0 1209.7 8316.8 8359.2 8414.4 8446.7 8548.0 1113.4 1148.3 1160.4 1166.3 1219.4 6369.5 6388.1 6418.3 6421.6 6427.9 10411.9 10651.7 10768.5 10823.1 10823.5 10239.2 10497.1 10658.5 10661.5 10679.1 8356.5 8504.5 8523.5 8560.4 8602.8 8220.8 8225.9 8278.0 8382.9 8395.1 9476.5 9613.6 9661.8 9880.6 9975.8 9770.2 10068.2 10403.3 10408.2 10413.3 6629.7 7384.4 7609.8 7614.0 7804.8 8375.6 8396.7 8432.6 8443.3 8458.0 7310.9 7386.0 7411.9 7528.8 7580.4 7368.9 7375.8 7381.9 7457.7 7499.7 7808.3 7826.6 7863.1 7869.8 7876.0 7084.1 7135.8 7164.9 7228.3 7244.7 7227.8 7254.2 7287.0 7299.5 7304.5 03:14:57 INFO - PROCESS | 1673 | 03:14:57 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5727.09 Median:6488.24 stddev:1824.69 (28.1%) stddev-sans-first:1784.28 03:14:57 INFO - PROCESS | 1673 | Values: 329.7 333.6 340.0 340.6 344.6 6524.7 6573.8 6585.4 6594.3 6663.6 5857.4 6496.7 6511.4 6527.7 6550.6 4323.8 4619.4 4739.1 4765.9 4834.3 3913.9 4801.7 4827.3 4828.3 4848.4 4782.4 4818.5 4838.4 4841.9 4865.1 4607.7 4645.2 4807.4 4851.7 4851.8 4156.9 4161.9 4164.0 4167.8 4171.3 6260.2 6273.6 6278.2 6278.7 6281.9 5652.5 5663.4 5666.7 5667.9 5668.3 6764.7 6923.2 6945.6 6954.3 6983.8 4646.6 4670.2 4675.6 4689.7 4702.9 7280.2 7344.7 7347.2 7355.8 7383.8 4727.7 4734.4 4738.2 4738.3 4738.5 4796.4 4805.3 4815.0 4815.3 4826.6 5684.2 5684.9 5685.2 5710.2 5710.8 6774.5 7027.9 7054.4 7071.0 7071.7 1650.7 1654.1 1665.7 1670.5 1676.2 1011.4 1048.1 1071.0 1074.8 1100.1 6300.0 6439.4 6520.5 6560.6 6597.5 6844.3 7238.5 7348.4 7382.8 7397.3 5599.3 6152.7 6347.4 6544.0 6560.0 3830.3 3861.3 3864.7 3867.5 3876.0 7551.6 7616.0 7623.6 7629.4 7639.3 6084.6 7490.8 7558.0 7570.1 7580.9 7601.7 7618.7 7629.7 7645.4 7646.5 7061.4 7328.0 7331.0 7363.6 7367.8 7119.7 7203.7 7225.7 7237.0 7261.4 7627.1 7637.2 7638.5 7649.1 7663.3 3820.5 4570.7 4615.7 4619.2 4625.9 7004.3 7260.8 7277.1 7282.9 7290.9 5625.3 6930.3 6995.4 6996.7 7013.3 6105.6 6631.0 7020.5 7036.3 7050.0 5916.3 6479.7 6848.3 6866.9 6869.3 6829.1 6971.8 7001.4 7012.6 7063.5 6607.9 6726.2 6748.0 6894.9 6933.8 03:14:57 INFO - PROCESS | 1673 | 03:14:57 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:19338.72 Median:3885.85 stddev:27973.06 (719.9%) stddev-sans-first:28016.64 03:14:57 INFO - PROCESS | 1673 | Values: 729.9 786.8 803.4 812.2 813.9 14624.3 14841.3 14864.9 14897.3 14914.9 11440.4 13506.7 13587.0 13597.0 13646.0 793.4 812.7 972.7 1001.9 1003.3 988.5 998.6 1000.1 1003.0 1004.7 852.8 1065.3 1069.8 1070.0 1072.6 1040.5 1067.7 1068.6 1071.0 1071.1 794.7 795.5 796.3 797.5 797.7 15416.8 15487.8 15500.5 15501.7 15505.4 12580.0 12637.7 12887.1 13007.8 13173.7 10228.4 10425.1 11083.8 11720.4 11836.2 3533.1 3550.8 3564.6 3631.9 3769.2 78379.8 80118.0 90609.5 91372.5 92139.5 9533.2 9557.0 9754.6 9764.7 10478.6 22053.4 22121.0 22163.4 22502.9 22524.7 7568.6 7568.8 7636.2 7647.3 7662.4 4104.7 4122.0 4169.4 4304.2 4361.8 3686.3 3720.9 3734.1 3739.3 3754.9 653.2 659.0 672.9 677.2 677.4 498.6 570.4 588.5 607.3 637.9 7851.7 8065.2 8133.7 8170.1 8173.3 530.0 539.8 572.5 594.6 612.2 3720.2 3810.3 3883.3 3888.4 3894.1 100332.0 101377.5 103518.5 104134.0 104451.5 83592.7 84047.6 85291.3 86083.1 86428.7 74782.1 76320.2 76663.2 77358.6 78478.6 7634.8 7676.7 7786.1 8478.0 8532.0 48458.5 50003.5 50282.2 50937.0 51470.7 70424.6 71152.6 71442.0 71771.0 72585.0 11111.7 11150.8 11425.9 11571.2 11721.4 10234.5 11952.5 12047.8 12174.8 12620.7 11151.2 11386.4 11593.7 11648.2 12191.3 9331.9 11508.3 11726.9 11727.6 11849.5 11196.8 11216.8 11423.3 11613.6 12307.9 9598.3 9652.9 9672.0 10012.9 10330.7 9827.4 9958.3 9997.8 10041.9 10044.2 03:14:57 INFO - PROCESS | 1673 | -------- Summary: end -------- 03:14:57 INFO - PROCESS | 1673 | 03:14:57 INFO - TEST-INFO | 1673: exit 0 03:14:57 INFO - TEST-OK | dromaeo_css | took 1112875ms 03:14:57 INFO - TEST-START | kraken 03:14:57 INFO - operating with platform_type : mac_ 03:14:57 INFO - Initialising browser for kraken test... 03:14:58 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpB0hyVX/profile http://localhost:49273/getInfo.html) 03:15:00 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 03:15:00 INFO - PROCESS | 1680 | colorDepth:24 03:15:00 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 03:15:00 INFO - PROCESS | 1680 | __metrics 03:15:00 INFO - PROCESS | 1680 | 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" 03:15:00 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:15:00 INFO - TEST-INFO | 1680: exit 0 03:15:00 INFO - Browser initialized. 03:15:00 INFO - Running cycle 1/1 for kraken test... 03:15:00 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpB0hyVX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:12 INFO - PROCESS | 1683 | RSS: Main: 210726912 03:15:12 INFO - PROCESS | 1683 | 03:15:15 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:16 INFO - PROCESS | 1683 | RSS: Main: 264867840 03:15:16 INFO - PROCESS | 1683 | 03:15:18 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 03:15:19 INFO - PROCESS | 1683 | RSS: Main: 275206144 03:15:19 INFO - PROCESS | 1683 | 03:15:22 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 03:15:22 INFO - PROCESS | 1683 | RSS: Main: 265736192 03:15:22 INFO - PROCESS | 1683 | 03:15:24 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 03:15:25 INFO - PROCESS | 1683 | RSS: Main: 268754944 03:15:25 INFO - PROCESS | 1683 | 03:15:27 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:28 INFO - PROCESS | 1683 | RSS: Main: 267628544 03:15:28 INFO - PROCESS | 1683 | 03:15:30 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:31 INFO - PROCESS | 1683 | RSS: Main: 268935168 03:15:31 INFO - PROCESS | 1683 | 03:15:34 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:34 INFO - PROCESS | 1683 | RSS: Main: 268042240 03:15:34 INFO - PROCESS | 1683 | 03:15:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 03:15:38 INFO - PROCESS | 1683 | RSS: Main: 269340672 03:15:38 INFO - PROCESS | 1683 | 03:15:39 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:15:40 INFO - PROCESS | 1683 | RSS: Main: 300822528 03:15:40 INFO - PROCESS | 1683 | 03:15:42 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:42 INFO - PROCESS | 1683 | RSS: Main: 301125632 03:15:42 INFO - PROCESS | 1683 | 03:15:44 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:45 INFO - PROCESS | 1683 | RSS: Main: 307355648 03:15:45 INFO - PROCESS | 1683 | 03:15:47 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:15:48 INFO - PROCESS | 1683 | RSS: Main: 309006336 03:15:48 INFO - PROCESS | 1683 | 03:15:50 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:15:51 INFO - PROCESS | 1683 | RSS: Main: 310611968 03:15:51 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 03:15:53 INFO - PROCESS | 1683 | RSS: Main: 370737152 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | __start_tp_report 03:15:53 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 03:15:53 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 03:15:53 INFO - PROCESS | 1683 | |i|pagename|runs| 03:15:53 INFO - PROCESS | 1683 | |0;ai-astar;111;110;109;109;111;115;169;111;109;110 03:15:53 INFO - PROCESS | 1683 | |1;audio-beat-detection;151;118;150;142;115;135;111;147;147;116 03:15:53 INFO - PROCESS | 1683 | |2;audio-dft;185;186;183;183;182;184;183;183;184;184 03:15:53 INFO - PROCESS | 1683 | |3;audio-fft;72;73;74;116;54;57;57;57;112;55 03:15:53 INFO - PROCESS | 1683 | |4;audio-oscillator;91;90;125;70;109;122;157;88;79;116 03:15:53 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;87;84;87;84;86;83;87;83;84;83 03:15:53 INFO - PROCESS | 1683 | |6;imaging-darkroom;92;104;148;123;92;92;92;93;92;92 03:15:53 INFO - PROCESS | 1683 | |7;imaging-desaturate;85;85;85;84;87;85;85;84;85;85 03:15:53 INFO - PROCESS | 1683 | |8;json-parse-financial;52;57;58;57;58;57;57;66;54;52 03:15:53 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;61;62;75;71;67;64;65;65;65;65 03:15:53 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;80;83;80;79;80;79;79;78;80;93 03:15:53 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;116;118;124;123;119;116;137;157;123;105 03:15:53 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;132;116;128;131;133;121;131;132;133;131 03:15:53 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;66;66;64;65;65;65;66;60;80;94 03:15:53 INFO - PROCESS | 1683 | __end_tp_report 03:15:53 INFO - PROCESS | 1683 | __start_cc_report 03:15:53 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1177 03:15:53 INFO - PROCESS | 1683 | __end_cc_report 03:15:53 INFO - PROCESS | 1683 | __startTimestamp1459160153482__endTimestamp 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | ------- Summary: start ------- 03:15:53 INFO - PROCESS | 1683 | Number of tests: 14 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:116.40 Median:111.00 stddev:18.57 (16.7%) stddev-sans-first:19.59 03:15:53 INFO - PROCESS | 1683 | Values: 111.0 110.0 109.0 109.0 111.0 115.0 169.0 111.0 109.0 110.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:144.50 stddev:16.37 (11.3%) stddev-sans-first:16.05 03:15:53 INFO - PROCESS | 1683 | Values: 151.0 118.0 150.0 142.0 115.0 135.0 111.0 147.0 147.0 116.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.16 (0.6%) stddev-sans-first:1.13 03:15:53 INFO - PROCESS | 1683 | Values: 185.0 186.0 183.0 183.0 182.0 184.0 183.0 183.0 184.0 184.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:72.70 Median:57.00 stddev:23.15 (40.6%) stddev-sans-first:24.55 03:15:53 INFO - PROCESS | 1683 | Values: 72.0 73.0 74.0 116.0 54.0 57.0 57.0 57.0 112.0 55.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:74.50 stddev:26.12 (35.1%) stddev-sans-first:27.23 03:15:53 INFO - PROCESS | 1683 | Values: 91.0 90.0 125.0 70.0 109.0 122.0 157.0 88.0 79.0 116.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:85.00 stddev:1.75 (2.1%) stddev-sans-first:1.67 03:15:53 INFO - PROCESS | 1683 | Values: 87.0 84.0 87.0 84.0 86.0 83.0 87.0 83.0 84.0 83.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:92.00 stddev:18.98 (20.6%) stddev-sans-first:19.78 03:15:53 INFO - PROCESS | 1683 | Values: 92.0 104.0 148.0 123.0 92.0 92.0 92.0 93.0 92.0 92.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 03:15:53 INFO - PROCESS | 1683 | Values: 85.0 85.0 85.0 84.0 87.0 85.0 85.0 84.0 85.0 85.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:3.97 (7.0%) stddev-sans-first:3.81 03:15:53 INFO - PROCESS | 1683 | Values: 52.0 57.0 58.0 57.0 58.0 57.0 57.0 66.0 54.0 52.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.00 stddev:4.16 (6.4%) stddev-sans-first:4.00 03:15:53 INFO - PROCESS | 1683 | Values: 61.0 62.0 75.0 71.0 67.0 64.0 65.0 65.0 65.0 65.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.00 stddev:4.38 (5.5%) stddev-sans-first:4.63 03:15:53 INFO - PROCESS | 1683 | Values: 80.0 83.0 80.0 79.0 80.0 79.0 79.0 78.0 80.0 93.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:123.00 stddev:14.18 (11.5%) stddev-sans-first:14.76 03:15:53 INFO - PROCESS | 1683 | Values: 116.0 118.0 124.0 123.0 119.0 116.0 137.0 157.0 123.0 105.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:128.80 Median:131.50 stddev:5.73 (4.4%) stddev-sans-first:5.96 03:15:53 INFO - PROCESS | 1683 | Values: 132.0 116.0 128.0 131.0 133.0 121.0 131.0 132.0 133.0 131.0 03:15:53 INFO - PROCESS | 1683 | 03:15:53 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:66.00 stddev:10.15 (15.4%) stddev-sans-first:10.70 03:15:53 INFO - PROCESS | 1683 | Values: 66.0 66.0 64.0 65.0 65.0 65.0 66.0 60.0 80.0 94.0 03:15:53 INFO - PROCESS | 1683 | -------- Summary: end -------- 03:15:53 INFO - PROCESS | 1683 | 03:15:54 INFO - TEST-INFO | 1683: exit 0 03:15:54 INFO - TEST-OK | kraken | took 56203ms 03:15:54 INFO - SUITE-END | took 1169s 03:15:54 INFO - Completed test suite (00:19:29) 03:15:54 INFO - javascript benchmark 03:15:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3437.1578963154025, 3493.9650603493974, 3534.4874993126014, 3536.8054756988363, 3574.6782789548934, 5680.517156041731, 5692.288463942007, 5698.943010569898, 5707.429257074291, 5708.1152421374645, 5690.0, 5728.083506638938, 5735.971320143404, 5743.195952566644, 5746.913796293059, 5136.974315128437, 5160.767765450545, 5198.324217851674, 5232.502912223333, 5235.607329450288, 5259.474052594748, 5263.368395792491, 5267.3942496613, 5270.736463176845, 5276.630635855492, 5185.559227465651, 5224.582033437316, 5233.528982391584, 5242.213667949819, 5273.103572392683, 5229.058769421503, 5274.5780337572905, 5277.86805329866, 5287.550558202519, 5320.6275560710765, 4379.299312110079, 4783.784729687172, 4841.104395686809, 5222.268882356473, 5229.08491014071, 5548.6393384430285, 5602.13166959122, 5633.0, 5633.295838020247, 5642.943570564283, 6094.116353128816, 6194.318624951252, 6263.217097862767, 6270.561060725751, 6279.623222606612, 5246.0, 5600.6079574429805, 6174.25908890936, 6248.718807653667, 6291.245050593912, 5762.394948530386, 5767.480926716574, 5772.134179872969, 5772.913406298951, 5776.595638305278, 6159.84600384994, 6190.721417536221, 6238.937610623926, 6266.279377871512, 6277.5605707600025, 6172.567920245539, 6205.28639206488, 6227.408396202353, 6232.8130156095385, 6233.875322493524, 6255.030470277115, 6281.8743625127245, 6290.056491526216, 6290.433860952537, 6306.463950564162, 5172.301739265226, 6024.909626355608, 6169.5064394848305, 6170.352113028157, 6232.8130156095385, 6244.531660125509, 6261.467775239064, 6282.4974002079725, 6291.6854157291955, 6312.747490100344, 4926.802927882844, 4931.112399768004, 4932.210846264652, 4937.654364194472, 4944.406671199479, 4345.891352716144, 4377.890552736143, 4452.777361131931, 4467.955320446819, 4505.459344878635, 5741.540676745851, 5767.913481297784, 5768.3366412862215, 5783.190353350535, 5790.305163380422, 6265.154204182468, 6271.560990730696, 6274.403931626488, 6297.464715499143, 6303.621782693053, 5614.073677843192, 5689.743961521659, 5720.48515633595, 5745.712714364265, 5764.5676574257095, 5334.546563542142, 5352.812651557177, 5373.731313434391, 5379.273798037215, 5400.756965936543, 6252.280987686383, 6327.746890124344, 6333.714982825784, 6340.461060809883, 6356.9364306357265, 6153.84615384619, 6206.627602343874, 6254.4996400286955, 6257.311695713377, 6276.058591211355, 5891.263592050994, 6343.143675603735, 6344.080108384351, 6364.554481186273, 6377.521685873486, 6207.379262073937, 6218.9378106218355, 6223.315435302023, 6233.2208473940755, 6236.18929539157, 5212.270282160424, 6128.19758601264, 6153.938460615515, 6225.31521532622, 6261.373862613702, 6099.695015249308, 6114.174586430775, 6123.84690382744, 6127.785527506516, 6131.356207598138, 4861.295112208781, 5992.790252341147, 6121.418465245794, 6121.816345509642, 6163.907541386793, 5929.0, 6017.518598512021, 6020.367861374492, 6022.187004754477, 6033.54748393881, 4941.629377796751, 6028.788992385245, 6042.1540984261355, 6060.575759696779, 6078.0, 5898.734556945034, 5937.9406205937385, 5953.613015154001, 5965.224520812267, 5995.2206213192], "unit": "score", "name": "dojo.html", "value": 5676.165196927323}, {"lowerIsBetter": false, "replicates": [507.1201465457433, 589.6462122726365, 599.8590331272151, 614.3856143856143, 655.7934250711027, 22374.776252237472, 38667.61332386675, 38821.0, 38998.41502377463, 39016.21967560647, 42250.78874605631, 42772.57227427725, 42780.786096069554, 42827.143457130915, 42849.78575107128, 9556.952215238915, 9684.322097453181, 9775.511224438786, 9795.020497950183, 9805.264605154607, 9487.335886487948, 9651.613935442574, 9655.420674759502, 9655.855162172573, 9681.903180968206, 9636.807263854755, 9860.457674827881, 9869.161121304662, 9872.308938374317, 9874.703758887244, 9723.416595004286, 9821.607135714563, 9822.066903644178, 9827.656032038843, 9847.60609575616, 9703.514824258758, 9851.802963940752, 9854.704358869245, 9857.605695772161, 9875.061869122423, 41502.0, 41939.7903010483, 41941.370879436836, 41987.37018944718, 42006.949826254284, 3092.1651154188244, 3273.8199399033283, 3288.490284005983, 3788.7644902407774, 3855.248226595815, 28064.0, 28385.290367740767, 29162.0, 29560.0, 30319.69680303213, 2777.805553611248, 2788.3308006078596, 2790.539560972437, 2821.0, 2846.1034774046316, 484157.99999999645, 487530.0, 488990.99999999645, 489348.553257235, 494156.0, 45472.77263613661, 46488.07023859571, 46743.29885051727, 64357.712845742826, 65036.674816625615, 40120.799396003415, 46542.767286163355, 46837.82905427391, 46850.53149468462, 46969.35607253798, 16893.0, 17018.31926722942, 17053.48839534791, 17065.317387304618, 17101.315947362215, 13484.730305393838, 13573.981951353491, 13588.93205533966, 13594.0, 13606.59180224575, 15184.772228416583, 15249.085054896741, 15265.847341526665, 15318.004329718755, 15332.693346133015, 6680.799576012728, 6815.0, 6852.211995620468, 6863.38229559342, 6869.107016087976, 958.990410095904, 972.7762614598682, 1042.9634962776267, 1065.9680209593726, 1138.538891748843, 29847.70152298449, 30183.547246791317, 30610.92861749828, 30698.0, 30768.384632307676, 1062.9043386095288, 1067.9839802402971, 1201.171191877619, 1220.8840160184768, 1254.956076537317, 11787.587434439753, 12677.809832852514, 14013.719725605431, 14988.47540336083, 16123.67752644964, 539828.0, 547041.0, 547326.0, 547566.0, 548089.0, 43783.781081095025, 61280.38719612836, 61407.07889381663, 61539.0, 61569.0, 1393.101449565025, 1417.3976060174384, 1527.0761189480204, 1534.7851300817895, 1654.3713388912136, 24863.751362486142, 28441.857790710914, 30420.543691845083, 30484.695153048186, 31168.376632467676, 47657.523424766696, 47851.28223076587, 48274.793130172024, 48320.0, 48435.27347089867, 372070.0, 374717.1264143662, 375388.0, 375576.0, 375623.0, 29796.255093622833, 30321.696783031886, 33813.81651642181, 34843.65156348404, 34881.0, 35501.0, 41761.791191045064, 42279.57720422879, 42398.36402453904, 43565.34651980159, 35034.474482883285, 35584.7545335912, 35585.93242202738, 35778.463323050695, 36621.816890915376, 35661.0, 35700.64299356973, 36105.0, 36235.0, 36437.63562364342, 36919.44620830743, 36977.630223697415, 37383.626163738016, 37667.43498847465, 38231.42652860265, 26267.73732262653, 31864.68135318617, 32328.35343293168, 32749.0, 32770.83614581912, 22880.542389152455, 23599.0560377583, 24702.0, 25520.872395637904, 25635.743642563335], "unit": "score", "name": "ext.html", "value": 19241.765813170114}, {"lowerIsBetter": false, "replicates": [378.65731512980744, 383.3617027648966, 386.5361566120656, 387.7421514692729, 390.45921398862566, 20144.798552014476, 20705.378838634846, 20947.476313092182, 21411.0, 21430.678539821874, 12075.456604452798, 12458.003359731223, 21811.890940545276, 22174.88912555439, 22180.445488862788, 5312.495312945273, 5447.373552041507, 5482.479164479368, 5504.779808807642, 5505.807296744615, 4149.896252593694, 4336.761478118702, 5835.095560188178, 6091.177691011723, 6095.359987201325, 6001.579889407743, 6070.939290607103, 6073.331933487313, 6086.056661217518, 6088.512918966472, 5920.348761636216, 6029.849253768647, 6079.635221886657, 6088.238970128734, 6089.847753806168, 4022.979885100585, 5510.862228444281, 5747.0, 5748.683822389767, 5764.711764411804, 13522.053456258065, 13655.180689158582, 13720.93139534306, 13781.310934453237, 14001.369938352798, 2026.6149431607948, 2157.266529380003, 2195.9560808783735, 2393.0786647140803, 2762.668479782439, 9851.458169800659, 9963.0, 10028.49857507129, 10318.071373576415, 10503.10723588496, 1816.2190258188973, 1825.0, 1832.7159290310024, 1845.2434501854175, 1870.3640762140801, 104320.0, 109071.51856665267, 109336.4533177329, 109957.45021274843, 112797.43601282022, 11960.760784784256, 11995.160338776202, 12012.018017027267, 12035.458404371824, 12059.879401206052, 14612.780808287884, 14631.561053168421, 14675.0, 14712.779308310384, 14746.483873064391, 9133.725988220363, 9198.494082825375, 9200.81598368029, 9208.585613647401, 9300.581473833694, 9400.200982916393, 9403.0, 9405.589161625674, 9452.763680908032, 9507.1918886894, 4672.159011377985, 4706.223473126965, 4709.034647897173, 4741.5495527924795, 4810.735409552438, 1733.1334332833583, 1839.6136811269516, 1841.1462233537964, 1899.5725961658793, 1906.36136894142, 916.5142474488532, 937.4000639590668, 1027.085893554737, 1079.6545105566142, 1081.6863109698256, 20172.956680988227, 20568.971551422368, 20804.0, 20885.0, 21008.684869726967, 1000.4697510319543, 1004.5429329655135, 1008.5209525475487, 1016.2581315639625, 1045.5713157605346, 9864.457454839909, 11050.950159734812, 11145.777084458265, 11170.106391488662, 11185.272957257752, 645387.0, 648442.0, 660262.0, 670217.0, 671885.0, 80859.0, 112649.0, 122751.0, 124514.0, 125858.0, 1045.461587282535, 1065.573770491794, 1077.3374374759624, 1078.735709751116, 1079.5142186016324, 14922.403103875724, 17867.374641887473, 17964.0, 18317.633647327246, 18324.26702931868, 52473.7376313116, 55127.173092404446, 55911.72044139916, 56802.431975681364, 56934.0, 78453.4309313822, 78636.0, 79709.0, 82633.58683206546, 84065.0, 8125.634346454542, 8240.66976596021, 8313.750587482386, 8359.247667709935, 8386.580670966305, 9048.457092574467, 9516.238700903772, 12727.299998500172, 13650.726985460036, 13725.931370343083, 8694.739157825275, 11439.428028598702, 11799.35103569312, 12013.219140755822, 12114.091443141975, 11365.772684546097, 11431.256968297033, 11610.361430121424, 11829.231099978819, 11945.581904633296, 10923.344599324066, 11097.778044439228, 11737.119716021503, 12171.939140304241, 12256.448459819509, 8139.430239883388, 8192.75421737349, 8330.750077497685, 8459.06950235486, 8545.87181192295, 11826.0, 11973.401329933642, 12116.636500904988, 12212.633620991384, 12221.69445763863], "unit": "score", "name": "jquery.html", "value": 9492.686156433047}, {"lowerIsBetter": false, "replicates": [1516.014590516165, 1633.9346426142954, 1663.3346661335465, 2008.5681578460637, 2087.8329733621304, 8189.3857960652895, 8743.25682317003, 8898.199162075412, 8900.732978010654, 8908.420952638075, 8602.61288242029, 8824.117588241188, 8839.77900552485, 8850.0, 8852.468851868893, 2093.874367537945, 2452.080469823816, 2518.8866501007406, 2530.3041663542535, 2559.9488010239784, 2554.6423500709916, 2564.384547708546, 2566.358410397401, 2569.1393383216646, 2570.3445621366527, 2439.85360878347, 2548.8215824892263, 2550.961735573968, 2552.374668206283, 2555.092942005589, 2238.507528343762, 2453.411181316489, 2507.360623041131, 2507.849529028264, 2556.169244995375, 2502.5745623244093, 2514.673092497982, 2543.9109631163005, 2549.8725063746924, 2552.693676758782, 8926.196642302224, 8944.418612790148, 9005.909940900572, 9018.954905225432, 9019.684311049148, 4706.7646617669325, 5582.91625625616, 5625.959197548466, 5629.521490673298, 5635.464630860061, 3627.782333060025, 3726.087108658396, 3782.9810850945846, 3800.923981520354, 3811.3901775715754, 1053.8366553184192, 1057.984130238047, 1064.8562444070028, 1078.1051727066595, 1104.0229396983648, 12350.258984460961, 12361.62915112548, 12368.319742414164, 12372.81440778389, 12379.195352302071, 5010.5240002199735, 5027.346444962204, 5043.722595257223, 5061.367329083864, 5066.214736715815, 10325.0, 10341.741456463498, 10344.586216551405, 10352.896471035194, 10370.740731481774, 5629.155626655953, 5638.323401191801, 5638.943610563924, 5644.379118296984, 5658.236138121383, 4202.726822756511, 4526.547345265513, 4710.26990816424, 4923.310736496894, 5067.467915868854, 3979.6617287530307, 3996.7402118862183, 4042.0703238255364, 4094.385842123705, 4116.567760385176, 1363.195714528433, 1367.384676895381, 1369.5480491437802, 1369.8424681161594, 1371.3211960079825, 1125.611663975927, 1146.9655910322704, 1168.20562017827, 1172.9589464368705, 1209.6552482542434, 8316.750497485085, 8359.205875441945, 8414.36892233085, 8446.704365347307, 8547.957260213783, 1113.4210210690396, 1148.311013391975, 1160.4255893332854, 1166.288563975974, 1219.4024927785322, 6369.458596019297, 6388.1376014237485, 6418.293987661354, 6421.550491465552, 6427.935720642734, 10411.94794026025, 10651.733706657396, 10768.461576921123, 10823.13414926804, 10823.512941917632, 10239.180865530889, 10497.055265026183, 10658.520366583522, 10661.466926653637, 10679.092277156373, 8356.456830306131, 8504.53225072627, 8523.531205783618, 8560.357973152039, 8602.784930376665, 8220.83558328842, 8225.876611850706, 8278.048024477263, 8382.916170838214, 8395.076541580544, 9476.526173691425, 9613.567389467351, 9661.806763864824, 9880.604775809175, 9975.750606234902, 9770.218382529238, 10068.24488163376, 10403.323783954018, 10408.219383546415, 10413.271071024956, 6629.701663425061, 7384.37232835215, 7609.771706848804, 7614.010178676736, 7804.84390312202, 8375.62309696053, 8396.664133434595, 8432.620532075949, 8443.324534037385, 8458.0, 7310.926890731237, 7386.0, 7411.888821667571, 7528.849423011399, 7580.3556697681315, 7368.889466657897, 7375.778726638209, 7381.889271660822, 7457.7389791357045, 7499.66251518672, 7808.336291415066, 7826.569538675428, 7863.095743989285, 7869.803254918673, 7876.015498062742, 7084.123972169529, 7135.785926422215, 7164.89252661221, 7228.277172282729, 7244.746433874789, 7227.7831665050135, 7254.202037775946, 7286.96356518214, 7299.452541059548, 7304.5252058616015], "unit": "score", "name": "mootools.html", "value": 5046.14244960651}, {"lowerIsBetter": false, "replicates": [329.69009131416465, 333.6196735721277, 340.020740268028, 340.6100015482271, 344.60542678632964, 6524.739010439583, 6573.83565410865, 6585.374389433002, 6594.274629790719, 6663.63350015749, 5857.355690874011, 6496.74013039479, 6511.4465270452065, 6527.673616319189, 6550.5742126761725, 4323.762193079379, 4619.422572178478, 4739.0758802033615, 4765.90468190636, 4834.299026641135, 3913.882583522499, 4801.663883528155, 4827.251775974712, 4828.251620998733, 4848.418189817226, 4782.354382158416, 4818.518148185189, 4838.443578988408, 4841.854744357657, 4865.124277630025, 4607.723536587799, 4645.187092258858, 4807.447143578498, 4851.708897466164, 4851.805927762885, 4156.91686166278, 4161.9375709364385, 4164.0, 4167.83328666853, 4171.3325867860995, 6260.248770147566, 6273.62358258506, 6278.183836101323, 6278.686065696743, 6281.937180628181, 5652.491275785158, 5663.377028526858, 5666.744996475169, 5667.886642267132, 5668.319801623831, 6764.729410823561, 6923.169219693669, 6945.583265004066, 6954.269801670803, 6983.82540436488, 4646.558576935186, 4670.206064968964, 4675.625949923998, 4689.695169813951, 4702.929456058162, 7280.199178090405, 7344.706211751577, 7347.1550771661405, 7355.816104597375, 7383.815404614874, 4727.7399743013775, 4734.4081989751285, 4738.241881298975, 4738.289256611467, 4738.549837765407, 4796.37647105874, 4805.255185446262, 4814.988852341047, 4815.3258543803895, 4826.638002149783, 5684.204211410406, 5684.886302274014, 5685.204071430003, 5710.229119068956, 5710.800121995793, 6774.525783195228, 7027.945808128821, 7054.435645148375, 7070.964645176844, 7071.681774320168, 1650.6946214950271, 1654.073718717522, 1665.6668666266796, 1670.5072003758678, 1676.1786724505148, 1011.3931641015479, 1048.109107258824, 1071.0200166847403, 1074.8065348237392, 1100.1308965916835, 6300.0, 6439.420452159328, 6520.510961677893, 6560.606363618198, 6597.538172327891, 6844.349786770249, 7238.457115716343, 7348.375388091965, 7382.778516644509, 7397.334239918433, 5599.272094627754, 6152.692365381713, 6347.428731414195, 6543.967280163569, 6560.0, 3830.3296923038356, 3861.2856621525107, 3864.7101467390057, 3867.5165604299464, 3876.030992251937, 7551.622418879034, 7616.0099187105325, 7623.551525210192, 7629.351505122016, 7639.274268944441, 6084.574079814459, 7490.812729681802, 7557.962210189024, 7570.05374328209, 7580.886286705704, 7601.695932162652, 7618.733344332922, 7629.694812207449, 7645.388368930472, 7646.502977306569, 7061.435085193069, 7328.0, 7331.0, 7363.595002274927, 7367.8158046049275, 7119.679614417467, 7203.675834587351, 7225.674844631899, 7236.986821845051, 7261.38278246355, 7627.122880868771, 7637.159912409742, 7638.465307428427, 7649.082110146818, 7663.27198916102, 3820.522434695663, 4570.702904311209, 4615.653825962999, 4619.191641462663, 4625.861224163281, 7004.299570042955, 7260.818479538054, 7277.126744790659, 7282.890756638549, 7290.890636640561, 5625.296837895263, 6930.306969303029, 6995.370416662525, 6996.650167491707, 7013.333733295329, 6105.603135796159, 6631.0, 7020.543664661781, 7036.296370362923, 7049.9647501762165, 5916.26046744157, 6479.740810367721, 6848.315168483311, 6866.896996544956, 6869.278725733926, 6829.146356705412, 6971.825704357431, 7001.404880585207, 7012.614306213207, 7063.5055546113335, 6607.900881486878, 6726.192856857013, 6747.966260168668, 6894.931050689429, 6933.791986240421], "unit": "score", "name": "prototype.html", "value": 5122.541078382502}, {"lowerIsBetter": false, "replicates": [729.8941653460248, 786.8190316227272, 803.3803544208264, 812.1796985045106, 813.9186081391858, 14624.26878656067, 14841.257937103155, 14864.925675371622, 14897.329620167091, 14914.850851491481, 11440.427978601057, 13506.662333441669, 13587.0, 13596.980226483003, 13646.044776865598, 793.4208028139461, 812.7317985064944, 972.65470757881, 1001.8647482589867, 1003.3127307794148, 988.4563490080463, 998.5905778630763, 1000.0749306891097, 1003.032074048543, 1004.6584161385127, 852.799592095857, 1065.2915810985724, 1069.844872493488, 1069.9893001069968, 1072.6031368393706, 1040.5057597641135, 1067.7277294289984, 1068.5939343049592, 1071.0, 1071.0681706914957, 794.7417089445953, 795.459087820282, 796.2515235678444, 797.5135167547792, 797.6889013284823, 15416.768748468781, 15487.845121548753, 15500.457483988119, 15501.689966200725, 15505.379784808594, 12580.0, 12637.747245055047, 12887.097903146783, 13007.764262395152, 13173.670658233525, 10228.43743594102, 10425.113865321457, 11083.778324433466, 11720.355380454072, 11836.171467997243, 3533.0990597397754, 3550.751447398683, 3564.590072141685, 3631.891043268706, 3769.246150769857, 78379.80429437473, 80118.0, 90609.54695226482, 91372.54313728455, 92139.53930230373, 9533.189678877234, 9557.0, 9754.561044753003, 9764.658236961672, 10478.580856765644, 22053.448663783533, 22121.0, 22163.445913852283, 22502.887485562795, 22524.662130068064, 7568.621568921642, 7568.8486230276185, 7636.236376362319, 7647.273509016634, 7662.4253181011645, 4104.712670113123, 4122.031322639177, 4169.353750168729, 4304.182205380967, 4361.80371883266, 3686.2627474505207, 3720.925581488355, 3734.085149138424, 3739.3456145174487, 3754.8685795997008, 653.2487639214846, 659.0162467881667, 672.8788818012707, 677.2313424263497, 677.4005005570008, 498.6110833549764, 570.4466667332681, 588.4644973074567, 607.2864384348374, 637.8761308142879, 7851.685932562634, 8065.153158918347, 8133.739270413095, 8170.060443049007, 8173.264406203471, 530.0406264660899, 539.8434454008294, 572.4790440698944, 594.551113908996, 612.2071916867667, 3720.162963333228, 3810.3141434541494, 3883.2815929053218, 3888.416737489399, 3894.1432884765304, 100332.0, 101377.49311253396, 103518.48240758899, 104134.0, 104451.4777426108, 83592.74610880842, 84047.5797621008, 85291.29417411616, 86083.13916860876, 86428.70356944652, 74782.13044673819, 76320.23679763242, 76663.23336766561, 77358.61320693474, 78478.6076069616, 7634.847303053797, 7676.692932282646, 7786.143524212445, 8477.95761021191, 8532.0, 48458.5154148454, 50003.499964999886, 50282.2457663128, 50936.98126037385, 51470.742646286526, 70424.59150816852, 71152.64423677849, 71442.0, 71771.0, 72585.0, 11111.666650000512, 11150.832737509107, 11425.885741142481, 11571.247868888495, 11721.413929303671, 10234.488275586042, 11952.521899123938, 12047.759044818878, 12174.817377739164, 12620.684482887635, 11151.163662725166, 11386.373749443861, 11593.710157246136, 11648.242864213798, 12191.268523888595, 9331.86002209981, 11508.340492731935, 11726.88273117292, 11727.589534366256, 11849.466773995364, 11196.832047519456, 11216.847739255447, 11423.314601123959, 11613.593524226611, 12307.876921230672, 9598.32811703174, 9652.855207171757, 9672.0, 10012.949935250568, 10330.741731456774, 9827.361221520578, 9958.253131015348, 9997.800043999225, 10041.899581004096, 10044.246681498771], "unit": "score", "name": "yui.html", "value": 7155.737868065878}], "name": "dromaeo_css", "value": 7593.994529214091}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 109.0, 111.0, 115.0, 169.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [151.0, 118.0, 150.0, 142.0, 115.0, 135.0, 111.0, 147.0, 147.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 133.2}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 183.0, 183.0, 182.0, 184.0, 183.0, 183.0, 184.0, 184.0], "unit": "score", "name": "audio-dft", "value": 183.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 74.0, 116.0, 54.0, 57.0, 57.0, 57.0, 112.0, 55.0], "unit": "score", "name": "audio-fft", "value": 72.7}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 125.0, 70.0, 109.0, 122.0, 157.0, 88.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 84.0, 86.0, 83.0, 87.0, 83.0, 84.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.8}, {"lowerIsBetter": true, "replicates": [92.0, 104.0, 148.0, 123.0, 92.0, 92.0, 92.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 102.0}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 84.0, 87.0, 85.0, 85.0, 84.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.0}, {"lowerIsBetter": true, "replicates": [52.0, 57.0, 58.0, 57.0, 58.0, 57.0, 57.0, 66.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 75.0, 71.0, 67.0, 64.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [80.0, 83.0, 80.0, 79.0, 80.0, 79.0, 79.0, 78.0, 80.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.1}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 124.0, 123.0, 119.0, 116.0, 137.0, 157.0, 123.0, 105.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [132.0, 116.0, 128.0, 131.0, 133.0, 121.0, 131.0, 132.0, 133.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 128.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 64.0, 65.0, 65.0, 65.0, 66.0, 60.0, 80.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1408.0999999999997}]} 03:15:54 INFO - Return code: 0 03:15:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:15:54 INFO - # TBPL SUCCESS # 03:15:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:15:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:15:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:15:54 INFO - 2016-03-28 03:15:54.756 screenresolution[1687:12079] starting screenresolution argv=screenresolution get 03:15:54 INFO - 2016-03-28 03:15:54.759 screenresolution[1687:12079] Display 0: 1600x1200x32@60 03:15:54 INFO - 2016-03-28 03:15:54.765 screenresolution[1688:12082] starting screenresolution argv=screenresolution list 03:15:54 INFO - Available Modes on Display 0 03:15:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:15:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:15:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:15:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:15:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:15:54 INFO - Intel Iris: 03:15:54 INFO - Chipset Model: Intel Iris 03:15:54 INFO - Type: GPU 03:15:54 INFO - Bus: Built-In 03:15:54 INFO - VRAM (Dynamic, Max): 1536 MB 03:15:54 INFO - Vendor: Intel (0x8086) 03:15:54 INFO - Device ID: 0x0a2e 03:15:54 INFO - Revision ID: 0x0009 03:15:54 INFO - Displays: 03:15:54 INFO - Display: 03:15:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:15:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:15:54 INFO - Display Serial Number: 1600x1200 60 03:15:54 INFO - Main Display: Yes 03:15:54 INFO - Mirror: Off 03:15:54 INFO - Online: Yes 03:15:54 INFO - Rotation: Supported 03:15:55 INFO - Return code: 0 03:15:55 INFO - Running post-action listener: _resource_record_post_action 03:15:55 INFO - Running post-run listener: _resource_record_post_run 03:15:56 INFO - Total resource usage - Wall time: 1204s; CPU: 52.0%; Read bytes: 32210432; Write bytes: 665706496; Read time: 359; Write time: 1836 03:15:56 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 352868864; Write bytes: 353154560; Read time: 28613; Write time: 666 03:15:56 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 31288832; Write bytes: 302213632; Read time: 346; Write time: 1136 03:15:56 INFO - Running post-run listener: _upload_blobber_files 03:15:56 INFO - Blob upload gear active. 03:15:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:15:56 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 03:15:56 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'] 03:15:56 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 03:15:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:15:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:15:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:15:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:57 INFO - (blobuploader) - INFO - Done attempting. 03:15:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:15:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:15:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:58 INFO - (blobuploader) - INFO - Done attempting. 03:15:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:15:58 INFO - Return code: 0 03:15:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:15:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:15:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67783cc70327ba7aea55675c0fa88f64f89c3aef2af86a96ae161fa023d5a59d31b9cd7fe5f52273f4d48e8de7611eb69e0e3cbb0914788ae33b6da95c044867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddcf6a705a12dcb328e98be78c94dada62b0a60e1636769ef59b1822a4e36300d82b1ec7bd0f176094764a532ac1f6022ecc6f14091a69fce945edba8fdcca4f"} 03:15:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:15:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:15:58 INFO - Contents: 03:15:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67783cc70327ba7aea55675c0fa88f64f89c3aef2af86a96ae161fa023d5a59d31b9cd7fe5f52273f4d48e8de7611eb69e0e3cbb0914788ae33b6da95c044867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddcf6a705a12dcb328e98be78c94dada62b0a60e1636769ef59b1822a4e36300d82b1ec7bd0f176094764a532ac1f6022ecc6f14091a69fce945edba8fdcca4f"} 03:15:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:15:58 INFO - Copying logs to upload dir... 03:15:58 INFO - mkdir: /builds/slave/test/build/upload/logs 03:15:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.220900 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-03-28 03:15:58.267105) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 03:15:58.271058) ========= 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.Heefau8TxK/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.9UhqpPDdOm/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67783cc70327ba7aea55675c0fa88f64f89c3aef2af86a96ae161fa023d5a59d31b9cd7fe5f52273f4d48e8de7611eb69e0e3cbb0914788ae33b6da95c044867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddcf6a705a12dcb328e98be78c94dada62b0a60e1636769ef59b1822a4e36300d82b1ec7bd0f176094764a532ac1f6022ecc6f14091a69fce945edba8fdcca4f"} build_url:https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010952 build_url: 'https://queue.taskcluster.net/v1/task/NDCgoyydRACCHOoc6mjhSg/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/67783cc70327ba7aea55675c0fa88f64f89c3aef2af86a96ae161fa023d5a59d31b9cd7fe5f52273f4d48e8de7611eb69e0e3cbb0914788ae33b6da95c044867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddcf6a705a12dcb328e98be78c94dada62b0a60e1636769ef59b1822a4e36300d82b1ec7bd0f176094764a532ac1f6022ecc6f14091a69fce945edba8fdcca4f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 03:15:58.298021) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 03:15:58.298406) ========= 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.Heefau8TxK/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.9UhqpPDdOm/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005159 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 03:15:58.347263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 03:15:58.347543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 03:15:58.347894) ========= ========= Total master_lag: 0.38 =========