builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0081 starttime: 1460540883.8 results: success (0) buildid: 20160413004016 builduid: 4053d68bc98f4a60be21086675af1e22 revision: 3312754269d285ad416da1d54cf07e6a163ce479 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.801720) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.802358) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.802798) ========= 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.Ubzh2Ukacm/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.o475jOK9fp/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005723 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.828717) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.829264) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.847256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.847612) ========= 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.Ubzh2Ukacm/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.o475jOK9fp/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005823 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.897905) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.898437) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.899172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:03.899746) ========= 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.Ubzh2Ukacm/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.o475jOK9fp/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-13 02:48:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.4M=0.001s 2016-04-13 02:48:04 (19.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.481448 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:04.398424) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:04.398807) ========= 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.Ubzh2Ukacm/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.o475jOK9fp/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.034514 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:04.450543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 02:48:04.451170) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3312754269d285ad416da1d54cf07e6a163ce479 --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 3312754269d285ad416da1d54cf07e6a163ce479 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ubzh2Ukacm/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.o475jOK9fp/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-13 02:48:04,526 truncating revision to first 12 chars 2016-04-13 02:48:04,527 Setting DEBUG logging. 2016-04-13 02:48:04,527 attempt 1/10 2016-04-13 02:48:04,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3312754269d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 02:48:06,244 unpacking tar archive at: mozilla-aurora-3312754269d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.962975 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 02:48:06.433158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:06.433874) ========= echo 3312754269d285ad416da1d54cf07e6a163ce479 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3312754269d285ad416da1d54cf07e6a163ce479'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ubzh2Ukacm/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.o475jOK9fp/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 3312754269d285ad416da1d54cf07e6a163ce479 program finished with exit code 0 elapsedTime=0.005362 script_repo_revision: '3312754269d285ad416da1d54cf07e6a163ce479' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:06.484387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:06.484766) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 02:48:06.499302) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-13 02:48:06.499676) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.Ubzh2Ukacm/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.o475jOK9fp/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:06 INFO - MultiFileLogger online at 20160413 02:48:06 in /builds/slave/test 02:48:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:48:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:06 INFO - {'append_to_log': False, 02:48:06 INFO - 'base_work_dir': '/builds/slave/test', 02:48:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:48:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:06 INFO - 'branch': 'Mozilla-Aurora', 02:48:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:06 INFO - 'config_files': ('talos/mac_config.py',), 02:48:06 INFO - 'default_actions': ('clobber', 02:48:06 INFO - 'read-buildbot-config', 02:48:06 INFO - 'download-and-extract', 02:48:06 INFO - 'populate-webroot', 02:48:06 INFO - 'create-virtualenv', 02:48:06 INFO - 'install', 02:48:06 INFO - 'run-tests'), 02:48:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:06 INFO - 'download_minidump_stackwalk': True, 02:48:06 INFO - 'download_symbols': 'ondemand', 02:48:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:06 INFO - 'installer_path': 'installer.exe', 02:48:06 INFO - 'log_level': 'info', 02:48:06 INFO - 'log_name': 'talos', 02:48:06 INFO - 'log_to_console': True, 02:48:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:48:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:48:06 INFO - 'opt_config_files': (), 02:48:06 INFO - 'pip_index': False, 02:48:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:06 INFO - 'cmd': ('bash', 02:48:06 INFO - '-c', 02:48:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:06 INFO - 'enabled': True, 02:48:06 INFO - 'halt_on_failure': False, 02:48:06 INFO - 'name': 'check_screen_resolution'},), 02:48:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:06 INFO - 'cmd': ('bash', 02:48:06 INFO - '-c', 02:48:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:06 INFO - 'enabled': True, 02:48:06 INFO - 'halt_on_failure': False, 02:48:06 INFO - 'name': 'check_screen_resolution'},), 02:48:06 INFO - 'run_cmd_checks_enabled': True, 02:48:06 INFO - 'sps_profile': False, 02:48:06 INFO - 'sps_profile_interval': 0, 02:48:06 INFO - 'suite': 'dromaeojs-e10s', 02:48:06 INFO - 'system_bits': '32', 02:48:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:06 INFO - 'title': 't-yosemite-r7-0081', 02:48:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:06 INFO - 'use_talos_json': True, 02:48:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:06 INFO - 'work_dir': 'build'} 02:48:06 INFO - ##### 02:48:06 INFO - ##### Running clobber step. 02:48:06 INFO - ##### 02:48:06 INFO - Running pre-action listener: _resource_record_pre_action 02:48:06 INFO - Running main action method: clobber 02:48:06 INFO - rmtree: /builds/slave/test/build 02:48:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:08 INFO - Running post-action listener: _resource_record_post_action 02:48:08 INFO - ##### 02:48:08 INFO - ##### Running read-buildbot-config step. 02:48:08 INFO - ##### 02:48:08 INFO - Running pre-action listener: _resource_record_pre_action 02:48:08 INFO - Running main action method: read_buildbot_config 02:48:08 INFO - Using buildbot properties: 02:48:08 INFO - { 02:48:08 INFO - "project": "", 02:48:08 INFO - "product": "firefox", 02:48:08 INFO - "script_repo_revision": "production", 02:48:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:48:08 INFO - "repository": "", 02:48:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:48:08 INFO - "buildid": "20160413004016", 02:48:08 INFO - "stage_platform": "macosx64", 02:48:08 INFO - "basedir": "/builds/slave/test", 02:48:08 INFO - "nightly_build": "True", 02:48:08 INFO - "buildnumber": 256, 02:48:08 INFO - "slavename": "t-yosemite-r7-0081", 02:48:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:48:08 INFO - "platform": "yosemite_r7", 02:48:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:48:08 INFO - "branch": "mozilla-aurora", 02:48:08 INFO - "repo_path": "releases/mozilla-aurora", 02:48:08 INFO - "revision": "3312754269d285ad416da1d54cf07e6a163ce479", 02:48:08 INFO - "pgo_build": "False", 02:48:08 INFO - "builduid": "4053d68bc98f4a60be21086675af1e22", 02:48:08 INFO - "slavebuilddir": "test" 02:48:08 INFO - } 02:48:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:48:08 INFO - Running post-action listener: _resource_record_post_action 02:48:08 INFO - ##### 02:48:08 INFO - ##### Running download-and-extract step. 02:48:08 INFO - ##### 02:48:08 INFO - Running pre-action listener: _resource_record_pre_action 02:48:08 INFO - Running main action method: download_and_extract 02:48:08 INFO - mkdir: /builds/slave/test/build/tests 02:48:08 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:48:08 INFO - https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/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:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/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:48:09 INFO - Downloaded 1277 bytes. 02:48:09 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:48:09 INFO - Using the following test package requirements: 02:48:09 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:48:09 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:09 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:48:09 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:09 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:48:09 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:09 INFO - u'jsshell-mac.zip'], 02:48:09 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:09 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:48:09 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:48:09 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:09 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:48:09 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:09 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:48:09 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:09 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:48:09 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:48:09 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:09 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:48:09 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:48: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:48:09 INFO - https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/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:48:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/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:48:10 INFO - Downloaded 17911153 bytes. 02:48:10 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:48:10 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:48:13 INFO - Return code: 0 02:48:13 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:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:13 INFO - https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/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:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/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:48:14 INFO - Downloaded 17911153 bytes. 02:48:14 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:48:14 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:48:18 INFO - Return code: 0 02:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:18 INFO - https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:48:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:48:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:48:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/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:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/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:48:19 INFO - Downloaded 10845168 bytes. 02:48:19 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:48:19 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:48:19 INFO - Return code: 0 02:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:19 INFO - https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:48:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:48:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:48:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/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:48:22 INFO - Downloaded 115310217 bytes. 02:48:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:48:22 INFO - mkdir: /builds/slave/test/properties 02:48:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:22 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:22 INFO - Contents: 02:48:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:48:23 INFO - Running post-action listener: _resource_record_post_action 02:48:23 INFO - Running post-action listener: set_extra_try_arguments 02:48:23 INFO - ##### 02:48:23 INFO - ##### Running populate-webroot step. 02:48:23 INFO - ##### 02:48:23 INFO - Running pre-action listener: _resource_record_pre_action 02:48:23 INFO - Running main action method: populate_webroot 02:48:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:23 INFO - '--tppagecycles', 02:48:23 INFO - '7'], 02:48:23 INFO - 'tests': ['tsvgm']}}, 02:48:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:48:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:48:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:48:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:48:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--e10s'], 02:48:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'tests': ['damp', 'tps']}, 02:48:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--e10s'], 02:48:23 INFO - 'tests': ['damp', 'tps']}, 02:48:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:48:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:23 INFO - 'other': {'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:48:23 INFO - 'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:48:23 INFO - 'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:48:23 INFO - 'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other_l64': {'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other_nol64': {'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'svgr': {'tests': ['tsvgx', 02:48:23 INFO - 'tsvgr_opacity', 02:48:23 INFO - 'tart', 02:48:23 INFO - 'tscrollx', 02:48:23 INFO - 'cart']}, 02:48:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:48:23 INFO - 'tests': ['tsvgx', 02:48:23 INFO - 'tsvgr_opacity', 02:48:23 INFO - 'tart', 02:48:23 INFO - 'tscrollx', 02:48:23 INFO - 'cart']}, 02:48:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'tests': ['tp5o']}, 02:48:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--e10s'], 02:48:23 INFO - 'tests': ['tp5o']}, 02:48:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--xperf_path', 02:48:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:23 INFO - 'tests': ['tp5n']}, 02:48:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--e10s', 02:48:23 INFO - '--xperf_path', 02:48:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:23 INFO - 'tests': ['tp5n']}}, 02:48:23 INFO - 'talos.zip': {'path': '', 02:48:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:23 INFO - Running post-action listener: _resource_record_post_action 02:48:23 INFO - ##### 02:48:23 INFO - ##### Running create-virtualenv step. 02:48:23 INFO - ##### 02:48:23 INFO - Running pre-action listener: _resource_record_pre_action 02:48:23 INFO - Running main action method: create_virtualenv 02:48:23 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:23 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:48:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:23 INFO - Using real prefix '/tools/python27' 02:48:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:24 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:27 INFO - Installing pip.................done. 02:48:27 INFO - Return code: 0 02:48:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:27 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:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:27 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:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:27 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 0x105847a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10584e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d539a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, '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.Ubzh2Ukacm/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.o475jOK9fp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:27 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:48:27 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:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:27 INFO - 'HOME': '/Users/cltbld', 02:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:27 INFO - 'LOGNAME': 'cltbld', 02:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:27 INFO - 'MOZ_NO_REMOTE': '1', 02:48:27 INFO - 'NO_EM_RESTART': '1', 02:48:27 INFO - 'PAGER': '/bin/cat', 02:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:27 INFO - 'PWD': '/builds/slave/test', 02:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:27 INFO - 'SHELL': '/bin/bash', 02:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:48:27 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:27 INFO - 'USER': 'cltbld', 02:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:27 INFO - 'XPC_FLAGS': '0x0', 02:48:27 INFO - 'XPC_SERVICE_NAME': '0', 02:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:27 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:48:27 INFO - Cleaning up... 02:48:27 INFO - Return code: 0 02:48:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:48:27 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:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:27 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:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:27 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 0x105847a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10584e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d539a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, '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.Ubzh2Ukacm/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.o475jOK9fp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:27 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:48:27 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:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:27 INFO - 'HOME': '/Users/cltbld', 02:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:27 INFO - 'LOGNAME': 'cltbld', 02:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:27 INFO - 'MOZ_NO_REMOTE': '1', 02:48:27 INFO - 'NO_EM_RESTART': '1', 02:48:27 INFO - 'PAGER': '/bin/cat', 02:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:27 INFO - 'PWD': '/builds/slave/test', 02:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:27 INFO - 'SHELL': '/bin/bash', 02:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:48:27 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:27 INFO - 'USER': 'cltbld', 02:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:27 INFO - 'XPC_FLAGS': '0x0', 02:48:27 INFO - 'XPC_SERVICE_NAME': '0', 02:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:28 INFO - Downloading/unpacking psutil>=0.7.1 02:48: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:48: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:48: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:48: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:48: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:48: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:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:30 INFO - Installing collected packages: psutil 02:48:30 INFO - Running setup.py install for psutil 02:48:31 INFO - building 'psutil._psutil_osx' extension 02:48:31 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:48:31 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:48:31 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:48:31 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:48:31 INFO - building 'psutil._psutil_posix' extension 02:48:31 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:48:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:31 INFO - ^ 02:48:32 INFO - 1 warning generated. 02:48:32 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:48:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:32 INFO - Successfully installed psutil 02:48:32 INFO - Cleaning up... 02:48:32 INFO - Return code: 0 02:48:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:48: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:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 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 0x105847a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10584e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d539a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, '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.Ubzh2Ukacm/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.o475jOK9fp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:32 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:48:32 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:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:32 INFO - 'HOME': '/Users/cltbld', 02:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:32 INFO - 'LOGNAME': 'cltbld', 02:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:32 INFO - 'MOZ_NO_REMOTE': '1', 02:48:32 INFO - 'NO_EM_RESTART': '1', 02:48:32 INFO - 'PAGER': '/bin/cat', 02:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:32 INFO - 'PWD': '/builds/slave/test', 02:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:32 INFO - 'SHELL': '/bin/bash', 02:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:48:32 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:32 INFO - 'USER': 'cltbld', 02:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:32 INFO - 'XPC_FLAGS': '0x0', 02:48:32 INFO - 'XPC_SERVICE_NAME': '0', 02:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:48:32 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:48:32 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:48:32 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:48:32 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:48:32 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:48:32 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:48:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:35 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:48:35 INFO - Installing collected packages: mozsystemmonitor 02:48:35 INFO - Running setup.py install for mozsystemmonitor 02:48:35 INFO - Successfully installed mozsystemmonitor 02:48:35 INFO - Cleaning up... 02:48:35 INFO - Return code: 0 02:48:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105847a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10584e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d539a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, '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.Ubzh2Ukacm/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.o475jOK9fp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:35 INFO - 'HOME': '/Users/cltbld', 02:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:35 INFO - 'LOGNAME': 'cltbld', 02:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:35 INFO - 'MOZ_NO_REMOTE': '1', 02:48:35 INFO - 'NO_EM_RESTART': '1', 02:48:35 INFO - 'PAGER': '/bin/cat', 02:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:35 INFO - 'PWD': '/builds/slave/test', 02:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:35 INFO - 'SHELL': '/bin/bash', 02:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:48:35 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:35 INFO - 'USER': 'cltbld', 02:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:35 INFO - 'XPC_FLAGS': '0x0', 02:48:35 INFO - 'XPC_SERVICE_NAME': '0', 02:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:35 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:37 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:48:37 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:48:37 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:48:37 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:48:37 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:48:37 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:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:39 INFO - Downloading docopt-0.6.1.tar.gz 02:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:39 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:39 INFO - Running setup.py install for blobuploader 02:48:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:39 INFO - Running setup.py install for requests 02:48:39 INFO - Running setup.py install for docopt 02:48:39 INFO - Successfully installed blobuploader requests docopt 02:48:39 INFO - Cleaning up... 02:48:40 INFO - Return code: 0 02:48:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:40 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:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:40 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:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:40 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 0x105847a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10584e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d539a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, '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.Ubzh2Ukacm/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.o475jOK9fp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:40 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:48:40 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:48:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:40 INFO - 'HOME': '/Users/cltbld', 02:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:40 INFO - 'LOGNAME': 'cltbld', 02:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:40 INFO - 'MOZ_NO_REMOTE': '1', 02:48:40 INFO - 'NO_EM_RESTART': '1', 02:48:40 INFO - 'PAGER': '/bin/cat', 02:48:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:40 INFO - 'PWD': '/builds/slave/test', 02:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:40 INFO - 'SHELL': '/bin/bash', 02:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:48:40 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:40 INFO - 'USER': 'cltbld', 02:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:40 INFO - 'XPC_FLAGS': '0x0', 02:48:40 INFO - 'XPC_SERVICE_NAME': '0', 02:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-Y7lXsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-ApsrSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-wHxv8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-Z0iXRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-rzMC4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-QGIrgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-WUhRPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-w410Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-ANersh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-a8K1Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-IYKJ0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-ssvPPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-PdhMGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-xlkkeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-Jof2Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-EDybbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-EW1q5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:42 INFO - Running setup.py install for manifestparser 02:48:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozcrash 02:48:42 INFO - Running setup.py install for mozdebug 02:48:42 INFO - Running setup.py install for mozdevice 02:48:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozfile 02:48:42 INFO - Running setup.py install for mozhttpd 02:48:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozinfo 02:48:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Running setup.py install for mozInstall 02:48:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Running setup.py install for mozleak 02:48:43 INFO - Running setup.py install for mozlog 02:48:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Running setup.py install for moznetwork 02:48:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Running setup.py install for mozprocess 02:48:43 INFO - Running setup.py install for mozprofile 02:48:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Running setup.py install for mozrunner 02:48:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:44 INFO - Running setup.py install for mozscreenshot 02:48:44 INFO - Running setup.py install for moztest 02:48:44 INFO - Running setup.py install for mozversion 02:48:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:44 INFO - Cleaning up... 02:48:44 INFO - Return code: 0 02:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48: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:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:44 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 0x105847a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10584e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d539a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, '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.Ubzh2Ukacm/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.o475jOK9fp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:44 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:48:44 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:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:44 INFO - 'HOME': '/Users/cltbld', 02:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:44 INFO - 'LOGNAME': 'cltbld', 02:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:44 INFO - 'MOZ_NO_REMOTE': '1', 02:48:44 INFO - 'NO_EM_RESTART': '1', 02:48:44 INFO - 'PAGER': '/bin/cat', 02:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:44 INFO - 'PWD': '/builds/slave/test', 02:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:44 INFO - 'SHELL': '/bin/bash', 02:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:48:44 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:44 INFO - 'USER': 'cltbld', 02:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:44 INFO - 'XPC_FLAGS': '0x0', 02:48:44 INFO - 'XPC_SERVICE_NAME': '0', 02:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:44 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-j0K8o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:44 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:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:44 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-ZB3YF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:45 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:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:45 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-nIXia0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:45 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:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:45 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-I19ZXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:45 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:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:45 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-VOdV7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:45 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:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:45 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-NFKsNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:45 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:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:45 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-wM8BsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:45 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:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:45 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-tl1ZfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:45 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:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:45 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-9FaIP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:45 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:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:45 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-IxEJIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:45 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:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:45 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-uNd2W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:46 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:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-x7C8Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:46 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:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-2aj3NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:46 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:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-FlaF87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:46 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:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-K5qJVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:46 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:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-i84su1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:46 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:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-tfp8g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:46 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:48:46 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:48:46 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:48:46 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:48:46 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:48:46 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:48:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48: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:48: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:48: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:48: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:48: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:48: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:48:49 INFO - Downloading blessings-1.6.tar.gz 02:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:49 INFO - Installing collected packages: blessings 02:48:49 INFO - Running setup.py install for blessings 02:48:49 INFO - Successfully installed blessings 02:48:49 INFO - Cleaning up... 02:48:49 INFO - Return code: 0 02:48:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:49 INFO - Reading from file tmpfile_stdout 02:48:49 INFO - Current package versions: 02:48:49 INFO - blessings == 1.6 02:48:49 INFO - blobuploader == 1.2.4 02:48:49 INFO - docopt == 0.6.1 02:48:49 INFO - manifestparser == 1.1 02:48:49 INFO - mozInstall == 1.12 02:48:49 INFO - mozcrash == 0.17 02:48:49 INFO - mozdebug == 0.1 02:48:49 INFO - mozdevice == 0.48 02:48:49 INFO - mozfile == 1.2 02:48:49 INFO - mozhttpd == 0.7 02:48:49 INFO - mozinfo == 0.9 02:48:49 INFO - mozleak == 0.1 02:48:49 INFO - mozlog == 3.1 02:48:49 INFO - moznetwork == 0.27 02:48:49 INFO - mozprocess == 0.22 02:48:49 INFO - mozprofile == 0.28 02:48:49 INFO - mozrunner == 6.11 02:48:49 INFO - mozscreenshot == 0.1 02:48:49 INFO - mozsystemmonitor == 0.0 02:48:49 INFO - moztest == 0.7 02:48:49 INFO - mozversion == 1.4 02:48:49 INFO - psutil == 3.1.1 02:48:49 INFO - requests == 1.2.3 02:48:49 INFO - wsgiref == 0.1.2 02:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 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 0x105847a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10584e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d539a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, '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.Ubzh2Ukacm/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.o475jOK9fp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:49 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:48:49 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:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:49 INFO - 'HOME': '/Users/cltbld', 02:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:49 INFO - 'LOGNAME': 'cltbld', 02:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:49 INFO - 'MOZ_NO_REMOTE': '1', 02:48:49 INFO - 'NO_EM_RESTART': '1', 02:48:49 INFO - 'PAGER': '/bin/cat', 02:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:49 INFO - 'PWD': '/builds/slave/test', 02:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:49 INFO - 'SHELL': '/bin/bash', 02:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:48:49 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:49 INFO - 'USER': 'cltbld', 02:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:49 INFO - 'XPC_FLAGS': '0x0', 02:48:49 INFO - 'XPC_SERVICE_NAME': '0', 02:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:50 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:48:50 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:48:50 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:48:50 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:48:50 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:48:50 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:48:50 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:48:50 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:48:50 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:48:50 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:48:50 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:48:50 INFO - Cleaning up... 02:48:50 INFO - Return code: 0 02:48:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105847a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10584e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d539a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, '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.Ubzh2Ukacm/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.o475jOK9fp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:48:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:48:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:50 INFO - 'HOME': '/Users/cltbld', 02:48:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:50 INFO - 'LOGNAME': 'cltbld', 02:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:50 INFO - 'MOZ_NO_REMOTE': '1', 02:48:50 INFO - 'NO_EM_RESTART': '1', 02:48:50 INFO - 'PAGER': '/bin/cat', 02:48:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:50 INFO - 'PWD': '/builds/slave/test', 02:48:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:50 INFO - 'SHELL': '/bin/bash', 02:48:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:48:50 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:48:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:50 INFO - 'USER': 'cltbld', 02:48:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:50 INFO - 'XPC_FLAGS': '0x0', 02:48:50 INFO - 'XPC_SERVICE_NAME': '0', 02:48:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:50 INFO - Downloading/unpacking jsonschema 02:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:52 INFO - Downloading/unpacking functools32 (from jsonschema) 02:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:53 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:53 INFO - warning: no files found matching '*.txt' 02:48:53 INFO - no previously-included directories found matching 'build' 02:48:53 INFO - no previously-included directories found matching 'dist' 02:48:53 INFO - no previously-included directories found matching '.git*' 02:48:53 INFO - Installing collected packages: jsonschema, functools32 02:48:53 INFO - Running setup.py install for functools32 02:48:53 INFO - warning: no files found matching '*.txt' 02:48:53 INFO - no previously-included directories found matching 'build' 02:48:53 INFO - no previously-included directories found matching 'dist' 02:48:53 INFO - no previously-included directories found matching '.git*' 02:48:53 INFO - Successfully installed jsonschema functools32 02:48:53 INFO - Cleaning up... 02:48:53 INFO - Return code: 0 02:48:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:48:53 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:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:53 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:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:53 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 0x105847a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10584e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d539a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, '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.Ubzh2Ukacm/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.o475jOK9fp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:48:53 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:48:53 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:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:53 INFO - 'HOME': '/Users/cltbld', 02:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:53 INFO - 'LOGNAME': 'cltbld', 02:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:53 INFO - 'MOZ_NO_REMOTE': '1', 02:48:53 INFO - 'NO_EM_RESTART': '1', 02:48:53 INFO - 'PAGER': '/bin/cat', 02:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:53 INFO - 'PWD': '/builds/slave/test', 02:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:53 INFO - 'SHELL': '/bin/bash', 02:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:48:53 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:53 INFO - 'USER': 'cltbld', 02:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:53 INFO - 'XPC_FLAGS': '0x0', 02:48:53 INFO - 'XPC_SERVICE_NAME': '0', 02:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:53 INFO - Downloading/unpacking flake8 02:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:48:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:48:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:57 INFO - no previously-included directories found matching 'docs/_build' 02:48:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:48:57 INFO - Running setup.py install for pep8 02:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:57 INFO - no previously-included directories found matching 'docs/_build' 02:48:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:48:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:48:57 INFO - Cleaning up... 02:48:57 INFO - Return code: 0 02:48:57 INFO - Running post-action listener: _resource_record_post_action 02:48:57 INFO - Running post-action listener: _start_resource_monitoring 02:48:57 INFO - Starting resource monitoring. 02:48:57 INFO - ##### 02:48:57 INFO - ##### Running install step. 02:48:57 INFO - ##### 02:48:57 INFO - Running pre-action listener: _resource_record_pre_action 02:48:57 INFO - Running main action method: install 02:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:58 INFO - Reading from file tmpfile_stdout 02:48:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:58 INFO - Reading from file tmpfile_stdout 02:48:58 INFO - Output received: 02:48:58 INFO - Usage: mozinstall [options] installer 02:48:58 INFO - Options: 02:48:58 INFO - -h, --help show this help message and exit 02:48:58 INFO - -d DEST, --destination=DEST 02:48:58 INFO - Directory to install application into. [default: 02:48:58 INFO - "/builds/slave/test"] 02:48:58 INFO - --app=APP Application being installed. [default: firefox] 02:48:58 INFO - mkdir: /builds/slave/test/build/application 02:48:58 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:48:58 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:49:29 INFO - Reading from file tmpfile_stdout 02:49:29 INFO - Output received: 02:49:29 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:49:29 INFO - Running post-action listener: _resource_record_post_action 02:49:29 INFO - ##### 02:49:29 INFO - ##### Running run-tests step. 02:49:29 INFO - ##### 02:49:29 INFO - Running pre-action listener: _resource_record_pre_action 02:49:29 INFO - Running main action method: run_tests 02:49:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:29 INFO - 2016-04-13 02:49:29.916 screenresolution[1645:7446] starting screenresolution argv=screenresolution get 02:49:29 INFO - 2016-04-13 02:49:29.919 screenresolution[1645:7446] Display 0: 1600x1200x32@60 02:49:29 INFO - 2016-04-13 02:49:29.924 screenresolution[1646:7448] starting screenresolution argv=screenresolution list 02:49:29 INFO - Available Modes on Display 0 02:49:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:30 INFO - Intel Iris: 02:49:30 INFO - Chipset Model: Intel Iris 02:49:30 INFO - Type: GPU 02:49:30 INFO - Bus: Built-In 02:49:30 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:30 INFO - Vendor: Intel (0x8086) 02:49:30 INFO - Device ID: 0x0a2e 02:49:30 INFO - Revision ID: 0x0009 02:49:30 INFO - Displays: 02:49:30 INFO - Display: 02:49:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:30 INFO - Display Serial Number: 1600x1200 60 02:49:30 INFO - Main Display: Yes 02:49:30 INFO - Mirror: Off 02:49:30 INFO - Online: Yes 02:49:30 INFO - Rotation: Supported 02:49:30 INFO - Return code: 0 02:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:30 INFO - Python 2.7.3 02:49:30 INFO - Return code: 0 02:49:30 INFO - grabbing minidump binary from tooltool 02:49:30 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:49:30 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 0x1056ebd30>, '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 0x10554fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:30 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:49:30 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:49:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:30 INFO - Return code: 0 02:49:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:49:31 INFO - Return code: 0 02:49:31 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:49:31 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0081 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:49:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubzh2Ukacm/Render', 02:49:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:31 INFO - 'HOME': '/Users/cltbld', 02:49:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:31 INFO - 'LOGNAME': 'cltbld', 02:49:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:31 INFO - 'MOZ_NO_REMOTE': '1', 02:49:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:31 INFO - 'NO_EM_RESTART': '1', 02:49:31 INFO - 'PAGER': '/bin/cat', 02:49:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:31 INFO - 'PWD': '/builds/slave/test', 02:49:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:31 INFO - 'SHELL': '/bin/bash', 02:49:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o475jOK9fp/Listeners', 02:49:31 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:49:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:31 INFO - 'USER': 'cltbld', 02:49:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:31 INFO - 'XPC_FLAGS': '0x0', 02:49:31 INFO - 'XPC_SERVICE_NAME': '0', 02:49:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:49:31 INFO - mozversion application_buildid: 20160413004016 02:49:31 INFO - mozversion application_changeset: 3312754269d285ad416da1d54cf07e6a163ce479 02:49:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:49:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:31 INFO - mozversion application_name: Firefox 02:49:31 INFO - mozversion application_remotingname: firefox-dev 02:49:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:31 INFO - mozversion application_vendor: Mozilla 02:49:31 INFO - mozversion application_version: 47.0a2 02:49:31 INFO - mozversion platform_buildid: 20160413004016 02:49:31 INFO - mozversion platform_changeset: 3312754269d285ad416da1d54cf07e6a163ce479 02:49:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:31 INFO - mozversion platform_version: 47.0a2 02:49:31 INFO - using testdate: 1460540971 02:49:31 INFO - actual date: 1460540971 02:49:31 INFO - starting webserver on 'localhost:49276' 02:49:31 INFO - SUITE-START | Running 2 tests 02:49:31 INFO - TEST-START | dromaeo_css 02:49:31 INFO - operating with platform_type : mac_ 02:49:31 INFO - Initialising browser for dromaeo_css test... 02:49:31 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpOBzsa1/profile http://localhost:49276/getInfo.html) 02:49:34 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 02:49:34 INFO - PROCESS | 1664 | colorDepth:24 02:49:34 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 02:49:34 INFO - PROCESS | 1664 | __metrics 02:49:34 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 02:49:35 INFO - TEST-INFO | 1664: exit 0 02:49:35 INFO - Browser initialized. 02:49:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:35 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpOBzsa1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:47 INFO - PROCESS | 1668 | RSS: Main: 217571328 02:49:47 INFO - PROCESS | 1668 | 02:50:36 INFO - PROCESS | 1668 | 1460541036953 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:52:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 02:52:49 INFO - PROCESS | 1668 | RSS: Main: 228392960 02:52:49 INFO - PROCESS | 1668 | 02:55:51 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 02:55:52 INFO - PROCESS | 1668 | RSS: Main: 240082944 02:55:52 INFO - PROCESS | 1668 | 02:58:53 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 02:58:54 INFO - PROCESS | 1668 | RSS: Main: 242802688 02:58:54 INFO - PROCESS | 1668 | 03:01:56 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 03:01:56 INFO - PROCESS | 1668 | RSS: Main: 243675136 03:01:56 INFO - PROCESS | 1668 | 03:04:59 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 03:05:00 INFO - PROCESS | 1668 | RSS: Main: 246464512 03:05:00 INFO - PROCESS | 1668 | 03:08:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 03:08:02 INFO - PROCESS | 1668 | RSS: Main: 247730176 03:08:02 INFO - PROCESS | 1668 | 03:08:02 INFO - PROCESS | 1668 | __start_tp_report 03:08:02 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 03:08:02 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 03:08:02 INFO - PROCESS | 1668 | |i|pagename|runs| 03:08:02 INFO - PROCESS | 1668 | |0;dojo.html;3090.9381812363745;3166.7941583797065;3169.4136584731827;3536.7524273300846;3604.5674519057716;5863.677497737623;5900.11498275259;5902.704864756755;5908.911366329503;5923.022701254294;5935.139404786314;5969.522438204944;5980.431858973401;6022.819315420534;6049.06239532872;5329.307190065296;5359.5444387227135;5435.347758269013;5460.126379779236;5479.753411096491;5277.736113194344;5386.757595908174;5424.267723857268;5503.3120859892515;5523.558115350783;5385.81149659762;5387.838364849061;5392.433794451585;5392.811251606195;5413.64811287267;5354.170103633924;5391.81128660495;5424.213489044106;5437.673739575638;5490.972545137289;5317.494837990384;5350.5987050971335;5394.190871369326;5416.891662166774;5431.402545719968;5775.653460792324;5925.614835035709;5928.49607783339;5961.956657584905;6054.606450580698;6127.189528148586;6188.87622247557;6195.783147589813;6269.435750782452;6305.621662700252;6312;6330.778422755181;6344.397282258178;6345.206849143857;6356.014817703263;5834.241548598655;5971.4924231439945;6055.757769689207;6071.150038994544;6080.787172448943;6408.51936104794;6419.972804351281;6428.100065990765;6458.257300410513;6462.256840463313;6261.405166509175;6264.874702505925;6269.122322874801;6284.402981716729;6285.968570157212;6175.5677102602385;6228.626282423069;6291.653959032205;6312.968435157886;6319.96840015797;6211.65835879022;6226;6263.561550691408;6296.275928268216;6300.432961033437;6237.438630523184;6251.4061164189325;6289.402506761941;6312.274088479791;6316.589421687576;4930.309756634074;4961.776720047535;4996.525330093636;5000.524950129732;5063.316452278895;3874.748141370802;4502.009557897258;4542.500324964251;4547.681662283609;4564.3153526970555;5503.724813759296;5806;6006.549508786771;6008.519318454513;6025.517958563304;6136.304638670978;6144.3717414885095;6252.6873656317;6283.622982621057;6307.905381419282;5963.344032156459;5976.491998180203;6008.549358798107;6010.729517171738;6015.796840631891;5539.335279766454;5547.77808887648;5550.306211723535;5554.361248456398;5558.082916318843;6332.303446620868;6444.613323200623;6497.447716944018;6512.544121911421;6522;6287.2140982377205;6303.243610766737;6330.588511746721;6341.365863413622;6342.651154186379;6325.588836725598;6449.226092868886;6458.418742313214;6481;6481.125048118443;5272.209168624737;6202.968985155046;6247.812565623039;6257.217847769029;6309.148264984168;5276.973615132053;6163.476104531165;6267.905981410191;6268.153799237227;6321.557490975588;5378.650387724785;6164.383561643979;6267.9971204607045;6280.0893870389455;6282.937170628418;6155.922713525205;6204.534659900435;6247.875042499034;6249.156363890998;6272.937270627418;5564.860878477908;6146.323904370426;6159.106929495288;6208.379162083756;6221.06683997404;6118.632882027093;6172.166757487861;6176.227971503562;6213.1922850029205;6272.466840318624;6112.169143789106;6140.3596453525415;6141.8464538385115;6146.200993870768;6164.982777841786 03:08:02 INFO - PROCESS | 1668 | |1;ext.html;520.3261776000082;594.2245369792422;601.5578549765919;628.5160426471615;668.372512931013;33888.4916726249;39591.60408395915;39634.60365396349;39675.80162099186;39812.60187398121;41006.589934100724;41384.96537586554;41615.16769664605;41653.75038748842;41659.58340416595;9713.980032096633;9967.651132210374;9973.252006099536;9990.90009099907;9999.150072243869;9774.902250977506;9884.209263258923;9890;9914.256430767686;9937.006299370041;8467.53428561432;8568.271696905771;9933.106020458157;9953.950230248875;9957.651482198124;8990.235829954461;9437.622495100188;9898.752531186778;9919;9925.50372481373;9779.364341317792;9920.305578609501;9928.45393503357;9934.45360505172;9949;34996.950091497296;35096.64903350985;35268.82365588181;35315.293694125976;35393.11517212065;3012.141539661208;3264.27438540842;3363.7477189210663;3484.79091254523;3897.7661340319673;27827.443451130865;28105.43789124206;28106.718932810614;28165.718342816515;28432.573511397346;2785.456835916997;2792.274008757717;2804.3970546332434;2850.558163484663;2886.033178885055;359923.2003839964;361568;362574;363537;435480.46779298654;49631.75184124128;50035;68319.3168068313;68953.58662446891;68985.65507172432;50430.99138017219;50715.985680286925;50733;51098;51218.48781512212;17548.561285967953;17668.646627067643;17802.46592602224;17812.821871781376;17834.643307133785;14041.297935103205;14042.648933776738;14113.506027288995;14152.858471415155;14169.716605667829;15926.362945482051;15978.76031859523;15997.760033599505;16008.359665613245;16009.199540023184;6011.797640471836;6058.757649694051;6405.135306733531;6450.612963222222;6513.218413790375;953.6709835106877;968.4963818814177;988.3229987458614;991.1624677147798;1194.4147367789894;28418.71581284202;29612;29711.554326685116;29767.478889988794;30192.698073019426;1066.3761699405934;1100.8954149355798;1103.189155970361;1148.2593727046008;1149.0233301693493;15202.619934501505;15373;15413.46052888166;15649;15705.528834134766;666062;668183;673691;674126;676069;64046;64472.355276447575;65283.347166527725;65462;65917.01124483136;1314.5530519623373;1503.8496150384874;1533.8619524242872;1536.2779493637972;1545.6058705030146;28953;29052.56421153727;29711.257218568844;29722.85138574293;30535.54196687007;46019;52844.471555283955;52882.471175287756;53048.46951530435;53168;499575;509194;510987;511596;512308;34631.653683463854;35558;35928.8203558991;36353.81823090868;36445.63554364529;47081.76459117683;47886.76056619834;47915.76042119767;48124.75937620289;48448.27327590019;39200.60799391969;39243;39333.80333098316;39899;40256.59743402646;38724.41913371358;39166;39220.80389598034;39557;40174.79475615736;38968.6103138965;40017.59982400139;40972.590274096874;41738;41932.3710144342;30485;33096.66903330936;33673.49489757606;33757.3248535023;35067.82466087653;23414.414639634146;25180;25254.494910101326;25491;25801.483970320864 03:08:02 INFO - PROCESS | 1668 | |2;jquery.html;375.20269427466616;376.75322663655317;381.3555091894698;386.3027235839309;387.1347538252008;19989.800611963274;20612.866292353916;20884.791152088474;21147.365579032616;21232.04455799489;20313.390598282076;21130.260440884573;21923.890380548113;22160.667589986162;22178.778212217872;5258.763355649005;5358.758855851496;5439.0209762242785;5444.646098003637;5444.8366549003595;5171.7414129293575;5914.172015917775;5970.402959704016;6027.638341699512;6034.577579569432;5665.801696940608;5923.496502797268;5938.584299099065;5967.254093238345;5986.551008674345;5858.648481091127;5881.5294776417995;5893.233879595647;5942.049272116441;5969.224000879901;5080.339555857715;5202.557782588485;5220.765065572058;5274.7626356814035;5281.785189406458;13686.247256400893;13984.881209503215;24827.62758558623;25899.482010359876;26781.33046673829;2009.9296524621568;2148.237375731624;2154.967675484869;2317.988410057939;2796.5106106431294;9707.951460242724;9856.556454959544;10082.344647597884;10136.797264054678;10167.237457190666;1719.355241784331;1746.3713063297203;1747.3884140550706;1767.2930827668906;1797.694391953358;79806.80289795657;80798;111684.44157779159;113044.73910521744;114949;9816;11326.603568875049;11370.204085714086;11438.885611143782;11784.234024788362;14018.649533761738;14114.788278175836;14143.363548640336;14214.360353784105;14215.867619857105;7515.361194298546;8935.821283574292;8990.685326013558;9043.728688139367;9071.773205669779;7368.9366977246455;9161.450312981242;9181.449113053239;9287.489188094585;9318.618328739083;3947.388154836005;4561.29299958507;4678.415198100238;4702.835400760957;4703.482616912137;1643.958901027484;1976.4070778766313;1985.4540001499704;2017.878927264369;2026.6757318828916;878.4597472554333;882.1311008656596;904.8235594059096;1034.6482196053228;1086.2070688397514;19906.50233744168;20247.493812654506;20381.388558343275;20744.58510829775;20891.95540222983;993.2897977945803;993.5826952679892;1024.2369434771142;1029.7477118106112;1044.399470304578;10944.890551094546;11197.77489631697;11266.564067715268;11281.379524126252;11343.773124537463;560383;621674;639792;654757;665048;121440;127006;127440.36279818727;129009;130313;886.7073865624328;1096.8245080787035;1101.3832253937821;1108.3626914524182;1111.8165502691966;18352.265909363476;18907.43277701616;19018.714719278945;19034.52413689669;19281.4215573533;51566.74216628893;52253;52936;53162.202566960754;53275;69085.65457172682;76246.61876690581;76804.61597691975;78846;82347.5882620583;7746.92253077462;8074.798130046795;8083.514989100673;8141.755747327589;8196.631151598072;9529.857052144085;13026.674333141747;13074.869251307366;13353.66615834573;13477.663058423226;11655.825162622397;11665.246020945775;11688.766224675628;11712.297262164297;12161.270323780602;9785.706428807147;11423;11492.54029838797;11810.940945295219;11831.994280486255;11697.415129243675;12002.339871306813;12076.698082548006;12184.878151218374;12211.572594959134;7938;8131.71538996156;8196.180381961994;8299.83400332002;8499.575021249037;11903.583374581847;11908.940455297668;11993.160478766402;11994.64016079519;12060.939695301468 03:08:02 INFO - PROCESS | 1668 | |3;mootools.html;1657.6187476880318;1685.5533283679827;2006.832620769569;2011.8893460859656;2102.716133322003;8370.414071015031;8963.148500892405;9003.189712925836;9248.861267081;9268.536573171332;9074.455532668044;9076.90923090769;9136.497492637918;9173.036831132718;9177.265818734502;2550.54090263752;2579.1359894435386;2583.005542865991;2586.0819409109777;2601.0636170978432;2519.143491212987;2530.8608026558622;2531.822772405923;2532.873356332176;2535.8732063396847;2279.6922415473946;2542.0975553678454;2570.8457492550506;2575.9742402576017;2585;2544.9745502545015;2558.8336758110663;2564.5512035393826;2569.4604133132066;2583.8708064596694;2316.559853627822;2530.493901219745;2532.392225865797;2535.074697735332;2535.6576862123748;8189.099199088096;8916.687915922912;9067.455952642862;9277.979422263546;9323.953380233123;5583.134614134816;5741.655500669932;5742.655440673573;5802.274715660543;5808.912866307009;3199.520071989197;3660.1032746976894;3722.7394082414244;3771.622837716234;3783.735138540303;966.9758256043655;1001.064005155175;1018.3737001743948;1093.6882988348361;1105.182165197748;12247.265164090182;12421.813672794915;12443.004559635297;12449;12458.937705311415;4953.554180123806;5033.748312584356;5043.621728370387;5111.948880511221;5128.461511541309;10495.00297471739;10589.258751887448;10595.152387808957;10598.894011059945;10604;5662.886742265132;5754.942450575524;5764.971175144097;5769.9711501442225;5791.478766910914;4266.658667306608;5034.11902916988;5117.155669314521;5178.352705911761;5179.637425380262;4087.3664581989838;4115.218108559364;4146.212219678312;4156.418101465797;4163.5836416358125;1330.0490149543123;1339.5867359935362;1343.4827591377195;1347.9865201348057;1368.1927662679068;1399.6360946154073;1417.6455886028493;1428.5785693220525;1439.9208043557496;1446.3491428857055;8472.068072512018;8485.872711909326;8515.701950431705;8517.914820851713;8524.829503410021;515.2451658320504;526.6208330002393;528.1892295326655;531.5614617940215;531.7553925194377;5643.830685079454;6209.627422354673;6233.283172435228;6386.201724784402;6388.520860935449;10894.836577451344;11216.495257713423;11237.38194399316;11265.098792096776;11325.150613704005;10683.14534837211;10932.234743568033;11025.283356581796;11112.222144449972;11193.216474846682;8664.8700269496;8669.869951950726;8684.2184203422;8722.389432739774;8774.078721734126;8093.392995525477;8218.794530136794;8278.958605206935;8389.370797190357;8576.356773241907;9480.810383792423;9787.706368808947;9880.85178722334;9893.65372211969;9906;9990;10163.695089147337;10243.7439064024;10319.896801032193;10356.792864142826;7828.060632724109;7866.6066696666085;7879.133295337394;7937.365010799007;7994.720184793504;8553.272971797218;8562.614682339185;8575.87136192945;8603.870941935751;8664.91335086641;7362.6318684066655;7673.769786906401;7926.365890728844;8032.116467188488;8152.877706834521;7757.146713861358;7887.64505597238;7906.248906353887;7953.2842044216295;7990.3208227299;7867.134615192439;7907.130215676156;7929.841403171788;7983.520988740462;7993.320567751806;7227.710891564278;7233.421326293778;7276.96361518189;7282.980382746526;7296.160941491797;7166.713331466683;7493.288137626917;7507.774766757006;7534.811629709301;7537.924620753723 03:08:02 INFO - PROCESS | 1668 | |4;prototype.html;334.89785615387314;335.605663345569;345.63535470079063;345.80289235135984;345.96367381424966;5616.943830561693;6920;7008.754693585719;7015.859682806347;7102.9644851775665;6049.790041991598;6314.873702525947;6602.405783479486;6971.6165610891385;6989.755358562451;4352.89117772055;4834.395700537441;4953.504649535053;5059.266406371074;5083;4140.337545992642;5045.4450010499;5079.568236699885;5084.8220312288895;5085.982803439309;4091.6931230157707;5020.723860187688;5048.1418158913075;5069.087564238435;5447.591430642698;5027.849164525033;5043.495650434946;5055.620828437864;5062.96209277101;5103.438621751604;4356.8257269709175;4368.344748287782;4371.759553224571;4373.606375426195;4384.254676704968;6425.678716064178;6738.326167383271;6746.595204287759;6747.392734653905;6831.760888368933;5911.349751527328;5924.940750592482;5943.227380440559;5944.97027514864;5957.076653118774;7436.702531898718;7447.2552744725635;7457.813554661123;7460.962695186544;7484.700611975514;4028.2144981728575;4711.929321060187;4720.57514823664;4726.787294571753;4728.314394412825;6697.6986035628515;7510.6620202091035;7875.173106823759;7887.211278872067;7905.5256684598535;3820.598837122118;4688.249880019181;4753.809847606126;4762.476127625959;4790;4882.584980276645;4885.1206782779445;4888.2178851383605;4888.731119788375;4894.094592500328;5893.970530147321;5897.498712609477;5902.734376952962;5924.555658325643;5935.821925342247;7488.5506869588;7506.437017223621;7528.134264559536;7547.5848828314965;7556.773296801105;1622.4078211452734;1680.3110724602855;1695.5591546198077;1701.8213087625868;1705.104819969526;1061.9415932123652;1075.4622688655672;1079.2984560036039;1081.1837063017529;1084.766775143348;6617.33826617344;6907.13660792401;6922.58464492132;6934.653267336613;6943.618101004493;6297.464715499143;7505;7707.383409327241;7753.728619498291;7790.571518566533;7012.298770123049;7018.684159212848;7032.648367581601;7032.859342813115;7046.1192350956135;3613.4941108244866;4126.979365103215;4174.77038762871;4182.728122672017;4190.3238704518435;7823.491473054233;8164.346852251806;8177.468464549905;8192.672293108328;8206.958965205136;7774.416918731004;8035.236652518001;8097.635606397726;8100.189981001853;8109.797255068671;8124.106348301682;8139;8146.307563857138;8148.022237331558;8178.959105204436;6380.553361264667;7828.491148075357;7854.646540905559;7876.291133797986;7886.645100970585;7524.787276108832;7656.272654097852;7725.22747725223;7735;7740.845183096194;8015.398845086525;8134.593270336578;8144.633491492778;8163.877541836996;8219;4138.8344466221015;4216.262154123077;4734.33719279308;4822.276658501112;4844.539768721966;7821.96089019574;7831.334336581454;7831.804204894923;7833.686652534063;7870.645820938186;6969.407600353824;7396.8534877094135;7518.323350898446;7532.698692052257;7546.773596791885;7457.216992215956;7500.36246919018;7513.774586762406;7524.322810947041;7567.470277080552;6009.549283803644;7341.816454588678;7358.117025956705;7383.2985866342615;7401.5189012714;6774;7251.637418129178;7467.701291948261;7488.288612581796;7540.132884718328;7142.750003749844;7245.492815502864;7340.669669864762;7352.41180705553;7463.888041679488 03:08:02 INFO - PROCESS | 1668 | |5;yui.html;691.3604915453207;715.7888422915241;760.6729106484213;768.880823472362;774.2683164409635;15203.23983800811;15233.23833808308;15445.845541544595;15686.764698529518;15692.215389230536;14467.78298325526;14480.927595362034;14553.272336383165;14583.906207034488;14612.12327260365;785.2893131715806;824.41054645928;972.7470857577046;1010.8079464901682;1011.1506334678868;991.6628346362236;994.597188138805;998.3111652959471;1004.5931397783872;1004.7337455574242;1010.8685870836781;1056.6618682021756;1067.2795862792623;1067.3062509368933;1070.8714954205507;1033.5452400943561;1044.4777611194402;1057.6721216422934;1059.0204061243319;1060.6953447259875;785.9803504912365;793.0602236349944;794.2375319693101;795.1690483444814;796.7291121018882;15226.314815833313;15235.695286094327;15268.770968435483;15294.464693735667;15295.08229506222;11655.417229138595;12500.312482813442;12669.873301267055;12682.556110536087;12715.109942304043;9827.579341377008;9884.950575247078;9996.100350968447;10029.648962286357;10072.395656260647;3485.790852548855;3495.6154822969706;3549.343371476285;3566.4293713006055;3723.4414837774552;82597.58701206515;83834.16165838325;86924.99999999937;87225.12774872234;87238;9543.997880222616;9562.235021198287;9828.557714902847;9881.456519891331;10132.986701329808;21752.129914803547;21948.670769938464;21967.011484483235;21990.120395184014;22085.558288834134;6917.031615573824;7066.081409416743;7122.821929451805;7124.715011399486;7158.570485770871;3767.7174211934216;3888.734297980581;4096.487939007624;4110.938335924963;4122.628963393309;3746.7189960753053;3754.023953772039;3759.605241449663;3787.5833658297565;3803.1062700265416;667.6895243711697;673.0610797936948;674.5109795398297;688.4733179117978;692.1106378303855;502.29678450170053;576.6165499942575;591.9911201331984;601.6269912654095;623.1556241293073;8198.549079800669;8282.71010514629;8290.170982901662;8379.539125348043;8440.324774018063;487.61234818318815;519.3585921387084;523.4843678976282;579.4755746049832;609.3632154398664;3779.4141908004303;3798.7150963677836;3925.3326934421216;3939.8621048263744;3992.740471869319;79834.60082699666;97229.0277097234;100964.99035009702;103284.93430131355;104613;84481;85135.72296415435;85842.57078714692;86059.56970215109;86164;61458.69270653618;76630.46739065187;77747.61126194333;78629.21370786219;79499;7825.718487499643;7837.529748215125;7909.24862138096;7921.128675845537;7929.920700792918;53776;53897;53924.19113713219;54599.454005461026;55157;71275.28724712894;72388.63805680937;73666.26333736593;76997.61501192459;77791;10635.94682026585;10752.13982881352;10894.400807955639;10917.781644367227;10921.290116142743;11991.460384282555;12085.81871271914;12106.93946530297;12139.393030348623;12492.125551211328;11207.103431725605;11406.543738250377;11473.598424055119;11561.421928903354;11610.477528511406;11096.278741882075;11334.433278336215;11368.602098926498;11624.128190385585;12125.151239413157;10708.625198118028;10864;10909.290896091728;10999.395033273247;11080.889191107986;9024.278057755495;9272.211861991536;9308.906910930804;9421.387609805615;9509.096635819862;9605.279604029585;9679.467629280176;9769.462679552693;9793.559289832117;9831 03:08:02 INFO - PROCESS | 1668 | __end_tp_report 03:08:02 INFO - PROCESS | 1668 | __start_cc_report 03:08:02 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,355 03:08:02 INFO - PROCESS | 1668 | __end_cc_report 03:08:02 INFO - PROCESS | 1668 | __startTimestamp1460542082392__endTimestamp 03:08:02 INFO - PROCESS | 1668 | 03:08:02 INFO - PROCESS | 1668 | ------- Summary: start ------- 03:08:02 INFO - PROCESS | 1668 | Number of tests: 6 03:08:02 INFO - PROCESS | 1668 | 03:08:02 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5857.82 Median:6136.30 stddev:656.79 (10.7%) stddev-sans-first:621.90 03:08:02 INFO - PROCESS | 1668 | Values: 3090.9 3166.8 3169.4 3536.8 3604.6 5863.7 5900.1 5902.7 5908.9 5923.0 5935.1 5969.5 5980.4 6022.8 6049.1 5329.3 5359.5 5435.3 5460.1 5479.8 5277.7 5386.8 5424.3 5503.3 5523.6 5385.8 5387.8 5392.4 5392.8 5413.6 5354.2 5391.8 5424.2 5437.7 5491.0 5317.5 5350.6 5394.2 5416.9 5431.4 5775.7 5925.6 5928.5 5962.0 6054.6 6127.2 6188.9 6195.8 6269.4 6305.6 6312.0 6330.8 6344.4 6345.2 6356.0 5834.2 5971.5 6055.8 6071.2 6080.8 6408.5 6420.0 6428.1 6458.3 6462.3 6261.4 6264.9 6269.1 6284.4 6286.0 6175.6 6228.6 6291.7 6313.0 6320.0 6211.7 6226.0 6263.6 6296.3 6300.4 6237.4 6251.4 6289.4 6312.3 6316.6 4930.3 4961.8 4996.5 5000.5 5063.3 3874.7 4502.0 4542.5 4547.7 4564.3 5503.7 5806.0 6006.5 6008.5 6025.5 6136.3 6144.4 6252.7 6283.6 6307.9 5963.3 5976.5 6008.5 6010.7 6015.8 5539.3 5547.8 5550.3 5554.4 5558.1 6332.3 6444.6 6497.4 6512.5 6522.0 6287.2 6303.2 6330.6 6341.4 6342.7 6325.6 6449.2 6458.4 6481.0 6481.1 5272.2 6203.0 6247.8 6257.2 6309.1 5277.0 6163.5 6267.9 6268.2 6321.6 5378.7 6164.4 6268.0 6280.1 6282.9 6155.9 6204.5 6247.9 6249.2 6272.9 5564.9 6146.3 6159.1 6208.4 6221.1 6118.6 6172.2 6176.2 6213.2 6272.5 6112.2 6140.4 6141.8 6146.2 6165.0 03:08:02 INFO - PROCESS | 1668 | 03:08:02 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:66067.79 Median:39655.20 stddev:142545.85 (359.5%) stddev-sans-first:142860.77 03:08:02 INFO - PROCESS | 1668 | Values: 520.3 594.2 601.6 628.5 668.4 33888.5 39591.6 39634.6 39675.8 39812.6 41006.6 41385.0 41615.2 41653.8 41659.6 9714.0 9967.7 9973.3 9990.9 9999.2 9774.9 9884.2 9890.0 9914.3 9937.0 8467.5 8568.3 9933.1 9954.0 9957.7 8990.2 9437.6 9898.8 9919.0 9925.5 9779.4 9920.3 9928.5 9934.5 9949.0 34997.0 35096.6 35268.8 35315.3 35393.1 3012.1 3264.3 3363.7 3484.8 3897.8 27827.4 28105.4 28106.7 28165.7 28432.6 2785.5 2792.3 2804.4 2850.6 2886.0 359923.2 361568.0 362574.0 363537.0 435480.5 49631.8 50035.0 68319.3 68953.6 68985.7 50431.0 50716.0 50733.0 51098.0 51218.5 17548.6 17668.6 17802.5 17812.8 17834.6 14041.3 14042.6 14113.5 14152.9 14169.7 15926.4 15978.8 15997.8 16008.4 16009.2 6011.8 6058.8 6405.1 6450.6 6513.2 953.7 968.5 988.3 991.2 1194.4 28418.7 29612.0 29711.6 29767.5 30192.7 1066.4 1100.9 1103.2 1148.3 1149.0 15202.6 15373.0 15413.5 15649.0 15705.5 666062.0 668183.0 673691.0 674126.0 676069.0 64046.0 64472.4 65283.3 65462.0 65917.0 1314.6 1503.8 1533.9 1536.3 1545.6 28953.0 29052.6 29711.3 29722.9 30535.5 46019.0 52844.5 52882.5 53048.5 53168.0 499575.0 509194.0 510987.0 511596.0 512308.0 34631.7 35558.0 35928.8 36353.8 36445.6 47081.8 47886.8 47915.8 48124.8 48448.3 39200.6 39243.0 39333.8 39899.0 40256.6 38724.4 39166.0 39220.8 39557.0 40174.8 38968.6 40017.6 40972.6 41738.0 41932.4 30485.0 33096.7 33673.5 33757.3 35067.8 23414.4 25180.0 25254.5 25491.0 25801.5 03:08:02 INFO - PROCESS | 1668 | 03:08:02 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:35262.27 Median:22169.72 stddev:104425.70 (471.0%) stddev-sans-first:104685.78 03:08:02 INFO - PROCESS | 1668 | Values: 375.2 376.8 381.4 386.3 387.1 19989.8 20612.9 20884.8 21147.4 21232.0 20313.4 21130.3 21923.9 22160.7 22178.8 5258.8 5358.8 5439.0 5444.6 5444.8 5171.7 5914.2 5970.4 6027.6 6034.6 5665.8 5923.5 5938.6 5967.3 5986.6 5858.6 5881.5 5893.2 5942.0 5969.2 5080.3 5202.6 5220.8 5274.8 5281.8 13686.2 13984.9 24827.6 25899.5 26781.3 2009.9 2148.2 2155.0 2318.0 2796.5 9708.0 9856.6 10082.3 10136.8 10167.2 1719.4 1746.4 1747.4 1767.3 1797.7 79806.8 80798.0 111684.4 113044.7 114949.0 9816.0 11326.6 11370.2 11438.9 11784.2 14018.6 14114.8 14143.4 14214.4 14215.9 7515.4 8935.8 8990.7 9043.7 9071.8 7368.9 9161.5 9181.4 9287.5 9318.6 3947.4 4561.3 4678.4 4702.8 4703.5 1644.0 1976.4 1985.5 2017.9 2026.7 878.5 882.1 904.8 1034.6 1086.2 19906.5 20247.5 20381.4 20744.6 20892.0 993.3 993.6 1024.2 1029.7 1044.4 10944.9 11197.8 11266.6 11281.4 11343.8 560383.0 621674.0 639792.0 654757.0 665048.0 121440.0 127006.0 127440.4 129009.0 130313.0 886.7 1096.8 1101.4 1108.4 1111.8 18352.3 18907.4 19018.7 19034.5 19281.4 51566.7 52253.0 52936.0 53162.2 53275.0 69085.7 76246.6 76804.6 78846.0 82347.6 7746.9 8074.8 8083.5 8141.8 8196.6 9529.9 13026.7 13074.9 13353.7 13477.7 11655.8 11665.2 11688.8 11712.3 12161.3 9785.7 11423.0 11492.5 11810.9 11832.0 11697.4 12002.3 12076.7 12184.9 12211.6 7938.0 8131.7 8196.2 8299.8 8499.6 11903.6 11908.9 11993.2 11994.6 12060.9 03:08:02 INFO - PROCESS | 1668 | 03:08:02 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6303.74 Median:529.88 stddev:3341.47 (630.6%) stddev-sans-first:3332.59 03:08:02 INFO - PROCESS | 1668 | Values: 1657.6 1685.6 2006.8 2011.9 2102.7 8370.4 8963.1 9003.2 9248.9 9268.5 9074.5 9076.9 9136.5 9173.0 9177.3 2550.5 2579.1 2583.0 2586.1 2601.1 2519.1 2530.9 2531.8 2532.9 2535.9 2279.7 2542.1 2570.8 2576.0 2585.0 2545.0 2558.8 2564.6 2569.5 2583.9 2316.6 2530.5 2532.4 2535.1 2535.7 8189.1 8916.7 9067.5 9278.0 9324.0 5583.1 5741.7 5742.7 5802.3 5808.9 3199.5 3660.1 3722.7 3771.6 3783.7 967.0 1001.1 1018.4 1093.7 1105.2 12247.3 12421.8 12443.0 12449.0 12458.9 4953.6 5033.7 5043.6 5111.9 5128.5 10495.0 10589.3 10595.2 10598.9 10604.0 5662.9 5754.9 5765.0 5770.0 5791.5 4266.7 5034.1 5117.2 5178.4 5179.6 4087.4 4115.2 4146.2 4156.4 4163.6 1330.0 1339.6 1343.5 1348.0 1368.2 1399.6 1417.6 1428.6 1439.9 1446.3 8472.1 8485.9 8515.7 8517.9 8524.8 515.2 526.6 528.2 531.6 531.8 5643.8 6209.6 6233.3 6386.2 6388.5 10894.8 11216.5 11237.4 11265.1 11325.2 10683.1 10932.2 11025.3 11112.2 11193.2 8664.9 8669.9 8684.2 8722.4 8774.1 8093.4 8218.8 8279.0 8389.4 8576.4 9480.8 9787.7 9880.9 9893.7 9906.0 9990.0 10163.7 10243.7 10319.9 10356.8 7828.1 7866.6 7879.1 7937.4 7994.7 8553.3 8562.6 8575.9 8603.9 8664.9 7362.6 7673.8 7926.4 8032.1 8152.9 7757.1 7887.6 7906.2 7953.3 7990.3 7867.1 7907.1 7929.8 7983.5 7993.3 7227.7 7233.4 7277.0 7283.0 7296.2 7166.7 7493.3 7507.8 7534.8 7537.9 03:08:02 INFO - PROCESS | 1668 | 03:08:02 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:6047.05 Median:6913.57 stddev:1999.95 (28.9%) stddev-sans-first:1959.07 03:08:02 INFO - PROCESS | 1668 | Values: 334.9 335.6 345.6 345.8 346.0 5616.9 6920.0 7008.8 7015.9 7103.0 6049.8 6314.9 6602.4 6971.6 6989.8 4352.9 4834.4 4953.5 5059.3 5083.0 4140.3 5045.4 5079.6 5084.8 5086.0 4091.7 5020.7 5048.1 5069.1 5447.6 5027.8 5043.5 5055.6 5063.0 5103.4 4356.8 4368.3 4371.8 4373.6 4384.3 6425.7 6738.3 6746.6 6747.4 6831.8 5911.3 5924.9 5943.2 5945.0 5957.1 7436.7 7447.3 7457.8 7461.0 7484.7 4028.2 4711.9 4720.6 4726.8 4728.3 6697.7 7510.7 7875.2 7887.2 7905.5 3820.6 4688.2 4753.8 4762.5 4790.0 4882.6 4885.1 4888.2 4888.7 4894.1 5894.0 5897.5 5902.7 5924.6 5935.8 7488.6 7506.4 7528.1 7547.6 7556.8 1622.4 1680.3 1695.6 1701.8 1705.1 1061.9 1075.5 1079.3 1081.2 1084.8 6617.3 6907.1 6922.6 6934.7 6943.6 6297.5 7505.0 7707.4 7753.7 7790.6 7012.3 7018.7 7032.6 7032.9 7046.1 3613.5 4127.0 4174.8 4182.7 4190.3 7823.5 8164.3 8177.5 8192.7 8207.0 7774.4 8035.2 8097.6 8100.2 8109.8 8124.1 8139.0 8146.3 8148.0 8179.0 6380.6 7828.5 7854.6 7876.3 7886.6 7524.8 7656.3 7725.2 7735.0 7740.8 8015.4 8134.6 8144.6 8163.9 8219.0 4138.8 4216.3 4734.3 4822.3 4844.5 7822.0 7831.3 7831.8 7833.7 7870.6 6969.4 7396.9 7518.3 7532.7 7546.8 7457.2 7500.4 7513.8 7524.3 7567.5 6009.5 7341.8 7358.1 7383.3 7401.5 6774.0 7251.6 7467.7 7488.3 7540.1 7142.8 7245.5 7340.7 7352.4 7463.9 03:08:02 INFO - PROCESS | 1668 | 03:08:02 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:19248.37 Median:494.95 stddev:27741.47 (5604.9%) stddev-sans-first:27784.30 03:08:02 INFO - PROCESS | 1668 | Values: 691.4 715.8 760.7 768.9 774.3 15203.2 15233.2 15445.8 15686.8 15692.2 14467.8 14480.9 14553.3 14583.9 14612.1 785.3 824.4 972.7 1010.8 1011.2 991.7 994.6 998.3 1004.6 1004.7 1010.9 1056.7 1067.3 1067.3 1070.9 1033.5 1044.5 1057.7 1059.0 1060.7 786.0 793.1 794.2 795.2 796.7 15226.3 15235.7 15268.8 15294.5 15295.1 11655.4 12500.3 12669.9 12682.6 12715.1 9827.6 9885.0 9996.1 10029.6 10072.4 3485.8 3495.6 3549.3 3566.4 3723.4 82597.6 83834.2 86925.0 87225.1 87238.0 9544.0 9562.2 9828.6 9881.5 10133.0 21752.1 21948.7 21967.0 21990.1 22085.6 6917.0 7066.1 7122.8 7124.7 7158.6 3767.7 3888.7 4096.5 4110.9 4122.6 3746.7 3754.0 3759.6 3787.6 3803.1 667.7 673.1 674.5 688.5 692.1 502.3 576.6 592.0 601.6 623.2 8198.5 8282.7 8290.2 8379.5 8440.3 487.6 519.4 523.5 579.5 609.4 3779.4 3798.7 3925.3 3939.9 3992.7 79834.6 97229.0 100965.0 103284.9 104613.0 84481.0 85135.7 85842.6 86059.6 86164.0 61458.7 76630.5 77747.6 78629.2 79499.0 7825.7 7837.5 7909.2 7921.1 7929.9 53776.0 53897.0 53924.2 54599.5 55157.0 71275.3 72388.6 73666.3 76997.6 77791.0 10635.9 10752.1 10894.4 10917.8 10921.3 11991.5 12085.8 12106.9 12139.4 12492.1 11207.1 11406.5 11473.6 11561.4 11610.5 11096.3 11334.4 11368.6 11624.1 12125.2 10708.6 10864.0 10909.3 10999.4 11080.9 9024.3 9272.2 9308.9 9421.4 9509.1 9605.3 9679.5 9769.5 9793.6 9831.0 03:08:02 INFO - PROCESS | 1668 | -------- Summary: end -------- 03:08:02 INFO - PROCESS | 1668 | 03:08:02 INFO - TEST-INFO | 1668: exit 0 03:08:02 INFO - TEST-OK | dromaeo_css | took 1111263ms 03:08:02 INFO - TEST-START | kraken 03:08:02 INFO - operating with platform_type : mac_ 03:08:02 INFO - Initialising browser for kraken test... 03:08:02 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpjp7Bcf/profile http://localhost:49276/getInfo.html) 03:08:05 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 03:08:05 INFO - PROCESS | 1680 | colorDepth:24 03:08:05 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 03:08:05 INFO - PROCESS | 1680 | __metrics 03:08:05 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:08:06 INFO - TEST-INFO | 1680: exit 0 03:08:06 INFO - Browser initialized. 03:08:06 INFO - Running cycle 1/1 for kraken test... 03:08:06 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpjp7Bcf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:18 INFO - PROCESS | 1684 | RSS: Main: 218095616 03:08:18 INFO - PROCESS | 1684 | 03:08:21 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:21 INFO - PROCESS | 1684 | RSS: Main: 229707776 03:08:21 INFO - PROCESS | 1684 | 03:08:24 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 03:08:25 INFO - PROCESS | 1684 | RSS: Main: 238465024 03:08:25 INFO - PROCESS | 1684 | 03:08:28 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 03:08:28 INFO - PROCESS | 1684 | RSS: Main: 242057216 03:08:28 INFO - PROCESS | 1684 | 03:08:30 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 03:08:31 INFO - PROCESS | 1684 | RSS: Main: 242647040 03:08:31 INFO - PROCESS | 1684 | 03:08:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:33 INFO - PROCESS | 1684 | RSS: Main: 244170752 03:08:33 INFO - PROCESS | 1684 | 03:08:36 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:37 INFO - PROCESS | 1684 | RSS: Main: 244355072 03:08:37 INFO - PROCESS | 1684 | 03:08:40 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:40 INFO - PROCESS | 1684 | RSS: Main: 244363264 03:08:40 INFO - PROCESS | 1684 | 03:08:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 03:08:44 INFO - PROCESS | 1684 | RSS: Main: 244506624 03:08:44 INFO - PROCESS | 1684 | 03:08:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:46 INFO - PROCESS | 1684 | RSS: Main: 244195328 03:08:46 INFO - PROCESS | 1684 | 03:08:48 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:49 INFO - PROCESS | 1684 | RSS: Main: 244154368 03:08:49 INFO - PROCESS | 1684 | 03:08:51 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:51 INFO - PROCESS | 1684 | RSS: Main: 244584448 03:08:51 INFO - PROCESS | 1684 | 03:08:54 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:55 INFO - PROCESS | 1684 | RSS: Main: 244547584 03:08:55 INFO - PROCESS | 1684 | 03:08:57 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:08:58 INFO - PROCESS | 1684 | RSS: Main: 244645888 03:08:58 INFO - PROCESS | 1684 | 03:08:59 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 03:09:00 INFO - PROCESS | 1684 | RSS: Main: 246554624 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | __start_tp_report 03:09:00 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 03:09:00 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 03:09:00 INFO - PROCESS | 1684 | |i|pagename|runs| 03:09:00 INFO - PROCESS | 1684 | |0;ai-astar;115;107;114;148;169;161;114;114;114;115 03:09:00 INFO - PROCESS | 1684 | |1;audio-beat-detection;144;119;154;146;119;137;121;149;144;119 03:09:00 INFO - PROCESS | 1684 | |2;audio-dft;194;196;188;200;194;201;200;201;202;199 03:09:00 INFO - PROCESS | 1684 | |3;audio-fft;70;62;74;108;70;58;57;59;125;57 03:09:00 INFO - PROCESS | 1684 | |4;audio-oscillator;82;83;122;78;80;83;117;78;80;115 03:09:00 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;88;85;89;109;135;121;89;85;87;85 03:09:00 INFO - PROCESS | 1684 | |6;imaging-darkroom;104;95;93;95;94;94;95;95;93;93 03:09:00 INFO - PROCESS | 1684 | |7;imaging-desaturate;98;93;122;77;148;144;140;93;117;143 03:09:00 INFO - PROCESS | 1684 | |8;json-parse-financial;56;62;61;59;60;59;61;68;58;55 03:09:00 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;62;65;67;79;76;63;102;93;95;88 03:09:00 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;84;80;84;83;106;70;101;97;78;109 03:09:00 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;130;133;119;119;127;139;121;124;121;131 03:09:00 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;137;135;136;133;126;139;139;136;134;136 03:09:00 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;67;66;70;64;67;66;64;65;67;65 03:09:00 INFO - PROCESS | 1684 | __end_tp_report 03:09:00 INFO - PROCESS | 1684 | __start_cc_report 03:09:00 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,936 03:09:00 INFO - PROCESS | 1684 | __end_cc_report 03:09:00 INFO - PROCESS | 1684 | __startTimestamp1460542140125__endTimestamp 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | ------- Summary: start ------- 03:09:00 INFO - PROCESS | 1684 | Number of tests: 14 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:127.10 Median:115.00 stddev:22.91 (19.9%) stddev-sans-first:23.88 03:09:00 INFO - PROCESS | 1684 | Values: 115.0 107.0 114.0 148.0 169.0 161.0 114.0 114.0 114.0 115.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:144.00 stddev:14.17 (9.8%) stddev-sans-first:14.67 03:09:00 INFO - PROCESS | 1684 | Values: 144.0 119.0 154.0 146.0 119.0 137.0 121.0 149.0 144.0 119.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:197.50 Median:200.00 stddev:4.43 (2.2%) stddev-sans-first:4.51 03:09:00 INFO - PROCESS | 1684 | Values: 194.0 196.0 188.0 200.0 194.0 201.0 200.0 201.0 202.0 199.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:74.00 Median:60.50 stddev:23.55 (38.9%) stddev-sans-first:24.94 03:09:00 INFO - PROCESS | 1684 | Values: 70.0 62.0 74.0 108.0 70.0 58.0 57.0 59.0 125.0 57.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:80.00 stddev:18.24 (22.8%) stddev-sans-first:19.00 03:09:00 INFO - PROCESS | 1684 | Values: 82.0 83.0 122.0 78.0 80.0 83.0 117.0 78.0 80.0 115.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:97.30 Median:86.00 stddev:17.96 (20.9%) stddev-sans-first:18.73 03:09:00 INFO - PROCESS | 1684 | Values: 88.0 85.0 89.0 109.0 135.0 121.0 89.0 85.0 87.0 85.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:94.50 stddev:3.25 (3.4%) stddev-sans-first:0.93 03:09:00 INFO - PROCESS | 1684 | Values: 104.0 95.0 93.0 95.0 94.0 94.0 95.0 95.0 93.0 93.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:117.50 Median:112.50 stddev:25.89 (23.0%) stddev-sans-first:26.48 03:09:00 INFO - PROCESS | 1684 | Values: 98.0 93.0 122.0 77.0 148.0 144.0 140.0 93.0 117.0 143.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.50 stddev:3.60 (6.0%) stddev-sans-first:3.54 03:09:00 INFO - PROCESS | 1684 | Values: 56.0 62.0 61.0 59.0 60.0 59.0 61.0 68.0 58.0 55.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:79.00 Median:77.50 stddev:14.74 (19.0%) stddev-sans-first:14.30 03:09:00 INFO - PROCESS | 1684 | Values: 62.0 65.0 67.0 79.0 76.0 63.0 102.0 93.0 95.0 88.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:81.50 stddev:13.10 (16.1%) stddev-sans-first:13.76 03:09:00 INFO - PROCESS | 1684 | Values: 84.0 80.0 84.0 83.0 106.0 70.0 101.0 97.0 78.0 109.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:128.50 stddev:6.75 (5.3%) stddev-sans-first:7.04 03:09:00 INFO - PROCESS | 1684 | Values: 130.0 133.0 119.0 119.0 127.0 139.0 121.0 124.0 121.0 131.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.10 Median:136.00 stddev:3.73 (2.7%) stddev-sans-first:3.89 03:09:00 INFO - PROCESS | 1684 | Values: 137.0 135.0 136.0 133.0 126.0 139.0 139.0 136.0 134.0 136.0 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.79 (2.7%) stddev-sans-first:1.87 03:09:00 INFO - PROCESS | 1684 | Values: 67.0 66.0 70.0 64.0 67.0 66.0 64.0 65.0 67.0 65.0 03:09:00 INFO - PROCESS | 1684 | -------- Summary: end -------- 03:09:00 INFO - PROCESS | 1684 | 03:09:00 INFO - TEST-INFO | 1684: exit 0 03:09:00 INFO - TEST-OK | kraken | took 58025ms 03:09:00 INFO - SUITE-END | took 1169s 03:09:01 INFO - Completed test suite (00:19:29) 03:09:01 INFO - javascript benchmark 03:09:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3090.9381812363745, 3166.7941583797065, 3169.4136584731827, 3536.7524273300846, 3604.5674519057716, 5863.677497737623, 5900.11498275259, 5902.704864756755, 5908.911366329503, 5923.022701254294, 5935.139404786314, 5969.522438204944, 5980.431858973401, 6022.819315420534, 6049.06239532872, 5329.307190065296, 5359.5444387227135, 5435.347758269013, 5460.126379779236, 5479.753411096491, 5277.736113194344, 5386.757595908174, 5424.267723857268, 5503.3120859892515, 5523.558115350783, 5385.81149659762, 5387.838364849061, 5392.433794451585, 5392.811251606195, 5413.64811287267, 5354.170103633924, 5391.81128660495, 5424.213489044106, 5437.673739575638, 5490.972545137289, 5317.494837990384, 5350.5987050971335, 5394.190871369326, 5416.891662166774, 5431.402545719968, 5775.653460792324, 5925.614835035709, 5928.49607783339, 5961.956657584905, 6054.606450580698, 6127.189528148586, 6188.87622247557, 6195.783147589813, 6269.435750782452, 6305.621662700252, 6312.0, 6330.778422755181, 6344.397282258178, 6345.206849143857, 6356.014817703263, 5834.241548598655, 5971.4924231439945, 6055.757769689207, 6071.150038994544, 6080.787172448943, 6408.51936104794, 6419.972804351281, 6428.100065990765, 6458.257300410513, 6462.256840463313, 6261.405166509175, 6264.874702505925, 6269.122322874801, 6284.402981716729, 6285.968570157212, 6175.5677102602385, 6228.626282423069, 6291.653959032205, 6312.968435157886, 6319.96840015797, 6211.65835879022, 6226.0, 6263.561550691408, 6296.275928268216, 6300.432961033437, 6237.438630523184, 6251.4061164189325, 6289.402506761941, 6312.274088479791, 6316.589421687576, 4930.309756634074, 4961.776720047535, 4996.525330093636, 5000.524950129732, 5063.316452278895, 3874.748141370802, 4502.009557897258, 4542.500324964251, 4547.681662283609, 4564.3153526970555, 5503.724813759296, 5806.0, 6006.549508786771, 6008.519318454513, 6025.517958563304, 6136.304638670978, 6144.3717414885095, 6252.6873656317, 6283.622982621057, 6307.905381419282, 5963.344032156459, 5976.491998180203, 6008.549358798107, 6010.729517171738, 6015.796840631891, 5539.335279766454, 5547.77808887648, 5550.306211723535, 5554.361248456398, 5558.082916318843, 6332.303446620868, 6444.613323200623, 6497.447716944018, 6512.544121911421, 6522.0, 6287.2140982377205, 6303.243610766737, 6330.588511746721, 6341.365863413622, 6342.651154186379, 6325.588836725598, 6449.226092868886, 6458.418742313214, 6481.0, 6481.125048118443, 5272.209168624737, 6202.968985155046, 6247.812565623039, 6257.217847769029, 6309.148264984168, 5276.973615132053, 6163.476104531165, 6267.905981410191, 6268.153799237227, 6321.557490975588, 5378.650387724785, 6164.383561643979, 6267.9971204607045, 6280.0893870389455, 6282.937170628418, 6155.922713525205, 6204.534659900435, 6247.875042499034, 6249.156363890998, 6272.937270627418, 5564.860878477908, 6146.323904370426, 6159.106929495288, 6208.379162083756, 6221.06683997404, 6118.632882027093, 6172.166757487861, 6176.227971503562, 6213.1922850029205, 6272.466840318624, 6112.169143789106, 6140.3596453525415, 6141.8464538385115, 6146.200993870768, 6164.982777841786], "unit": "score", "name": "dojo.html", "value": 5814.848122721234}, {"lowerIsBetter": false, "replicates": [520.3261776000082, 594.2245369792422, 601.5578549765919, 628.5160426471615, 668.372512931013, 33888.4916726249, 39591.60408395915, 39634.60365396349, 39675.80162099186, 39812.60187398121, 41006.589934100724, 41384.96537586554, 41615.16769664605, 41653.75038748842, 41659.58340416595, 9713.980032096633, 9967.651132210374, 9973.252006099536, 9990.90009099907, 9999.150072243869, 9774.902250977506, 9884.209263258923, 9890.0, 9914.256430767686, 9937.006299370041, 8467.53428561432, 8568.271696905771, 9933.106020458157, 9953.950230248875, 9957.651482198124, 8990.235829954461, 9437.622495100188, 9898.752531186778, 9919.0, 9925.50372481373, 9779.364341317792, 9920.305578609501, 9928.45393503357, 9934.45360505172, 9949.0, 34996.950091497296, 35096.64903350985, 35268.82365588181, 35315.293694125976, 35393.11517212065, 3012.141539661208, 3264.27438540842, 3363.7477189210663, 3484.79091254523, 3897.7661340319673, 27827.443451130865, 28105.43789124206, 28106.718932810614, 28165.718342816515, 28432.573511397346, 2785.456835916997, 2792.274008757717, 2804.3970546332434, 2850.558163484663, 2886.033178885055, 359923.2003839964, 361568.0, 362574.0, 363537.0, 435480.46779298654, 49631.75184124128, 50035.0, 68319.3168068313, 68953.58662446891, 68985.65507172432, 50430.99138017219, 50715.985680286925, 50733.0, 51098.0, 51218.48781512212, 17548.561285967953, 17668.646627067643, 17802.46592602224, 17812.821871781376, 17834.643307133785, 14041.297935103205, 14042.648933776738, 14113.506027288995, 14152.858471415155, 14169.716605667829, 15926.362945482051, 15978.76031859523, 15997.760033599505, 16008.359665613245, 16009.199540023184, 6011.797640471836, 6058.757649694051, 6405.135306733531, 6450.612963222222, 6513.218413790375, 953.6709835106877, 968.4963818814177, 988.3229987458614, 991.1624677147798, 1194.4147367789894, 28418.71581284202, 29612.0, 29711.554326685116, 29767.478889988794, 30192.698073019426, 1066.3761699405934, 1100.8954149355798, 1103.189155970361, 1148.2593727046008, 1149.0233301693493, 15202.619934501505, 15373.0, 15413.46052888166, 15649.0, 15705.528834134766, 666062.0, 668183.0, 673691.0, 674126.0, 676069.0, 64046.0, 64472.355276447575, 65283.347166527725, 65462.0, 65917.01124483136, 1314.5530519623373, 1503.8496150384874, 1533.8619524242872, 1536.2779493637972, 1545.6058705030146, 28953.0, 29052.56421153727, 29711.257218568844, 29722.85138574293, 30535.54196687007, 46019.0, 52844.471555283955, 52882.471175287756, 53048.46951530435, 53168.0, 499575.0, 509194.0, 510987.0, 511596.0, 512308.0, 34631.653683463854, 35558.0, 35928.8203558991, 36353.81823090868, 36445.63554364529, 47081.76459117683, 47886.76056619834, 47915.76042119767, 48124.75937620289, 48448.27327590019, 39200.60799391969, 39243.0, 39333.80333098316, 39899.0, 40256.59743402646, 38724.41913371358, 39166.0, 39220.80389598034, 39557.0, 40174.79475615736, 38968.6103138965, 40017.59982400139, 40972.590274096874, 41738.0, 41932.3710144342, 30485.0, 33096.66903330936, 33673.49489757606, 33757.3248535023, 35067.82466087653, 23414.414639634146, 25180.0, 25254.494910101326, 25491.0, 25801.483970320864], "unit": "score", "name": "ext.html", "value": 19889.345437178672}, {"lowerIsBetter": false, "replicates": [375.20269427466616, 376.75322663655317, 381.3555091894698, 386.3027235839309, 387.1347538252008, 19989.800611963274, 20612.866292353916, 20884.791152088474, 21147.365579032616, 21232.04455799489, 20313.390598282076, 21130.260440884573, 21923.890380548113, 22160.667589986162, 22178.778212217872, 5258.763355649005, 5358.758855851496, 5439.0209762242785, 5444.646098003637, 5444.8366549003595, 5171.7414129293575, 5914.172015917775, 5970.402959704016, 6027.638341699512, 6034.577579569432, 5665.801696940608, 5923.496502797268, 5938.584299099065, 5967.254093238345, 5986.551008674345, 5858.648481091127, 5881.5294776417995, 5893.233879595647, 5942.049272116441, 5969.224000879901, 5080.339555857715, 5202.557782588485, 5220.765065572058, 5274.7626356814035, 5281.785189406458, 13686.247256400893, 13984.881209503215, 24827.62758558623, 25899.482010359876, 26781.33046673829, 2009.9296524621568, 2148.237375731624, 2154.967675484869, 2317.988410057939, 2796.5106106431294, 9707.951460242724, 9856.556454959544, 10082.344647597884, 10136.797264054678, 10167.237457190666, 1719.355241784331, 1746.3713063297203, 1747.3884140550706, 1767.2930827668906, 1797.694391953358, 79806.80289795657, 80798.0, 111684.44157779159, 113044.73910521744, 114949.0, 9816.0, 11326.603568875049, 11370.204085714086, 11438.885611143782, 11784.234024788362, 14018.649533761738, 14114.788278175836, 14143.363548640336, 14214.360353784105, 14215.867619857105, 7515.361194298546, 8935.821283574292, 8990.685326013558, 9043.728688139367, 9071.773205669779, 7368.9366977246455, 9161.450312981242, 9181.449113053239, 9287.489188094585, 9318.618328739083, 3947.388154836005, 4561.29299958507, 4678.415198100238, 4702.835400760957, 4703.482616912137, 1643.958901027484, 1976.4070778766313, 1985.4540001499704, 2017.878927264369, 2026.6757318828916, 878.4597472554333, 882.1311008656596, 904.8235594059096, 1034.6482196053228, 1086.2070688397514, 19906.50233744168, 20247.493812654506, 20381.388558343275, 20744.58510829775, 20891.95540222983, 993.2897977945803, 993.5826952679892, 1024.2369434771142, 1029.7477118106112, 1044.399470304578, 10944.890551094546, 11197.77489631697, 11266.564067715268, 11281.379524126252, 11343.773124537463, 560383.0, 621674.0, 639792.0, 654757.0, 665048.0, 121440.0, 127006.0, 127440.36279818727, 129009.0, 130313.0, 886.7073865624328, 1096.8245080787035, 1101.3832253937821, 1108.3626914524182, 1111.8165502691966, 18352.265909363476, 18907.43277701616, 19018.714719278945, 19034.52413689669, 19281.4215573533, 51566.74216628893, 52253.0, 52936.0, 53162.202566960754, 53275.0, 69085.65457172682, 76246.61876690581, 76804.61597691975, 78846.0, 82347.5882620583, 7746.92253077462, 8074.798130046795, 8083.514989100673, 8141.755747327589, 8196.631151598072, 9529.857052144085, 13026.674333141747, 13074.869251307366, 13353.66615834573, 13477.663058423226, 11655.825162622397, 11665.246020945775, 11688.766224675628, 11712.297262164297, 12161.270323780602, 9785.706428807147, 11423.0, 11492.54029838797, 11810.940945295219, 11831.994280486255, 11697.415129243675, 12002.339871306813, 12076.698082548006, 12184.878151218374, 12211.572594959134, 7938.0, 8131.71538996156, 8196.180381961994, 8299.83400332002, 8499.575021249037, 11903.583374581847, 11908.940455297668, 11993.160478766402, 11994.64016079519, 12060.939695301468], "unit": "score", "name": "jquery.html", "value": 9562.115333426416}, {"lowerIsBetter": false, "replicates": [1657.6187476880318, 1685.5533283679827, 2006.832620769569, 2011.8893460859656, 2102.716133322003, 8370.414071015031, 8963.148500892405, 9003.189712925836, 9248.861267081, 9268.536573171332, 9074.455532668044, 9076.90923090769, 9136.497492637918, 9173.036831132718, 9177.265818734502, 2550.54090263752, 2579.1359894435386, 2583.005542865991, 2586.0819409109777, 2601.0636170978432, 2519.143491212987, 2530.8608026558622, 2531.822772405923, 2532.873356332176, 2535.8732063396847, 2279.6922415473946, 2542.0975553678454, 2570.8457492550506, 2575.9742402576017, 2585.0, 2544.9745502545015, 2558.8336758110663, 2564.5512035393826, 2569.4604133132066, 2583.8708064596694, 2316.559853627822, 2530.493901219745, 2532.392225865797, 2535.074697735332, 2535.6576862123748, 8189.099199088096, 8916.687915922912, 9067.455952642862, 9277.979422263546, 9323.953380233123, 5583.134614134816, 5741.655500669932, 5742.655440673573, 5802.274715660543, 5808.912866307009, 3199.520071989197, 3660.1032746976894, 3722.7394082414244, 3771.622837716234, 3783.735138540303, 966.9758256043655, 1001.064005155175, 1018.3737001743948, 1093.6882988348361, 1105.182165197748, 12247.265164090182, 12421.813672794915, 12443.004559635297, 12449.0, 12458.937705311415, 4953.554180123806, 5033.748312584356, 5043.621728370387, 5111.948880511221, 5128.461511541309, 10495.00297471739, 10589.258751887448, 10595.152387808957, 10598.894011059945, 10604.0, 5662.886742265132, 5754.942450575524, 5764.971175144097, 5769.9711501442225, 5791.478766910914, 4266.658667306608, 5034.11902916988, 5117.155669314521, 5178.352705911761, 5179.637425380262, 4087.3664581989838, 4115.218108559364, 4146.212219678312, 4156.418101465797, 4163.5836416358125, 1330.0490149543123, 1339.5867359935362, 1343.4827591377195, 1347.9865201348057, 1368.1927662679068, 1399.6360946154073, 1417.6455886028493, 1428.5785693220525, 1439.9208043557496, 1446.3491428857055, 8472.068072512018, 8485.872711909326, 8515.701950431705, 8517.914820851713, 8524.829503410021, 515.2451658320504, 526.6208330002393, 528.1892295326655, 531.5614617940215, 531.7553925194377, 5643.830685079454, 6209.627422354673, 6233.283172435228, 6386.201724784402, 6388.520860935449, 10894.836577451344, 11216.495257713423, 11237.38194399316, 11265.098792096776, 11325.150613704005, 10683.14534837211, 10932.234743568033, 11025.283356581796, 11112.222144449972, 11193.216474846682, 8664.8700269496, 8669.869951950726, 8684.2184203422, 8722.389432739774, 8774.078721734126, 8093.392995525477, 8218.794530136794, 8278.958605206935, 8389.370797190357, 8576.356773241907, 9480.810383792423, 9787.706368808947, 9880.85178722334, 9893.65372211969, 9906.0, 9990.0, 10163.695089147337, 10243.7439064024, 10319.896801032193, 10356.792864142826, 7828.060632724109, 7866.6066696666085, 7879.133295337394, 7937.365010799007, 7994.720184793504, 8553.272971797218, 8562.614682339185, 8575.87136192945, 8603.870941935751, 8664.91335086641, 7362.6318684066655, 7673.769786906401, 7926.365890728844, 8032.116467188488, 8152.877706834521, 7757.146713861358, 7887.64505597238, 7906.248906353887, 7953.2842044216295, 7990.3208227299, 7867.134615192439, 7907.130215676156, 7929.841403171788, 7983.520988740462, 7993.320567751806, 7227.710891564278, 7233.421326293778, 7276.96361518189, 7282.980382746526, 7296.160941491797, 7166.713331466683, 7493.288137626917, 7507.774766757006, 7534.811629709301, 7537.924620753723], "unit": "score", "name": "mootools.html", "value": 5050.4445390915525}, {"lowerIsBetter": false, "replicates": [334.89785615387314, 335.605663345569, 345.63535470079063, 345.80289235135984, 345.96367381424966, 5616.943830561693, 6920.0, 7008.754693585719, 7015.859682806347, 7102.9644851775665, 6049.790041991598, 6314.873702525947, 6602.405783479486, 6971.6165610891385, 6989.755358562451, 4352.89117772055, 4834.395700537441, 4953.504649535053, 5059.266406371074, 5083.0, 4140.337545992642, 5045.4450010499, 5079.568236699885, 5084.8220312288895, 5085.982803439309, 4091.6931230157707, 5020.723860187688, 5048.1418158913075, 5069.087564238435, 5447.591430642698, 5027.849164525033, 5043.495650434946, 5055.620828437864, 5062.96209277101, 5103.438621751604, 4356.8257269709175, 4368.344748287782, 4371.759553224571, 4373.606375426195, 4384.254676704968, 6425.678716064178, 6738.326167383271, 6746.595204287759, 6747.392734653905, 6831.760888368933, 5911.349751527328, 5924.940750592482, 5943.227380440559, 5944.97027514864, 5957.076653118774, 7436.702531898718, 7447.2552744725635, 7457.813554661123, 7460.962695186544, 7484.700611975514, 4028.2144981728575, 4711.929321060187, 4720.57514823664, 4726.787294571753, 4728.314394412825, 6697.6986035628515, 7510.6620202091035, 7875.173106823759, 7887.211278872067, 7905.5256684598535, 3820.598837122118, 4688.249880019181, 4753.809847606126, 4762.476127625959, 4790.0, 4882.584980276645, 4885.1206782779445, 4888.2178851383605, 4888.731119788375, 4894.094592500328, 5893.970530147321, 5897.498712609477, 5902.734376952962, 5924.555658325643, 5935.821925342247, 7488.5506869588, 7506.437017223621, 7528.134264559536, 7547.5848828314965, 7556.773296801105, 1622.4078211452734, 1680.3110724602855, 1695.5591546198077, 1701.8213087625868, 1705.104819969526, 1061.9415932123652, 1075.4622688655672, 1079.2984560036039, 1081.1837063017529, 1084.766775143348, 6617.33826617344, 6907.13660792401, 6922.58464492132, 6934.653267336613, 6943.618101004493, 6297.464715499143, 7505.0, 7707.383409327241, 7753.728619498291, 7790.571518566533, 7012.298770123049, 7018.684159212848, 7032.648367581601, 7032.859342813115, 7046.1192350956135, 3613.4941108244866, 4126.979365103215, 4174.77038762871, 4182.728122672017, 4190.3238704518435, 7823.491473054233, 8164.346852251806, 8177.468464549905, 8192.672293108328, 8206.958965205136, 7774.416918731004, 8035.236652518001, 8097.635606397726, 8100.189981001853, 8109.797255068671, 8124.106348301682, 8139.0, 8146.307563857138, 8148.022237331558, 8178.959105204436, 6380.553361264667, 7828.491148075357, 7854.646540905559, 7876.291133797986, 7886.645100970585, 7524.787276108832, 7656.272654097852, 7725.22747725223, 7735.0, 7740.845183096194, 8015.398845086525, 8134.593270336578, 8144.633491492778, 8163.877541836996, 8219.0, 4138.8344466221015, 4216.262154123077, 4734.33719279308, 4822.276658501112, 4844.539768721966, 7821.96089019574, 7831.334336581454, 7831.804204894923, 7833.686652534063, 7870.645820938186, 6969.407600353824, 7396.8534877094135, 7518.323350898446, 7532.698692052257, 7546.773596791885, 7457.216992215956, 7500.36246919018, 7513.774586762406, 7524.322810947041, 7567.470277080552, 6009.549283803644, 7341.816454588678, 7358.117025956705, 7383.2985866342615, 7401.5189012714, 6774.0, 7251.637418129178, 7467.701291948261, 7488.288612581796, 7540.132884718328, 7142.750003749844, 7245.492815502864, 7340.669669864762, 7352.41180705553, 7463.888041679488], "unit": "score", "name": "prototype.html", "value": 5376.46239978738}, {"lowerIsBetter": false, "replicates": [691.3604915453207, 715.7888422915241, 760.6729106484213, 768.880823472362, 774.2683164409635, 15203.23983800811, 15233.23833808308, 15445.845541544595, 15686.764698529518, 15692.215389230536, 14467.78298325526, 14480.927595362034, 14553.272336383165, 14583.906207034488, 14612.12327260365, 785.2893131715806, 824.41054645928, 972.7470857577046, 1010.8079464901682, 1011.1506334678868, 991.6628346362236, 994.597188138805, 998.3111652959471, 1004.5931397783872, 1004.7337455574242, 1010.8685870836781, 1056.6618682021756, 1067.2795862792623, 1067.3062509368933, 1070.8714954205507, 1033.5452400943561, 1044.4777611194402, 1057.6721216422934, 1059.0204061243319, 1060.6953447259875, 785.9803504912365, 793.0602236349944, 794.2375319693101, 795.1690483444814, 796.7291121018882, 15226.314815833313, 15235.695286094327, 15268.770968435483, 15294.464693735667, 15295.08229506222, 11655.417229138595, 12500.312482813442, 12669.873301267055, 12682.556110536087, 12715.109942304043, 9827.579341377008, 9884.950575247078, 9996.100350968447, 10029.648962286357, 10072.395656260647, 3485.790852548855, 3495.6154822969706, 3549.343371476285, 3566.4293713006055, 3723.4414837774552, 82597.58701206515, 83834.16165838325, 86924.99999999937, 87225.12774872234, 87238.0, 9543.997880222616, 9562.235021198287, 9828.557714902847, 9881.456519891331, 10132.986701329808, 21752.129914803547, 21948.670769938464, 21967.011484483235, 21990.120395184014, 22085.558288834134, 6917.031615573824, 7066.081409416743, 7122.821929451805, 7124.715011399486, 7158.570485770871, 3767.7174211934216, 3888.734297980581, 4096.487939007624, 4110.938335924963, 4122.628963393309, 3746.7189960753053, 3754.023953772039, 3759.605241449663, 3787.5833658297565, 3803.1062700265416, 667.6895243711697, 673.0610797936948, 674.5109795398297, 688.4733179117978, 692.1106378303855, 502.29678450170053, 576.6165499942575, 591.9911201331984, 601.6269912654095, 623.1556241293073, 8198.549079800669, 8282.71010514629, 8290.170982901662, 8379.539125348043, 8440.324774018063, 487.61234818318815, 519.3585921387084, 523.4843678976282, 579.4755746049832, 609.3632154398664, 3779.4141908004303, 3798.7150963677836, 3925.3326934421216, 3939.8621048263744, 3992.740471869319, 79834.60082699666, 97229.0277097234, 100964.99035009702, 103284.93430131355, 104613.0, 84481.0, 85135.72296415435, 85842.57078714692, 86059.56970215109, 86164.0, 61458.69270653618, 76630.46739065187, 77747.61126194333, 78629.21370786219, 79499.0, 7825.718487499643, 7837.529748215125, 7909.24862138096, 7921.128675845537, 7929.920700792918, 53776.0, 53897.0, 53924.19113713219, 54599.454005461026, 55157.0, 71275.28724712894, 72388.63805680937, 73666.26333736593, 76997.61501192459, 77791.0, 10635.94682026585, 10752.13982881352, 10894.400807955639, 10917.781644367227, 10921.290116142743, 11991.460384282555, 12085.81871271914, 12106.93946530297, 12139.393030348623, 12492.125551211328, 11207.103431725605, 11406.543738250377, 11473.598424055119, 11561.421928903354, 11610.477528511406, 11096.278741882075, 11334.433278336215, 11368.602098926498, 11624.128190385585, 12125.151239413157, 10708.625198118028, 10864.0, 10909.290896091728, 10999.395033273247, 11080.889191107986, 9024.278057755495, 9272.211861991536, 9308.906910930804, 9421.387609805615, 9509.096635819862, 9605.279604029585, 9679.467629280176, 9769.462679552693, 9793.559289832117, 9831.0], "unit": "score", "name": "yui.html", "value": 7091.386834511679}], "name": "dromaeo_css", "value": 7727.704339017808}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 114.0, 148.0, 169.0, 161.0, 114.0, 114.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 127.1}, {"lowerIsBetter": true, "replicates": [144.0, 119.0, 154.0, 146.0, 119.0, 137.0, 121.0, 149.0, 144.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 135.2}, {"lowerIsBetter": true, "replicates": [194.0, 196.0, 188.0, 200.0, 194.0, 201.0, 200.0, 201.0, 202.0, 199.0], "unit": "score", "name": "audio-dft", "value": 197.5}, {"lowerIsBetter": true, "replicates": [70.0, 62.0, 74.0, 108.0, 70.0, 58.0, 57.0, 59.0, 125.0, 57.0], "unit": "score", "name": "audio-fft", "value": 74.0}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 122.0, 78.0, 80.0, 83.0, 117.0, 78.0, 80.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 91.8}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 89.0, 109.0, 135.0, 121.0, 89.0, 85.0, 87.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.3}, {"lowerIsBetter": true, "replicates": [104.0, 95.0, 93.0, 95.0, 94.0, 94.0, 95.0, 95.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 95.1}, {"lowerIsBetter": true, "replicates": [98.0, 93.0, 122.0, 77.0, 148.0, 144.0, 140.0, 93.0, 117.0, 143.0], "unit": "score", "name": "imaging-desaturate", "value": 117.5}, {"lowerIsBetter": true, "replicates": [56.0, 62.0, 61.0, 59.0, 60.0, 59.0, 61.0, 68.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 67.0, 79.0, 76.0, 63.0, 102.0, 93.0, 95.0, 88.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 79.0}, {"lowerIsBetter": true, "replicates": [84.0, 80.0, 84.0, 83.0, 106.0, 70.0, 101.0, 97.0, 78.0, 109.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.2}, {"lowerIsBetter": true, "replicates": [130.0, 133.0, 119.0, 119.0, 127.0, 139.0, 121.0, 124.0, 121.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [137.0, 135.0, 136.0, 133.0, 126.0, 139.0, 139.0, 136.0, 134.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 70.0, 64.0, 67.0, 66.0, 64.0, 65.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1491.1999999999998}]} 03:09:01 INFO - Return code: 0 03:09:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:09:01 ERROR - # TBPL SUCCESS # 03:09:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:01 INFO - 2016-04-13 03:09:01.463 screenresolution[1689:10395] starting screenresolution argv=screenresolution get 03:09:01 INFO - 2016-04-13 03:09:01.465 screenresolution[1689:10395] Display 0: 1600x1200x32@60 03:09:01 INFO - 2016-04-13 03:09:01.471 screenresolution[1690:10398] starting screenresolution argv=screenresolution list 03:09:01 INFO - Available Modes on Display 0 03:09:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:01 INFO - Intel Iris: 03:09:01 INFO - Chipset Model: Intel Iris 03:09:01 INFO - Type: GPU 03:09:01 INFO - Bus: Built-In 03:09:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:01 INFO - Vendor: Intel (0x8086) 03:09:01 INFO - Device ID: 0x0a2e 03:09:01 INFO - Revision ID: 0x0009 03:09:01 INFO - Displays: 03:09:01 INFO - Display: 03:09:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:01 INFO - Display Serial Number: 1600x1200 60 03:09:01 INFO - Main Display: Yes 03:09:01 INFO - Mirror: Off 03:09:01 INFO - Online: Yes 03:09:01 INFO - Rotation: Supported 03:09:01 INFO - Return code: 0 03:09:01 INFO - Running post-action listener: _resource_record_post_action 03:09:01 INFO - Running post-run listener: _resource_record_post_run 03:09:02 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37594624; Write bytes: 665580544; Read time: 394; Write time: 1790 03:09:02 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362357248; Write bytes: 363283968; Read time: 28175; Write time: 641 03:09:02 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 35776000; Write bytes: 301399552; Read time: 374; Write time: 1145 03:09:02 INFO - Running post-run listener: _upload_blobber_files 03:09:02 INFO - Blob upload gear active. 03:09:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:02 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:09:02 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:09:02 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:09:03 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:09:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:09:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:04 INFO - (blobuploader) - INFO - Done attempting. 03:09:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:09:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:09:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:05 INFO - (blobuploader) - INFO - Done attempting. 03:09:05 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:05 INFO - Return code: 0 03:09:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c962262390d0a02be58d5d7bf88457a53e1ddd795e9290cbfa13af110379c39b24f151299bc53d099fbd59ced9a84756af74d637fc2a56b30908123589bdbee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ace7d3230d5bb7c7ed4a753bcda7b477d8beba89be1e6b165a585428e27e6d5f151f80e57cb31c4b0085f4349ebd49b7e42a48941ef81ba2556e4b7fbaf9e27"} 03:09:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:05 INFO - Contents: 03:09:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c962262390d0a02be58d5d7bf88457a53e1ddd795e9290cbfa13af110379c39b24f151299bc53d099fbd59ced9a84756af74d637fc2a56b30908123589bdbee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ace7d3230d5bb7c7ed4a753bcda7b477d8beba89be1e6b165a585428e27e6d5f151f80e57cb31c4b0085f4349ebd49b7e42a48941ef81ba2556e4b7fbaf9e27"} 03:09:05 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:05 INFO - Copying logs to upload dir... 03:09:05 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.692478 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-13 03:09:05.278093) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 03:09:05.281131) ========= 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.Ubzh2Ukacm/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.o475jOK9fp/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c962262390d0a02be58d5d7bf88457a53e1ddd795e9290cbfa13af110379c39b24f151299bc53d099fbd59ced9a84756af74d637fc2a56b30908123589bdbee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ace7d3230d5bb7c7ed4a753bcda7b477d8beba89be1e6b165a585428e27e6d5f151f80e57cb31c4b0085f4349ebd49b7e42a48941ef81ba2556e4b7fbaf9e27"} build_url:https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/Tu1sS-ZQSgGEHxBncgY2Tw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c962262390d0a02be58d5d7bf88457a53e1ddd795e9290cbfa13af110379c39b24f151299bc53d099fbd59ced9a84756af74d637fc2a56b30908123589bdbee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ace7d3230d5bb7c7ed4a753bcda7b477d8beba89be1e6b165a585428e27e6d5f151f80e57cb31c4b0085f4349ebd49b7e42a48941ef81ba2556e4b7fbaf9e27"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 03:09:05.314114) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 03:09:05.314463) ========= 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.Ubzh2Ukacm/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.o475jOK9fp/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005217 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 03:09:05.364941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 03:09:05.365456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 03:09:05.366116) ========= ========= Total master_lag: 0.32 =========