builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0113 starttime: 1459872809.69 results: success (0) buildid: 20160405075115 builduid: abcdb52c19504692a1f3e7b6d43ef26f revision: f0110e77e9f7b40ba80b3640ea7cd038398b8eee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 09:13:29.689322) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 09:13:29.689662) ========= ========= Started set props: basedir (results: 0, elapsed: 8 secs) (at 2016-04-05 09:13:29.689968) ========= 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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.005619 basedir: '/builds/slave/test' ========= master_lag: 8.57 ========= ========= Finished set props: basedir (results: 0, elapsed: 8 secs) (at 2016-04-05 09:13:38.262209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 19 secs) (at 2016-04-05 09:13:38.262518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 19 secs) (at 2016-04-05 09:13:58.156153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 23 secs) (at 2016-04-05 09:13:58.156441) ========= 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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.005858 ========= master_lag: 23.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 23 secs) (at 2016-04-05 09:14:21.212026) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:21.212295) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:21.212623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-05 09:14:21.212906) ========= 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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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-05 09:14:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-04-05 09:14:22 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.887453 ========= master_lag: 2.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-05 09:14:24.395566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:24.395891) ========= 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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.025907 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:24.524559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:24.524901) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0110e77e9f7b40ba80b3640ea7cd038398b8eee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f0110e77e9f7b40ba80b3640ea7cd038398b8eee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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-05 09:14:24,617 truncating revision to first 12 chars 2016-04-05 09:14:24,617 Setting DEBUG logging. 2016-04-05 09:14:24,617 attempt 1/10 2016-04-05 09:14:24,617 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0110e77e9f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 09:14:25,286 unpacking tar archive at: mozilla-central-f0110e77e9f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.920926 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:25.504424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:25.504740) ========= echo f0110e77e9f7b40ba80b3640ea7cd038398b8eee in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f0110e77e9f7b40ba80b3640ea7cd038398b8eee'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 f0110e77e9f7b40ba80b3640ea7cd038398b8eee program finished with exit code 0 elapsedTime=0.005690 script_repo_revision: 'f0110e77e9f7b40ba80b3640ea7cd038398b8eee' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:25.561507) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:25.561823) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 09:14:25.598496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-05 09:14:25.602795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:14:25 INFO - MultiFileLogger online at 20160405 09:14:25 in /builds/slave/test 09:14:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:14:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:25 INFO - {'append_to_log': False, 09:14:25 INFO - 'base_work_dir': '/builds/slave/test', 09:14:25 INFO - 'blob_upload_branch': 'Firefox', 09:14:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:25 INFO - 'branch': 'Firefox', 09:14:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:25 INFO - 'config_files': ('talos/mac_config.py',), 09:14:25 INFO - 'default_actions': ('clobber', 09:14:25 INFO - 'read-buildbot-config', 09:14:25 INFO - 'download-and-extract', 09:14:25 INFO - 'populate-webroot', 09:14:25 INFO - 'create-virtualenv', 09:14:25 INFO - 'install', 09:14:25 INFO - 'run-tests'), 09:14:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:25 INFO - 'download_minidump_stackwalk': True, 09:14:25 INFO - 'download_symbols': 'ondemand', 09:14:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:25 INFO - 'installer_path': 'installer.exe', 09:14:25 INFO - 'log_level': 'info', 09:14:25 INFO - 'log_name': 'talos', 09:14:25 INFO - 'log_to_console': True, 09:14:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:14:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:14:25 INFO - 'opt_config_files': (), 09:14:25 INFO - 'pip_index': False, 09:14:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:14:25 INFO - 'cmd': ('bash', 09:14:25 INFO - '-c', 09:14:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:14:25 INFO - 'enabled': True, 09:14:25 INFO - 'halt_on_failure': False, 09:14:25 INFO - 'name': 'check_screen_resolution'},), 09:14:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:14:25 INFO - 'cmd': ('bash', 09:14:25 INFO - '-c', 09:14:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:14:25 INFO - 'enabled': True, 09:14:25 INFO - 'halt_on_failure': False, 09:14:25 INFO - 'name': 'check_screen_resolution'},), 09:14:25 INFO - 'run_cmd_checks_enabled': True, 09:14:25 INFO - 'sps_profile': False, 09:14:25 INFO - 'sps_profile_interval': 0, 09:14:25 INFO - 'suite': 'dromaeojs', 09:14:25 INFO - 'system_bits': '32', 09:14:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:25 INFO - 'title': 't-yosemite-r7-0113', 09:14:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:25 INFO - 'use_talos_json': True, 09:14:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:25 INFO - 'work_dir': 'build'} 09:14:25 INFO - ##### 09:14:25 INFO - ##### Running clobber step. 09:14:25 INFO - ##### 09:14:25 INFO - Running pre-action listener: _resource_record_pre_action 09:14:25 INFO - Running main action method: clobber 09:14:25 INFO - rmtree: /builds/slave/test/build 09:14:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:27 INFO - Running post-action listener: _resource_record_post_action 09:14:27 INFO - ##### 09:14:27 INFO - ##### Running read-buildbot-config step. 09:14:27 INFO - ##### 09:14:27 INFO - Running pre-action listener: _resource_record_pre_action 09:14:27 INFO - Running main action method: read_buildbot_config 09:14:27 INFO - Using buildbot properties: 09:14:27 INFO - { 09:14:27 INFO - "project": "", 09:14:27 INFO - "product": "firefox", 09:14:27 INFO - "script_repo_revision": "production", 09:14:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:14:27 INFO - "repository": "", 09:14:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:14:27 INFO - "buildid": "20160405075115", 09:14:27 INFO - "pgo_build": "False", 09:14:27 INFO - "basedir": "/builds/slave/test", 09:14:27 INFO - "buildnumber": 199, 09:14:27 INFO - "slavename": "t-yosemite-r7-0113", 09:14:27 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:14:27 INFO - "platform": "yosemite_r7", 09:14:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:14:27 INFO - "branch": "mozilla-central", 09:14:27 INFO - "repo_path": "mozilla-central", 09:14:27 INFO - "revision": "f0110e77e9f7b40ba80b3640ea7cd038398b8eee", 09:14:27 INFO - "stage_platform": "macosx64", 09:14:27 INFO - "builduid": "abcdb52c19504692a1f3e7b6d43ef26f", 09:14:27 INFO - "slavebuilddir": "test" 09:14:27 INFO - } 09:14:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:14:27 INFO - Running post-action listener: _resource_record_post_action 09:14:27 INFO - ##### 09:14:27 INFO - ##### Running download-and-extract step. 09:14:27 INFO - ##### 09:14:27 INFO - Running pre-action listener: _resource_record_pre_action 09:14:27 INFO - Running main action method: download_and_extract 09:14:27 INFO - mkdir: /builds/slave/test/build/tests 09:14: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')]} 09:14:27 INFO - https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 09:14:30 INFO - Downloaded 1199 bytes. 09:14:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:14:30 INFO - Using the following test package requirements: 09:14:30 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:14:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:14:30 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:14:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:14:30 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:14:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:14:30 INFO - u'jsshell-mac.zip'], 09:14:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:14:30 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:14:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:14:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:14:30 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:14:30 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:14:30 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:14:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:14:30 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:14:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:14:30 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:14:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:14: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')]} 09:14:30 INFO - https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:14:32 INFO - Downloaded 17959862 bytes. 09:14:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:14:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:14:35 INFO - Return code: 0 09:14:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:14: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')]} 09:14:35 INFO - https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:14:36 INFO - Downloaded 17959862 bytes. 09:14:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:14:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:14:39 INFO - Return code: 0 09:14:39 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')]} 09:14:39 INFO - https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:14:41 INFO - Downloaded 10847584 bytes. 09:14:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:14:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:14:41 INFO - Return code: 0 09:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:41 INFO - https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:14:46 INFO - Downloaded 111354067 bytes. 09:14:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:14:46 INFO - mkdir: /builds/slave/test/properties 09:14:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:14:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:14:46 INFO - Contents: 09:14:46 INFO - build_url:https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:14:47 INFO - Running post-action listener: _resource_record_post_action 09:14:47 INFO - Running post-action listener: set_extra_try_arguments 09:14:47 INFO - ##### 09:14:47 INFO - ##### Running populate-webroot step. 09:14:47 INFO - ##### 09:14:47 INFO - Running pre-action listener: _resource_record_pre_action 09:14:47 INFO - Running main action method: populate_webroot 09:14:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:47 INFO - '--tppagecycles', 09:14:47 INFO - '7'], 09:14:47 INFO - 'tests': ['tsvgm']}}, 09:14:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:14:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:14:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:14:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:47 INFO - 'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:47 INFO - 'tests': ['damp', 'tps']}, 09:14:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:47 INFO - 'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['damp', 'tps']}, 09:14:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:14:47 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['dromaeo_dom']}, 09:14:47 INFO - 'other': {'tests': ['a11yr', 09:14:47 INFO - 'ts_paint', 09:14:47 INFO - 'tpaint', 09:14:47 INFO - 'sessionrestore', 09:14:47 INFO - 'sessionrestore_no_auto_restore', 09:14:47 INFO - 'tabpaint']}, 09:14:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['a11yr', 09:14:47 INFO - 'ts_paint', 09:14:47 INFO - 'tpaint', 09:14:47 INFO - 'sessionrestore', 09:14:47 INFO - 'sessionrestore_no_auto_restore', 09:14:47 INFO - 'tabpaint']}, 09:14:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['a11yr', 09:14:47 INFO - 'ts_paint', 09:14:47 INFO - 'tpaint', 09:14:47 INFO - 'sessionrestore', 09:14:47 INFO - 'sessionrestore_no_auto_restore', 09:14:47 INFO - 'tabpaint']}, 09:14:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['a11yr', 09:14:47 INFO - 'ts_paint', 09:14:47 INFO - 'tpaint', 09:14:47 INFO - 'sessionrestore', 09:14:47 INFO - 'sessionrestore_no_auto_restore', 09:14:47 INFO - 'tabpaint']}, 09:14:47 INFO - 'other_l64': {'tests': ['a11yr', 09:14:47 INFO - 'ts_paint', 09:14:47 INFO - 'tpaint', 09:14:47 INFO - 'sessionrestore', 09:14:47 INFO - 'sessionrestore_no_auto_restore', 09:14:47 INFO - 'tabpaint']}, 09:14:47 INFO - 'other_nol64': {'tests': ['a11yr', 09:14:47 INFO - 'ts_paint', 09:14:47 INFO - 'tpaint', 09:14:47 INFO - 'sessionrestore', 09:14:47 INFO - 'sessionrestore_no_auto_restore', 09:14:47 INFO - 'tabpaint']}, 09:14:47 INFO - 'svgr': {'tests': ['tsvgx', 09:14:47 INFO - 'tsvgr_opacity', 09:14:47 INFO - 'tart', 09:14:47 INFO - 'tscrollx', 09:14:47 INFO - 'cart']}, 09:14:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['tsvgx', 09:14:47 INFO - 'tsvgr_opacity', 09:14:47 INFO - 'tart', 09:14:47 INFO - 'tscrollx', 09:14:47 INFO - 'cart']}, 09:14:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:47 INFO - 'tests': ['tp5o']}, 09:14:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:47 INFO - 'talos_options': ['--e10s'], 09:14:47 INFO - 'tests': ['tp5o']}, 09:14:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:47 INFO - 'talos_options': ['--xperf_path', 09:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:47 INFO - 'tests': ['tp5n']}, 09:14:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:47 INFO - 'talos_options': ['--e10s', 09:14:47 INFO - '--xperf_path', 09:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:47 INFO - 'tests': ['tp5n']}}, 09:14:47 INFO - 'talos.zip': {'path': '', 09:14:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:47 INFO - Running post-action listener: _resource_record_post_action 09:14:47 INFO - ##### 09:14:47 INFO - ##### Running create-virtualenv step. 09:14:47 INFO - ##### 09:14:47 INFO - Running pre-action listener: _resource_record_pre_action 09:14:47 INFO - Running main action method: create_virtualenv 09:14:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:14:47 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 09:14:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:14:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:47 INFO - Using real prefix '/tools/python27' 09:14:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:14:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:51 INFO - Installing pip.................done. 09:14:51 INFO - Return code: 0 09:14:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:14:51 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')]} 09:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:51 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')]} 09:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:51 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 0x10082aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10083a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5adbfad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, '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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:14:51 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 09:14:51 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 09:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:51 INFO - 'HOME': '/Users/cltbld', 09:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:51 INFO - 'LOGNAME': 'cltbld', 09:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:51 INFO - 'MOZ_NO_REMOTE': '1', 09:14:51 INFO - 'NO_EM_RESTART': '1', 09:14:51 INFO - 'PAGER': '/bin/cat', 09:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:51 INFO - 'PWD': '/builds/slave/test', 09:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:51 INFO - 'SHELL': '/bin/bash', 09:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:14:51 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:51 INFO - 'USER': 'cltbld', 09:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:51 INFO - 'XPC_FLAGS': '0x0', 09:14:51 INFO - 'XPC_SERVICE_NAME': '0', 09:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:51 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 09:14:51 INFO - Cleaning up... 09:14:51 INFO - Return code: 0 09:14:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:14:51 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')]} 09:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:51 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')]} 09:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:51 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 0x10082aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10083a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5adbfad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, '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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:14:51 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 09:14:51 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 09:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:51 INFO - 'HOME': '/Users/cltbld', 09:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:51 INFO - 'LOGNAME': 'cltbld', 09:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:51 INFO - 'MOZ_NO_REMOTE': '1', 09:14:51 INFO - 'NO_EM_RESTART': '1', 09:14:51 INFO - 'PAGER': '/bin/cat', 09:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:51 INFO - 'PWD': '/builds/slave/test', 09:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:51 INFO - 'SHELL': '/bin/bash', 09:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:14:51 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:51 INFO - 'USER': 'cltbld', 09:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:51 INFO - 'XPC_FLAGS': '0x0', 09:14:51 INFO - 'XPC_SERVICE_NAME': '0', 09:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:52 INFO - Downloading/unpacking psutil>=0.7.1 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:55 INFO - Installing collected packages: psutil 09:14:55 INFO - Running setup.py install for psutil 09:14:55 INFO - building 'psutil._psutil_osx' extension 09:14:55 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 09:14:56 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 09:14:56 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 09:14:56 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 09:14:56 INFO - building 'psutil._psutil_posix' extension 09:14:56 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 09:14:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:14:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:14:56 INFO - ^ 09:14:56 INFO - 1 warning generated. 09:14:56 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 09:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:56 INFO - Successfully installed psutil 09:14:56 INFO - Cleaning up... 09:14:56 INFO - Return code: 0 09:14:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:14:56 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')]} 09:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:56 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')]} 09:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:56 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 0x10082aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10083a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5adbfad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, '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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:14:56 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 09:14:56 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 09:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:56 INFO - 'HOME': '/Users/cltbld', 09:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:56 INFO - 'LOGNAME': 'cltbld', 09:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:56 INFO - 'MOZ_NO_REMOTE': '1', 09:14:56 INFO - 'NO_EM_RESTART': '1', 09:14:56 INFO - 'PAGER': '/bin/cat', 09:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:56 INFO - 'PWD': '/builds/slave/test', 09:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:56 INFO - 'SHELL': '/bin/bash', 09:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:14:56 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:56 INFO - 'USER': 'cltbld', 09:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:56 INFO - 'XPC_FLAGS': '0x0', 09:14:56 INFO - 'XPC_SERVICE_NAME': '0', 09:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:14:59 INFO - Installing collected packages: mozsystemmonitor 09:14:59 INFO - Running setup.py install for mozsystemmonitor 09:14:59 INFO - Successfully installed mozsystemmonitor 09:14:59 INFO - Cleaning up... 09:14:59 INFO - Return code: 0 09:14:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10082aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10083a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5adbfad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, '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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:59 INFO - 'HOME': '/Users/cltbld', 09:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:59 INFO - 'LOGNAME': 'cltbld', 09:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:59 INFO - 'MOZ_NO_REMOTE': '1', 09:14:59 INFO - 'NO_EM_RESTART': '1', 09:14:59 INFO - 'PAGER': '/bin/cat', 09:14:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:59 INFO - 'PWD': '/builds/slave/test', 09:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:59 INFO - 'SHELL': '/bin/bash', 09:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:14:59 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:59 INFO - 'USER': 'cltbld', 09:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:59 INFO - 'XPC_FLAGS': '0x0', 09:14:59 INFO - 'XPC_SERVICE_NAME': '0', 09:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:14:59 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 09:14:59 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 09:14:59 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 09:14:59 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 09:14:59 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 09:14:59 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 09:15:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:03 INFO - Downloading docopt-0.6.1.tar.gz 09:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:03 INFO - Running setup.py install for blobuploader 09:15:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:03 INFO - Running setup.py install for requests 09:15:04 INFO - Running setup.py install for docopt 09:15:04 INFO - Successfully installed blobuploader requests docopt 09:15:04 INFO - Cleaning up... 09:15:04 INFO - Return code: 0 09:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:04 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 0x10082aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10083a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5adbfad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, '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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:15:04 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 09:15:04 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 09:15:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:15:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:04 INFO - 'HOME': '/Users/cltbld', 09:15:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:04 INFO - 'LOGNAME': 'cltbld', 09:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:04 INFO - 'MOZ_NO_REMOTE': '1', 09:15:04 INFO - 'NO_EM_RESTART': '1', 09:15:04 INFO - 'PAGER': '/bin/cat', 09:15:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:04 INFO - 'PWD': '/builds/slave/test', 09:15:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:04 INFO - 'SHELL': '/bin/bash', 09:15:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:15:04 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:15:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:04 INFO - 'USER': 'cltbld', 09:15:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:04 INFO - 'XPC_FLAGS': '0x0', 09:15:04 INFO - 'XPC_SERVICE_NAME': '0', 09:15:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-arM47W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-zL4f7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-FiOBYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-eGlaOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-D_yo23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-HdPSRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-8ctUhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-1Br_Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-IQJWpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-M_YSmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-sfLLaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-FAJy6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:06 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-aO7vXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:06 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-JkwSz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:06 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-6sXEVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:06 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-SCUkdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:06 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-vWtnGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:06 INFO - Running setup.py install for manifestparser 09:15:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:06 INFO - Running setup.py install for mozcrash 09:15:06 INFO - Running setup.py install for mozdebug 09:15:06 INFO - Running setup.py install for mozdevice 09:15:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:15:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:07 INFO - Running setup.py install for mozfile 09:15:07 INFO - Running setup.py install for mozhttpd 09:15:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:07 INFO - Running setup.py install for mozinfo 09:15:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:07 INFO - Running setup.py install for mozInstall 09:15:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:07 INFO - Running setup.py install for mozleak 09:15:07 INFO - Running setup.py install for mozlog 09:15:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:08 INFO - Running setup.py install for moznetwork 09:15:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:08 INFO - Running setup.py install for mozprocess 09:15:08 INFO - Running setup.py install for mozprofile 09:15:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:15:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:15:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:15:08 INFO - Running setup.py install for mozrunner 09:15:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:15:08 INFO - Running setup.py install for mozscreenshot 09:15:08 INFO - Running setup.py install for moztest 09:15:08 INFO - Running setup.py install for mozversion 09:15:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:15:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:09 INFO - Cleaning up... 09:15:09 INFO - Return code: 0 09:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:09 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 0x10082aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10083a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5adbfad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, '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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:15:09 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 09:15:09 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 09:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:09 INFO - 'HOME': '/Users/cltbld', 09:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:09 INFO - 'LOGNAME': 'cltbld', 09:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:09 INFO - 'MOZ_NO_REMOTE': '1', 09:15:09 INFO - 'NO_EM_RESTART': '1', 09:15:09 INFO - 'PAGER': '/bin/cat', 09:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:09 INFO - 'PWD': '/builds/slave/test', 09:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:09 INFO - 'SHELL': '/bin/bash', 09:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:15:09 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:09 INFO - 'USER': 'cltbld', 09:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:09 INFO - 'XPC_FLAGS': '0x0', 09:15:09 INFO - 'XPC_SERVICE_NAME': '0', 09:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Q8LbkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:09 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)) 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-imNRc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:09 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)) 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-VXkLbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:09 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)) 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-va8XGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:09 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)) 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-PR6Vll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:09 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)) 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-5fCHad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:10 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)) 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-K5u_sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:10 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)) 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-5GGLw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:10 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)) 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-6_BljX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:10 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)) 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-eMOyeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:10 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)) 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-FOoOtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:10 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)) 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-j3dW3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:10 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)) 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-PBWwv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:10 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)) 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-kqDKCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:10 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)) 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-nAl2nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:11 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)) 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:11 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-DA9uxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:11 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)) 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:11 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Rx5NWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:11 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)) 09:15:11 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)) 09:15:11 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)) 09:15:11 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)) 09:15:11 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)) 09:15:11 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)) 09:15:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:11 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 09:15:11 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 09:15:11 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 09:15:11 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 09:15:11 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 09:15:11 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 09:15:13 INFO - Downloading blessings-1.6.tar.gz 09:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:13 INFO - Installing collected packages: blessings 09:15:13 INFO - Running setup.py install for blessings 09:15:13 INFO - Successfully installed blessings 09:15:13 INFO - Cleaning up... 09:15:13 INFO - Return code: 0 09:15:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:14 INFO - Reading from file tmpfile_stdout 09:15:14 INFO - Current package versions: 09:15:14 INFO - blessings == 1.6 09:15:14 INFO - blobuploader == 1.2.4 09:15:14 INFO - docopt == 0.6.1 09:15:14 INFO - manifestparser == 1.1 09:15:14 INFO - mozInstall == 1.12 09:15:14 INFO - mozcrash == 0.17 09:15:14 INFO - mozdebug == 0.1 09:15:14 INFO - mozdevice == 0.48 09:15:14 INFO - mozfile == 1.2 09:15:14 INFO - mozhttpd == 0.7 09:15:14 INFO - mozinfo == 0.9 09:15:14 INFO - mozleak == 0.1 09:15:14 INFO - mozlog == 3.1 09:15:14 INFO - moznetwork == 0.27 09:15:14 INFO - mozprocess == 0.22 09:15:14 INFO - mozprofile == 0.28 09:15:14 INFO - mozrunner == 6.11 09:15:14 INFO - mozscreenshot == 0.1 09:15:14 INFO - mozsystemmonitor == 0.0 09:15:14 INFO - moztest == 0.7 09:15:14 INFO - mozversion == 1.4 09:15:14 INFO - psutil == 3.1.1 09:15:14 INFO - requests == 1.2.3 09:15:14 INFO - wsgiref == 0.1.2 09:15:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:14 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')]} 09:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:14 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')]} 09:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:14 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 0x10082aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10083a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5adbfad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, '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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:15:14 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 09:15:14 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 09:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:14 INFO - 'HOME': '/Users/cltbld', 09:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:14 INFO - 'LOGNAME': 'cltbld', 09:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:14 INFO - 'MOZ_NO_REMOTE': '1', 09:15:14 INFO - 'NO_EM_RESTART': '1', 09:15:14 INFO - 'PAGER': '/bin/cat', 09:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:14 INFO - 'PWD': '/builds/slave/test', 09:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:14 INFO - 'SHELL': '/bin/bash', 09:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:15:14 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:14 INFO - 'USER': 'cltbld', 09:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:14 INFO - 'XPC_FLAGS': '0x0', 09:15:14 INFO - 'XPC_SERVICE_NAME': '0', 09:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 INFO - Cleaning up... 09:15:14 INFO - Return code: 0 09:15:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:15:14 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')]} 09:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:14 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')]} 09:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:14 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 0x10082aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10083a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5adbfad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, '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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:15:14 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 09:15:14 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 09:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:14 INFO - 'HOME': '/Users/cltbld', 09:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:14 INFO - 'LOGNAME': 'cltbld', 09:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:14 INFO - 'MOZ_NO_REMOTE': '1', 09:15:14 INFO - 'NO_EM_RESTART': '1', 09:15:14 INFO - 'PAGER': '/bin/cat', 09:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:14 INFO - 'PWD': '/builds/slave/test', 09:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:14 INFO - 'SHELL': '/bin/bash', 09:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:15:14 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:14 INFO - 'USER': 'cltbld', 09:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:14 INFO - 'XPC_FLAGS': '0x0', 09:15:14 INFO - 'XPC_SERVICE_NAME': '0', 09:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:14 INFO - Downloading/unpacking jsonschema 09:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:17 INFO - Downloading/unpacking functools32 (from jsonschema) 09:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:17 INFO - warning: no files found matching '*.txt' 09:15:17 INFO - no previously-included directories found matching 'build' 09:15:17 INFO - no previously-included directories found matching 'dist' 09:15:17 INFO - no previously-included directories found matching '.git*' 09:15:17 INFO - Installing collected packages: jsonschema, functools32 09:15:17 INFO - Running setup.py install for functools32 09:15:17 INFO - warning: no files found matching '*.txt' 09:15:17 INFO - no previously-included directories found matching 'build' 09:15:17 INFO - no previously-included directories found matching 'dist' 09:15:17 INFO - no previously-included directories found matching '.git*' 09:15:17 INFO - Successfully installed jsonschema functools32 09:15:17 INFO - Cleaning up... 09:15:17 INFO - Return code: 0 09:15:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:15:17 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')]} 09:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:17 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')]} 09:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:17 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 0x10082aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10083a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5adbfad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, '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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 09:15:17 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 09:15:17 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 09:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:17 INFO - 'HOME': '/Users/cltbld', 09:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:17 INFO - 'LOGNAME': 'cltbld', 09:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:17 INFO - 'MOZ_NO_REMOTE': '1', 09:15:17 INFO - 'NO_EM_RESTART': '1', 09:15:17 INFO - 'PAGER': '/bin/cat', 09:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:17 INFO - 'PWD': '/builds/slave/test', 09:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:17 INFO - 'SHELL': '/bin/bash', 09:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:15:17 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:17 INFO - 'USER': 'cltbld', 09:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:17 INFO - 'XPC_FLAGS': '0x0', 09:15:17 INFO - 'XPC_SERVICE_NAME': '0', 09:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:18 INFO - Downloading/unpacking flake8 09:15:18 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 09:15:18 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 09:15:18 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 09:15:18 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 09:15:18 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 09:15:18 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 09:15:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:15:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:15:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 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 09:15:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:15:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:21 INFO - no previously-included directories found matching 'docs/_build' 09:15:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:15:21 INFO - Running setup.py install for pep8 09:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:22 INFO - no previously-included directories found matching 'docs/_build' 09:15:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:15:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:15:22 INFO - Cleaning up... 09:15:22 INFO - Return code: 0 09:15:22 INFO - Running post-action listener: _resource_record_post_action 09:15:22 INFO - Running post-action listener: _start_resource_monitoring 09:15:22 INFO - Starting resource monitoring. 09:15:22 INFO - ##### 09:15:22 INFO - ##### Running install step. 09:15:22 INFO - ##### 09:15:22 INFO - Running pre-action listener: _resource_record_pre_action 09:15:22 INFO - Running main action method: install 09:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:22 INFO - Reading from file tmpfile_stdout 09:15:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:22 INFO - Reading from file tmpfile_stdout 09:15:22 INFO - Output received: 09:15:22 INFO - Usage: mozinstall [options] installer 09:15:22 INFO - Options: 09:15:22 INFO - -h, --help show this help message and exit 09:15:22 INFO - -d DEST, --destination=DEST 09:15:22 INFO - Directory to install application into. [default: 09:15:22 INFO - "/builds/slave/test"] 09:15:22 INFO - --app=APP Application being installed. [default: firefox] 09:15:22 INFO - mkdir: /builds/slave/test/build/application 09:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:15:56 INFO - Reading from file tmpfile_stdout 09:15:56 INFO - Output received: 09:15:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:15:56 INFO - Running post-action listener: _resource_record_post_action 09:15:56 INFO - ##### 09:15:56 INFO - ##### Running run-tests step. 09:15:56 INFO - ##### 09:15:56 INFO - Running pre-action listener: _resource_record_pre_action 09:15:56 INFO - Running main action method: run_tests 09:15:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:15:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:15:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:15:56 INFO - 2016-04-05 09:15:56.832 screenresolution[1880:8519] starting screenresolution argv=screenresolution get 09:15:56 INFO - 2016-04-05 09:15:56.834 screenresolution[1880:8519] Display 0: 1600x1200x32@60 09:15:56 INFO - 2016-04-05 09:15:56.840 screenresolution[1881:8521] starting screenresolution argv=screenresolution list 09:15:56 INFO - Available Modes on Display 0 09:15:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:15:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:15:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:15:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:15:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:15:57 INFO - Intel Iris: 09:15:57 INFO - Chipset Model: Intel Iris 09:15:57 INFO - Type: GPU 09:15:57 INFO - Bus: Built-In 09:15:57 INFO - VRAM (Dynamic, Max): 1536 MB 09:15:57 INFO - Vendor: Intel (0x8086) 09:15:57 INFO - Device ID: 0x0a2e 09:15:57 INFO - Revision ID: 0x0009 09:15:57 INFO - Displays: 09:15:57 INFO - Display: 09:15:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:15:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:15:57 INFO - Display Serial Number: 1600x1200 60 09:15:57 INFO - Main Display: Yes 09:15:57 INFO - Mirror: Off 09:15:57 INFO - Online: Yes 09:15:57 INFO - Rotation: Supported 09:15:57 INFO - Return code: 0 09:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:15:57 INFO - Python 2.7.3 09:15:57 INFO - Return code: 0 09:15:57 INFO - grabbing minidump binary from tooltool 09:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:57 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 0x1006c9e00>, '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 0x1004f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:15:57 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 09:15:57 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 09:15:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:57 INFO - Return code: 0 09:15:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:15:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:15:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:15:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:15:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:15:58 INFO - Return code: 0 09:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0113 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybm4Y2Bddw/Render', 09:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:58 INFO - 'HOME': '/Users/cltbld', 09:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:58 INFO - 'LOGNAME': 'cltbld', 09:15:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:58 INFO - 'MOZ_NO_REMOTE': '1', 09:15:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:58 INFO - 'NO_EM_RESTART': '1', 09:15:58 INFO - 'PAGER': '/bin/cat', 09:15:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:58 INFO - 'PWD': '/builds/slave/test', 09:15:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:58 INFO - 'SHELL': '/bin/bash', 09:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDk9H5KOVP/Listeners', 09:15:58 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 09:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:58 INFO - 'USER': 'cltbld', 09:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:58 INFO - 'XPC_FLAGS': '0x0', 09:15:58 INFO - 'XPC_SERVICE_NAME': '0', 09:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:15:58 INFO - mozversion application_buildid: 20160405075115 09:15:58 INFO - mozversion application_changeset: f0110e77e9f7b40ba80b3640ea7cd038398b8eee 09:15:58 INFO - mozversion application_display_name: Nightly 09:15:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:58 INFO - mozversion application_name: Firefox 09:15:58 INFO - mozversion application_remotingname: firefox 09:15:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:15:58 INFO - mozversion application_vendor: Mozilla 09:15:58 INFO - mozversion application_version: 48.0a1 09:15:58 INFO - mozversion platform_buildid: 20160405075115 09:15:58 INFO - mozversion platform_changeset: f0110e77e9f7b40ba80b3640ea7cd038398b8eee 09:15:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:15:58 INFO - mozversion platform_version: 48.0a1 09:15:58 INFO - using testdate: 1459872958 09:15:58 INFO - actual date: 1459872958 09:15:58 INFO - starting webserver on 'localhost:49288' 09:15:58 INFO - SUITE-START | Running 2 tests 09:15:58 INFO - TEST-START | dromaeo_css 09:15:58 INFO - operating with platform_type : mac_ 09:15:58 INFO - Initialising browser for dromaeo_css test... 09:15:58 INFO - TEST-INFO | started process 1899 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpr9k8q_/profile http://localhost:49288/getInfo.html) 09:16:00 INFO - PROCESS | 1899 | __metrics Screen width/height:1600/1200 09:16:00 INFO - PROCESS | 1899 | colorDepth:24 09:16:00 INFO - PROCESS | 1899 | Browser inner width/height: 1024/689 09:16:00 INFO - PROCESS | 1899 | __metrics 09:16:00 INFO - PROCESS | 1899 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:16:00 ERROR - PROCESS | 1899 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:16:01 INFO - TEST-INFO | 1899: exit 0 09:16:01 INFO - Browser initialized. 09:16:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:16:01 INFO - TEST-INFO | started process 1902 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpr9k8q_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:13 INFO - PROCESS | 1902 | RSS: Main: 236220416 09:16:13 INFO - PROCESS | 1902 | 09:17:04 INFO - PROCESS | 1902 | 1459873024982 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] 09:19:14 INFO - PROCESS | 1902 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49288/tests/dromaeo/cssquery-ext.html) 09:19:15 INFO - PROCESS | 1902 | RSS: Main: 348545024 09:19:15 INFO - PROCESS | 1902 | 09:22:18 INFO - PROCESS | 1902 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-ext.html (next: http://localhost:49288/tests/dromaeo/cssquery-jquery.html) 09:22:19 INFO - PROCESS | 1902 | RSS: Main: 361807872 09:22:19 INFO - PROCESS | 1902 | 09:25:21 INFO - PROCESS | 1902 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49288/tests/dromaeo/cssquery-mootools.html) 09:25:21 INFO - PROCESS | 1902 | RSS: Main: 361975808 09:25:21 INFO - PROCESS | 1902 | 09:28:23 INFO - PROCESS | 1902 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49288/tests/dromaeo/cssquery-prototype.html) 09:28:24 INFO - PROCESS | 1902 | RSS: Main: 326201344 09:28:24 INFO - PROCESS | 1902 | 09:31:27 INFO - PROCESS | 1902 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49288/tests/dromaeo/cssquery-yui.html) 09:31:28 INFO - PROCESS | 1902 | RSS: Main: 325779456 09:31:28 INFO - PROCESS | 1902 | 09:34:30 INFO - PROCESS | 1902 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-yui.html (next: http://localhost:49288/tests/dromaeo/cssquery-dojo.html) 09:34:30 INFO - PROCESS | 1902 | RSS: Main: 371990528 09:34:30 INFO - PROCESS | 1902 | 09:34:30 INFO - PROCESS | 1902 | __start_tp_report 09:34:30 INFO - PROCESS | 1902 | _x_x_mozilla_page_load 09:34:30 INFO - PROCESS | 1902 | _x_x_mozilla_page_load_details 09:34:30 INFO - PROCESS | 1902 | |i|pagename|runs| 09:34:30 INFO - PROCESS | 1902 | |0;dojo.html;3401.4047541680206;3447.8620855165796;3485.163560745422;3503.351879902218;3536.6463353664635;5533.972330138344;5590.944090559104;5601.859953501159;5602.019646561851;5633.070543360351;5603.831885043455;5639.943600563993;5709.914351284734;5729.971350143254;5735.455131762486;5021;5063.392392912847;5071.847844564669;5102.821401250957;5198.714070726109;5206.036883176605;5206.661566998152;5215.322008138936;5264.526192642661;5279.70961597112;5030.57240134589;5145.511176438233;5149.2791009258735;5187.910538786859;5188.273641690166;5124.205748109011;5135.897282054338;5143.3313669223135;5149.2791009258735;5151.793928242866;4943.233798761198;5033.597312215014;5036.697798132123;5045.823396181116;5070.61970352225;5530.5299049580835;5543.445655434464;5551.694656793875;5554.333479982428;5560.054790685593;6044.2746870375395;6145.754169833202;6170.444659980623;6193.81418557444;6196.070589411579;6133.365267548864;6193.102000209944;6208.906866397007;6261.87476250477;6264.655443950581;5696.572757043238;5743.62666426681;5748.7125643717645;5772.855678608026;5794.304683438015;6169.753209871555;6323.683815809191;6335.366463353628;6338.778142764981;6348.841278968062;5958.791442299499;6006.099085137177;6006.309274433496;6007.309159446632;6009.45914867664;6125.6017461851925;6129.2032035835055;6142.682951206388;6223.875522489525;6236.906446403307;5215.24378965048;6053.424924632153;6115.848865095035;6125.021800333928;6134.069235337226;6089.847753806191;6176.474999624992;6179.660118693425;6181.938180618136;6194.876102478015;4746.169420351424;4821.927671084936;4826.276058591169;4826.493218212037;4864.100141473838;4262.573742625713;4309.482862056573;4365.236083685342;4405.933910991338;4428.1365133799245;5578.330600327906;5634.211210430543;5654.943450565442;5658.519025882763;5676.914846277309;5094.719790411489;6063.636181829104;6163.537734669828;6249.875002500015;6279.843003924847;5585.944140558542;5651.406602306781;5679.5172410345585;5688.288963879515;5688.488036076773;5287.391949925731;5301.363836339664;5312.043832110257;5316.548093412026;5330.440303768126;6293.590916590407;6295;6299.149614801943;6312.368763123651;6318.4313411793155;5121.462246464068;6058.27300723916;6114.0828875669;6128.472568454128;6234.875302494015;6259.96870015647;6287.874242515216;6292.842678933063;6293.937060629518;6296.6851657417865;6125.173101631222;6149.446549810538;6162.322144564005;6165.260168779775;6176.907346389898;6074.817755467343;6143.757528501975;6188.752449902134;6205.751769929333;6249;6039.275286965592;6040.251685483006;6054.606450580698;6071.119687645355;6108.114323423168;5853.882922341444;6029.065494848305;6033.155358249761;6037.18498002764;6037.849053773691;5677.574181936454;5761.251037365283;5804.100364443518;5817.5345972321265;5887.322957859901;5960.374160713062;5984.760609575568;6006.069059295816;6012.819615411545;6027.60820546663;5688.715564221689;5859.091840764689;5863.061910094364;5872.500837428695;5890.352061273342 09:34:30 INFO - PROCESS | 1902 | |1;ext.html;462.2373084410724;535.783007881808;579.1370857422439;627.3381582430535;634.7905191286876;30468.781248750052;30942.226444338903;37777.81111094447;37845.62154378455;37971.430428543594;41995.69023703703;42457.7877110614;42533.78733106338;42542.57457425432;42727.786361068225;9385.296102792301;9704.854427183562;9720.708378748614;9728.270379721514;9746.415215087081;9463.858042129374;9657.710268691915;9667.758306042335;9670.516474176264;9677.806443871119;9793.902060979406;9859.063388978035;9868;9871.111599956002;9880.752981175456;9763.804723905518;9829.115379615798;9832.115109640095;9832.606695732162;9838.311318207765;9525.19035881951;9587.760305992337;9658;9660.71017869465;9673.177779888647;40432.79783601093;41165.79417102925;41585.58414415847;41654.58345416567;41748.79125604383;2746.2036009557205;3118.2672072063046;3218.61376634803;3252.317013427183;3727.434477519448;28832.27919302013;29718.257043573867;29760;29782.915195936293;30688;2703.8918443262246;2747.107190163185;2781.1795520321552;2828.278788908815;2891.3060865392363;411781;412572;414760;415594;416238;45536;62516.37483625196;62541.37458625356;62846;63007.369926301064;45374.77312613416;45468.3179752304;45483;45496.77251613787;45509.54490455119;15121.924390377977;15332.463363782437;15381.538553843402;15384.230788460532;15416.922915385352;12295.631131066082;12373.814392783936;12374.752504950031;12386.504539818307;12400.441980110916;14255.429782808778;14446.566603001927;14878.479253226085;14885.479008234659;15001;5317.867053323698;6205.844853878599;6415.743370265137;6422.33473108664;6437.324080971431;942.4392486470539;946.8248374050822;994.955227014786;1078.4068762180768;1086.9456527173768;28989.42021159565;29064;29490.11529654114;29809;29860.850695746383;975.8731364922656;1068.6847380022912;1136.7953768321781;1171.1216587559331;1231.8569431041515;14101.71796564063;14931.626709332353;14960.102393856403;15312.081275123528;15569;467335;472771.6361418171;480575;481312;481591.5920420375;58432;58972;59059.114113288335;59089;59313.70343148343;1339.6583871112998;1349.730053989206;1351.5877657314613;1448.8116544849102;1488.2261224163374;30026.549601755552;30453.695463045085;30457.695423045487;30764.692353077076;30939.69060309368;51534.74232628813;52423;52949;53006;53109;384792;386982;387318;387880.9089318369;389562;28484.287892802844;32847;33465.16337091592;33696.663033369354;34002.659973400936;41723.7913810429;42066;42093.94765130896;42165;42553.361699573914;28105.43789124165;33836.64653413836;34013.65986340105;34025.82987085148;35101;25090.37274068163;34481.79313724008;35610.28779424449;35830.82084589561;36802;29223.58913884239;31166.37667246688;32991;35994.64005359913;36797.44803827998;30556.541651874795;32023;32318.83840580782;32446;33094.33811323808;18968.620627587094;21472;24205.152819651226;24499;24701.135460258804 09:34:31 INFO - PROCESS | 1902 | |2;jquery.html;351.93489204497183;352.45193723759553;356.3372127842213;357.4977157094282;361.36039210597227;19273.807261927377;19770.20919163232;20735.274265400734;21279.468013299676;21320.36038918831;19644.919529425875;20296.59406811863;20481.692774608393;20779.16883324669;20819.895900520514;5507.201455788908;5680.801171958982;5726.971365143189;5730.369659337491;5736.938666346739;4098.118904435546;4211.410402543646;5689.6017278790505;5983.192269043667;6273.12176295319;6224.533160012995;6231.594946328497;6239.532035097386;6243.250809902818;6245.437910588046;6026.969865150646;6117.66352850593;6203.75184992602;6212.0371342441995;6222.719977601018;3633.509476220729;5142.948570514284;5339.252504649314;5383.757730902119;5405.189221616789;23745.05019799206;24177.87911060451;24415.63376549353;24809;24853;2160.2007257314895;2264.818814494853;2336.3224664847176;2403.3871362802547;2577.917274744612;8378;9838.114569688762;14471.348789304506;14785;14808.259587020713;1601.2714215032133;1704.2756828348026;1794.6270015186096;1821.4717731857745;1838.6874231380698;82795;85621.28757424817;86159;87878;88733.55633221858;9192.56397054781;10582.259241853151;10762.977517136016;10996.560137594566;11079.612213572485;13565.186088834702;13617.727645447036;13624.591262262147;13654.180749155083;13658.317084145752;8290.336773058141;8491.660333586711;8499.277561407349;8565.657373705106;8579.82840343202;8543.658253669908;8545.401821872534;8593.613287402082;8687.522186279815;8688.218060374596;4316.179925814085;4375.890602734957;4385.451818522684;4424.911501770011;4431.1137772445;1741.8345257200547;1796.6227092310762;1813.5103522049237;1819.0359109671895;1858.0988220712943;868.3964644571962;904.2954031650387;908.4821651658623;1023.3706270643501;1041.6041904076553;18629.627407451775;18894.716579251322;19011;19120.521986950436;19335.323263685703;790.3361176611673;928.744595236302;949.7245798718433;996.2976101848179;997.1673652500099;10058.04448577384;10305.381677099398;10366.429846358522;10462.895371046345;10466.53548210324;520851;563514;568037;576201;576230;103411.4829425848;113147;114832;116236;120497.19254211194;991.4002028772633;1008.9192864570816;1009.9444530551037;1026.4200726589602;1029.4441001858913;14913.3289001993;17242.137893105544;17326.220320085373;17807.73288400649;17997.910010449865;44335.77832110819;45355;48574.514254857;49380.8026317767;50035.74910627263;54358;69445;72618.63690681513;72794;74008;7771.494852834548;7813.531188128731;7882.211778822072;7902.367810575255;7959.4030447715495;9115.36192466521;11977.341246231192;12229.816552751538;12350.567730129402;12478.126531142732;10058.748531286483;10147.934466881166;10716.73208169802;10747.193960453154;10797.24419290642;7968.920310796818;10264.538095785558;10506.737331566772;10695.304805187638;10709.571617135227;9159.267258619162;10528.420936848546;10673.35959842412;10678.89321106779;10833.67498975032;7312.707491700486;7578.621068946641;7741.264579864904;7824.374050076094;7927.762167134995;8270.83458330818;10316.845247321446;10501.212409069198;10513.737156571147;10555.78328551013 09:34:31 INFO - PROCESS | 1902 | |3;mootools.html;1451.8838492920568;1582.2642471250867;1600.631854673425;1883.7927827938925;2020.323191730771;7761.340286075683;7954.76135715928;7964.681412743484;7971.441999060068;8009.91990080099;8158.184181581853;8429.030661473933;8431.241188293052;8443.788905277372;8444.071152173272;2407.410184504799;2479.1818699829105;2479.76442237988;2480.528699547089;2481.565725997943;2144.6354119799594;2213.4908970936613;2217.345882964529;2404.278716385086;2483.4784695213934;2150.3011521255653;2357.222116701493;2440.511897620474;2444.3889027743066;2445.4497738008986;2392.83250172488;2428.077330614373;2431.3556907419547;2435.452023294762;2449.9755002449924;2049.405672355015;2376.2989917974237;2431.4286142756437;2432.4526981429212;2436.5857804173156;8610.44032137909;8661.566921653892;8684;8684.60919258635;8692;5292.285541451932;5440.156775699773;5451.781928722886;5455.263539422167;5478.205660179252;2980.2251414632133;3497.475378693191;3667.266546690646;3675.61406052366;3696.537932758405;1033.4625994482901;1046.2414749306693;1057.6086847866338;1058.878229003659;1073.924825262232;11597.014253788439;11604.419779011016;11639.534418623329;11687.649370518813;11699.122565807598;4767.046590681808;4773.307870358779;4779.498152693986;4838.7338696372035;4855.732934688626;9896.20830333586;9897.406155630686;9909.603615855429;9916.851247231298;9917.057879501435;5445.074337362658;5448.482394172626;5456.727163641802;5458.099413596791;5470.753816078286;4902.411710594752;4977.40271167455;4978.2034874419915;4985.401751789808;4988.625853061035;3846.0577158595765;3859.073822282688;3889.8055097245024;3918.9804050980133;3920.3335432976464;1118.5078565431184;1148.4602236948622;1197.0363857095122;1255.5856567332758;1289.374653293152;1144.210494758614;1154.705550084723;1174.2543484886987;1377.7726675098497;1416.9362378692983;7872;7948.483348582324;7956.880646790303;8295.8340833183;8296.377771667148;1131.095123900876;1162.773259214445;1219.4878151176526;1224.7917853964848;1251.2805137046234;5946.405359464019;5972.85067873298;5974.850628734316;6010.038393857049;6019.036954087325;9856.556454959544;10389.272750907365;10436.42599657011;10495;10521.736956576147;10143.289969702199;10504.212184086224;10505.894941050492;10594.258401911946;10603.045725884707;8202.343812494986;8251.793705157419;8256.793580160544;8308.252257296872;8319.376046796515;7603.9619801902845;7819.726309579138;7854.842903142019;7864.292213700565;7962.203779621991;9266.351355405057;9334.813303734023;9396.624135034523;9506.287028472754;9540.904590954002;9269.768255793659;9543.33196676226;9700.12698857078;9770.706878793648;9787.972262912577;7288.708451661874;7326.96336518314;7395.297446742766;7422.777316680508;7426.405887529093;7967.84064318722;8175.100738918595;8201.13888041771;8205.220504052106;8212.17878212174;6005.519558435228;7237;7373.926260737324;7410.370118539984;7565.8108547284555;6420.7431702731365;6783.728650853911;7064.364207221375;7104.2239440139965;7182.245864184186;7429.5542267464125;7592.164861865301;7598.0502437195355;7603.0876294844975;7612.733554325572;6811.829704257433;6846.726130954706;6874.8625027500175;6886.414654754402;6898.620575868375;6937.202221744564;7001.299870012958;7025.789226323219;7047.08387909589;7047.7180912762915 09:34:31 INFO - PROCESS | 1902 | |4;prototype.html;317.1073428299337;320.31612507296916;324.54725657707496;324.7126293230493;328.7337256821974;6487.740490380379;6490.740370385185;6503.772367967122;6509.153810004705;6516.185476815404;6344.6510441925675;6442.420182183602;6470.773522926698;6472.773452929148;6483.643399613019;4585.174668559658;4684.5549672781035;4712.3873896393425;4760.785764640599;4804.711717296956;4755.64332675049;4759.595434388081;4768.570828625423;4769.236922092466;4792.185328494164;4704.458987216462;4710.764461776897;4712.316714076457;4723.952760472385;4726.385569875912;4542.477615074259;4602.171609110359;4724.102420540121;4737.905241895177;4756.928646070294;3358.395488812013;4048.817803198863;4071.3282308419075;4073.307537718595;4094.3653733671326;6238.126662267241;6252.406021427957;6253.562250642457;6260.655663938482;6294.181756371642;5542.473465020817;5551.250581171531;5554.638948468377;5558.277423934863;5589.217509548666;6842.110525631636;6848.246692863781;6863.965680171617;6876.277990810943;6883.65581720917;4458.643308535342;4585.931211031837;4610.193216187154;4614.976925115353;4642.094791515656;7073.681684324218;7178.892316615255;7277.490575659706;7283.4537409694485;7302.2697730226555;3933.724639275223;4721.102990431807;4721.8347357842995;4721.866751979569;4724.480307166209;4784.114938736345;4797.232442809203;4798.832040878622;4817.229243321051;4817.8313759018265;5597.776088956396;5602.971985140048;5604.103343465026;5608.85977850557;5623.718814059281;5562.554995600342;6586.176727909012;6913.723451062002;6925.653717314114;6950.826229344206;1648.4724888035714;1664.9001059936443;1673.1383337581156;1675.4387280261249;1676.5892356372524;1068.5405275731355;1076.311160857052;1097.1058587251364;1101.2896681640457;1102.536934487517;6270.275674189635;6429.6463694496315;6449.96775016122;6597.043428702811;6597.505187110986;7234.059572255678;7255;7258.056452661121;7262.745803896838;7272.127344718668;6642.236142843635;6714.29499902513;6725.529212955144;6734.225564060098;6744.696488658022;3768.811559422018;3811.5426148862316;3812.1422679897355;3820.4651348810635;3824.9043773905873;7204.783856484314;7542.849143017219;7546.471746977769;7567.810804729816;7588.62056897153;7388.815279617945;7396.704131834666;7411.962940185264;7413.147488038837;7453.291937265951;7513.436492262993;7520.398368130536;7537.54774713508;7540.057492813288;7546.094468663796;6895.275996020346;7172.318629730167;7189.784306470814;7199.676014579251;7206.89189662166;5755.424457554211;5881.882362352814;7008.859822803413;7089.539179953286;7113.253108423748;7478.813029674302;7513.8497230054;7523.6833554126715;7527.887081693889;7543.622818859145;4707.29390591414;4712.952870471388;4723.338732577373;4726.598239149711;4740.431148262092;6455.903161452488;7155.606441645759;7160.677769500281;7162.140543134858;7165.641717914188;5476.808311709071;6722.932770672231;6934.133233345832;6951.582905025714;6957.617331046638;5615.550755939434;6844.384005439534;6873.243943166348;6890.517663763489;6915.066466027022;6708.127943367331;6734.393904548614;6746.9325306746305;6757.425618822259;6775.661216939232;6428.742850286123;6895.172579290316;6917.308269173042;6926.653667316513;6927.44580433554;5979;5985.802839432044;6159.260888693386;6617.702203400762;6743.561668491729 09:34:31 INFO - PROCESS | 1902 | |5;yui.html;629.2480485819445;668.3717305732608;700.1947760075909;709.2942522190422;783.3654739660875;15048.398064077437;15325;15330.846691533081;15336.46322378717;15348.155851428168;13419.865801341984;14206.36071376788;14236.644083897907;14244.430222791076;14244.928775356135;733.3729661139729;744.7951813251373;913.6756451459736;916.4913473022469;942.2367882015556;931.9720408387759;935.8034812689343;936.8360536906048;937.2689302344182;938.6761567259284;980.2745967983676;990.1089019882091;990.1583653894169;991.1179050644931;992.3301771304377;775.3061010395693;970.7815741458151;990.8414653655452;991.4051569058579;992.503748125937;717.2576383443111;731.6634348199834;732.3518685962908;736.6243215959845;737.4063878577742;14843;14912.62718432037;14922.40310387594;14933.626659333495;14978.850211497855;12342.75314493714;12365.629031129081;12468.688282792911;12627.684307892285;12646.304453255067;9660.855087173699;9790;9998.200143988464;10130.24023198263;10348.379097254114;3552.378333791576;3597.244578638463;3625.546806649169;3699.648533389324;3738.700903927679;73487;73887.63056184739;74101.62949185219;74221;74239.62880185619;9428.811423771485;9462.384944978554;9482.478463684563;9722.708318750307;9776.657816976372;21892.89053554722;21976.34070977841;21981.560368792856;22001;22021.559568808534;7254.093238345207;7279.2720727927845;7540.849183016309;7564.016677831846;7796.844063118706;4048.6963477739287;4076.381027423578;4077.7145599808323;4107.958920410817;4126.525449573277;3555.8577656893954;3599.9640003600152;3613.638636136418;3620.420732682758;3627.3652110881017;638.0747915522511;654.3652656922777;657.5890068707058;658.9703463344161;671.7783131566571;541.6804085589521;548.9670619762827;597.7685966908183;611.3366996808423;612.4549151255386;8016.559089250147;8641.438306510183;8654.31365134248;8812.779680508038;8829.426087304304;518.7250757098743;541.7697478571591;573.0258560447256;601.2544444888307;635.9682015899186;3807.428885667117;3810.65704086628;3877.2439374322303;3968.4245784361106;4055.574164712663;86845.56577217074;87717.56141219253;88688.66966995501;88770.11229887747;89102.66346004815;77558.61220693974;77858;78162.6091869537;78305.21694783094;78446.6077669608;60643;62520.37479625145;63460.365396346366;64168;66756.33243667598;7630.4277179212895;7909.723159689614;8140.185981401813;8283.958580207302;8299.543525105935;46270.53729462662;47168.292475613576;49592.75203623959;49683.50949471522;50282.748586256836;67840.64318713697;68613;68757;68769.65615171893;69091;10980.835287470854;11000.834987475355;11005.669829905115;11114.610988615359;11222.494987725735;11622.302661840316;11756.647300580997;11909.880901191224;11922.225055371373;11928.880711192776;11099.667009989713;11175.329480231212;11204.43977801123;11328.263662861887;11366.785974217499;11187;11198;11386.397999969888;11477.885221147682;11856.940715296369;10931.890681093088;10985.450727463434;11023.393713345842;11072.501737421997;11085.057770089632;9355.204807591159;9355.48544830041;9528.523573821143;9665.468399238109;10001.599936002769;8052.677892884219;8872;9662.9033709662;9677.612895484102;9734.75663108428 09:34:31 INFO - PROCESS | 1902 | __end_tp_report 09:34:31 INFO - PROCESS | 1902 | __start_cc_report 09:34:31 INFO - PROCESS | 1902 | _x_x_mozilla_cycle_collect,1060 09:34:31 INFO - PROCESS | 1902 | __end_cc_report 09:34:31 INFO - PROCESS | 1902 | __startTimestamp1459874070993__endTimestamp 09:34:31 INFO - PROCESS | 1902 | 09:34:31 INFO - PROCESS | 1902 | ------- Summary: start ------- 09:34:31 INFO - PROCESS | 1902 | Number of tests: 6 09:34:31 INFO - PROCESS | 1902 | 09:34:31 INFO - PROCESS | 1902 | [#0] dojo.html Cycles:165 Average:5663.50 Median:5817.53 stddev:627.68 (10.8%) stddev-sans-first:604.00 09:34:31 INFO - PROCESS | 1902 | Values: 3401.4 3447.9 3485.2 3503.4 3536.6 5534.0 5590.9 5601.9 5602.0 5633.1 5603.8 5639.9 5709.9 5730.0 5735.5 5021.0 5063.4 5071.8 5102.8 5198.7 5206.0 5206.7 5215.3 5264.5 5279.7 5030.6 5145.5 5149.3 5187.9 5188.3 5124.2 5135.9 5143.3 5149.3 5151.8 4943.2 5033.6 5036.7 5045.8 5070.6 5530.5 5543.4 5551.7 5554.3 5560.1 6044.3 6145.8 6170.4 6193.8 6196.1 6133.4 6193.1 6208.9 6261.9 6264.7 5696.6 5743.6 5748.7 5772.9 5794.3 6169.8 6323.7 6335.4 6338.8 6348.8 5958.8 6006.1 6006.3 6007.3 6009.5 6125.6 6129.2 6142.7 6223.9 6236.9 5215.2 6053.4 6115.8 6125.0 6134.1 6089.8 6176.5 6179.7 6181.9 6194.9 4746.2 4821.9 4826.3 4826.5 4864.1 4262.6 4309.5 4365.2 4405.9 4428.1 5578.3 5634.2 5654.9 5658.5 5676.9 5094.7 6063.6 6163.5 6249.9 6279.8 5585.9 5651.4 5679.5 5688.3 5688.5 5287.4 5301.4 5312.0 5316.5 5330.4 6293.6 6295.0 6299.1 6312.4 6318.4 5121.5 6058.3 6114.1 6128.5 6234.9 6260.0 6287.9 6292.8 6293.9 6296.7 6125.2 6149.4 6162.3 6165.3 6176.9 6074.8 6143.8 6188.8 6205.8 6249.0 6039.3 6040.3 6054.6 6071.1 6108.1 5853.9 6029.1 6033.2 6037.2 6037.8 5677.6 5761.3 5804.1 5817.5 5887.3 5960.4 5984.8 6006.1 6012.8 6027.6 5688.7 5859.1 5863.1 5872.5 5890.4 09:34:31 INFO - PROCESS | 1902 | 09:34:31 INFO - PROCESS | 1902 | [#1] ext.html Cycles:180 Average:57070.25 Median:211381.72 stddev:113355.94 (53.6%) stddev-sans-first:113594.26 09:34:31 INFO - PROCESS | 1902 | Values: 462.2 535.8 579.1 627.3 634.8 30468.8 30942.2 37777.8 37845.6 37971.4 41995.7 42457.8 42533.8 42542.6 42727.8 9385.3 9704.9 9720.7 9728.3 9746.4 9463.9 9657.7 9667.8 9670.5 9677.8 9793.9 9859.1 9868.0 9871.1 9880.8 9763.8 9829.1 9832.1 9832.6 9838.3 9525.2 9587.8 9658.0 9660.7 9673.2 40432.8 41165.8 41585.6 41654.6 41748.8 2746.2 3118.3 3218.6 3252.3 3727.4 28832.3 29718.3 29760.0 29782.9 30688.0 2703.9 2747.1 2781.2 2828.3 2891.3 411781.0 412572.0 414760.0 415594.0 416238.0 45536.0 62516.4 62541.4 62846.0 63007.4 45374.8 45468.3 45483.0 45496.8 45509.5 15121.9 15332.5 15381.5 15384.2 15416.9 12295.6 12373.8 12374.8 12386.5 12400.4 14255.4 14446.6 14878.5 14885.5 15001.0 5317.9 6205.8 6415.7 6422.3 6437.3 942.4 946.8 995.0 1078.4 1086.9 28989.4 29064.0 29490.1 29809.0 29860.9 975.9 1068.7 1136.8 1171.1 1231.9 14101.7 14931.6 14960.1 15312.1 15569.0 467335.0 472771.6 480575.0 481312.0 481591.6 58432.0 58972.0 59059.1 59089.0 59313.7 1339.7 1349.7 1351.6 1448.8 1488.2 30026.5 30453.7 30457.7 30764.7 30939.7 51534.7 52423.0 52949.0 53006.0 53109.0 384792.0 386982.0 387318.0 387880.9 389562.0 28484.3 32847.0 33465.2 33696.7 34002.7 41723.8 42066.0 42093.9 42165.0 42553.4 28105.4 33836.6 34013.7 34025.8 35101.0 25090.4 34481.8 35610.3 35830.8 36802.0 29223.6 31166.4 32991.0 35994.6 36797.4 30556.5 32023.0 32318.8 32446.0 33094.3 18968.6 21472.0 24205.2 24499.0 24701.1 09:34:31 INFO - PROCESS | 1902 | 09:34:31 INFO - PROCESS | 1902 | [#2] jquery.html Cycles:180 Average:32009.05 Median:354.39 stddev:92951.66 (26228.3%) stddev-sans-first:93182.02 09:34:31 INFO - PROCESS | 1902 | Values: 351.9 352.5 356.3 357.5 361.4 19273.8 19770.2 20735.3 21279.5 21320.4 19644.9 20296.6 20481.7 20779.2 20819.9 5507.2 5680.8 5727.0 5730.4 5736.9 4098.1 4211.4 5689.6 5983.2 6273.1 6224.5 6231.6 6239.5 6243.3 6245.4 6027.0 6117.7 6203.8 6212.0 6222.7 3633.5 5142.9 5339.3 5383.8 5405.2 23745.1 24177.9 24415.6 24809.0 24853.0 2160.2 2264.8 2336.3 2403.4 2577.9 8378.0 9838.1 14471.3 14785.0 14808.3 1601.3 1704.3 1794.6 1821.5 1838.7 82795.0 85621.3 86159.0 87878.0 88733.6 9192.6 10582.3 10763.0 10996.6 11079.6 13565.2 13617.7 13624.6 13654.2 13658.3 8290.3 8491.7 8499.3 8565.7 8579.8 8543.7 8545.4 8593.6 8687.5 8688.2 4316.2 4375.9 4385.5 4424.9 4431.1 1741.8 1796.6 1813.5 1819.0 1858.1 868.4 904.3 908.5 1023.4 1041.6 18629.6 18894.7 19011.0 19120.5 19335.3 790.3 928.7 949.7 996.3 997.2 10058.0 10305.4 10366.4 10462.9 10466.5 520851.0 563514.0 568037.0 576201.0 576230.0 103411.5 113147.0 114832.0 116236.0 120497.2 991.4 1008.9 1009.9 1026.4 1029.4 14913.3 17242.1 17326.2 17807.7 17997.9 44335.8 45355.0 48574.5 49380.8 50035.7 54358.0 69445.0 72618.6 72794.0 74008.0 7771.5 7813.5 7882.2 7902.4 7959.4 9115.4 11977.3 12229.8 12350.6 12478.1 10058.7 10147.9 10716.7 10747.2 10797.2 7968.9 10264.5 10506.7 10695.3 10709.6 9159.3 10528.4 10673.4 10678.9 10833.7 7312.7 7578.6 7741.3 7824.4 7927.8 8270.8 10316.8 10501.2 10513.7 10555.8 09:34:31 INFO - PROCESS | 1902 | 09:34:31 INFO - PROCESS | 1902 | [#3] mootools.html Cycles:180 Average:5940.64 Median:5457.41 stddev:3101.24 (56.8%) stddev-sans-first:3091.58 09:34:31 INFO - PROCESS | 1902 | Values: 1451.9 1582.3 1600.6 1883.8 2020.3 7761.3 7954.8 7964.7 7971.4 8009.9 8158.2 8429.0 8431.2 8443.8 8444.1 2407.4 2479.2 2479.8 2480.5 2481.6 2144.6 2213.5 2217.3 2404.3 2483.5 2150.3 2357.2 2440.5 2444.4 2445.4 2392.8 2428.1 2431.4 2435.5 2450.0 2049.4 2376.3 2431.4 2432.5 2436.6 8610.4 8661.6 8684.0 8684.6 8692.0 5292.3 5440.2 5451.8 5455.3 5478.2 2980.2 3497.5 3667.3 3675.6 3696.5 1033.5 1046.2 1057.6 1058.9 1073.9 11597.0 11604.4 11639.5 11687.6 11699.1 4767.0 4773.3 4779.5 4838.7 4855.7 9896.2 9897.4 9909.6 9916.9 9917.1 5445.1 5448.5 5456.7 5458.1 5470.8 4902.4 4977.4 4978.2 4985.4 4988.6 3846.1 3859.1 3889.8 3919.0 3920.3 1118.5 1148.5 1197.0 1255.6 1289.4 1144.2 1154.7 1174.3 1377.8 1416.9 7872.0 7948.5 7956.9 8295.8 8296.4 1131.1 1162.8 1219.5 1224.8 1251.3 5946.4 5972.9 5974.9 6010.0 6019.0 9856.6 10389.3 10436.4 10495.0 10521.7 10143.3 10504.2 10505.9 10594.3 10603.0 8202.3 8251.8 8256.8 8308.3 8319.4 7604.0 7819.7 7854.8 7864.3 7962.2 9266.4 9334.8 9396.6 9506.3 9540.9 9269.8 9543.3 9700.1 9770.7 9788.0 7288.7 7327.0 7395.3 7422.8 7426.4 7967.8 8175.1 8201.1 8205.2 8212.2 6005.5 7237.0 7373.9 7410.4 7565.8 6420.7 6783.7 7064.4 7104.2 7182.2 7429.6 7592.2 7598.1 7603.1 7612.7 6811.8 6846.7 6874.9 6886.4 6898.6 6937.2 7001.3 7025.8 7047.1 7047.7 09:34:31 INFO - PROCESS | 1902 | 09:34:31 INFO - PROCESS | 1902 | [#4] prototype.html Cycles:180 Average:5655.82 Median:6429.19 stddev:1790.30 (27.8%) stddev-sans-first:1749.91 09:34:31 INFO - PROCESS | 1902 | Values: 317.1 320.3 324.5 324.7 328.7 6487.7 6490.7 6503.8 6509.2 6516.2 6344.7 6442.4 6470.8 6472.8 6483.6 4585.2 4684.6 4712.4 4760.8 4804.7 4755.6 4759.6 4768.6 4769.2 4792.2 4704.5 4710.8 4712.3 4724.0 4726.4 4542.5 4602.2 4724.1 4737.9 4756.9 3358.4 4048.8 4071.3 4073.3 4094.4 6238.1 6252.4 6253.6 6260.7 6294.2 5542.5 5551.3 5554.6 5558.3 5589.2 6842.1 6848.2 6864.0 6876.3 6883.7 4458.6 4585.9 4610.2 4615.0 4642.1 7073.7 7178.9 7277.5 7283.5 7302.3 3933.7 4721.1 4721.8 4721.9 4724.5 4784.1 4797.2 4798.8 4817.2 4817.8 5597.8 5603.0 5604.1 5608.9 5623.7 5562.6 6586.2 6913.7 6925.7 6950.8 1648.5 1664.9 1673.1 1675.4 1676.6 1068.5 1076.3 1097.1 1101.3 1102.5 6270.3 6429.6 6450.0 6597.0 6597.5 7234.1 7255.0 7258.1 7262.7 7272.1 6642.2 6714.3 6725.5 6734.2 6744.7 3768.8 3811.5 3812.1 3820.5 3824.9 7204.8 7542.8 7546.5 7567.8 7588.6 7388.8 7396.7 7412.0 7413.1 7453.3 7513.4 7520.4 7537.5 7540.1 7546.1 6895.3 7172.3 7189.8 7199.7 7206.9 5755.4 5881.9 7008.9 7089.5 7113.3 7478.8 7513.8 7523.7 7527.9 7543.6 4707.3 4713.0 4723.3 4726.6 4740.4 6455.9 7155.6 7160.7 7162.1 7165.6 5476.8 6722.9 6934.1 6951.6 6957.6 5615.6 6844.4 6873.2 6890.5 6915.1 6708.1 6734.4 6746.9 6757.4 6775.7 6428.7 6895.2 6917.3 6926.7 6927.4 5979.0 5985.8 6159.3 6617.7 6743.6 09:34:31 INFO - PROCESS | 1902 | 09:34:31 INFO - PROCESS | 1902 | [#5] yui.html Cycles:180 Average:17804.79 Median:32048.17 stddev:24569.60 (76.7%) stddev-sans-first:24604.67 09:34:31 INFO - PROCESS | 1902 | Values: 629.2 668.4 700.2 709.3 783.4 15048.4 15325.0 15330.8 15336.5 15348.2 13419.9 14206.4 14236.6 14244.4 14244.9 733.4 744.8 913.7 916.5 942.2 932.0 935.8 936.8 937.3 938.7 980.3 990.1 990.2 991.1 992.3 775.3 970.8 990.8 991.4 992.5 717.3 731.7 732.4 736.6 737.4 14843.0 14912.6 14922.4 14933.6 14978.9 12342.8 12365.6 12468.7 12627.7 12646.3 9660.9 9790.0 9998.2 10130.2 10348.4 3552.4 3597.2 3625.5 3699.6 3738.7 73487.0 73887.6 74101.6 74221.0 74239.6 9428.8 9462.4 9482.5 9722.7 9776.7 21892.9 21976.3 21981.6 22001.0 22021.6 7254.1 7279.3 7540.8 7564.0 7796.8 4048.7 4076.4 4077.7 4108.0 4126.5 3555.9 3600.0 3613.6 3620.4 3627.4 638.1 654.4 657.6 659.0 671.8 541.7 549.0 597.8 611.3 612.5 8016.6 8641.4 8654.3 8812.8 8829.4 518.7 541.8 573.0 601.3 636.0 3807.4 3810.7 3877.2 3968.4 4055.6 86845.6 87717.6 88688.7 88770.1 89102.7 77558.6 77858.0 78162.6 78305.2 78446.6 60643.0 62520.4 63460.4 64168.0 66756.3 7630.4 7909.7 8140.2 8284.0 8299.5 46270.5 47168.3 49592.8 49683.5 50282.7 67840.6 68613.0 68757.0 68769.7 69091.0 10980.8 11000.8 11005.7 11114.6 11222.5 11622.3 11756.6 11909.9 11922.2 11928.9 11099.7 11175.3 11204.4 11328.3 11366.8 11187.0 11198.0 11386.4 11477.9 11856.9 10931.9 10985.5 11023.4 11072.5 11085.1 9355.2 9355.5 9528.5 9665.5 10001.6 8052.7 8872.0 9662.9 9677.6 9734.8 09:34:31 INFO - PROCESS | 1902 | -------- Summary: end -------- 09:34:31 INFO - PROCESS | 1902 | 09:34:31 INFO - TEST-INFO | 1902: exit 0 09:34:31 INFO - TEST-OK | dromaeo_css | took 1112845ms 09:34:31 INFO - TEST-START | kraken 09:34:31 INFO - operating with platform_type : mac_ 09:34:31 INFO - Initialising browser for kraken test... 09:34:31 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpKsgUO8/profile http://localhost:49288/getInfo.html) 09:34:33 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 09:34:33 INFO - PROCESS | 1909 | colorDepth:24 09:34:33 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 09:34:33 INFO - PROCESS | 1909 | __metrics 09:34:33 INFO - PROCESS | 1909 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:34:33 ERROR - PROCESS | 1909 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:34:34 INFO - TEST-INFO | 1909: exit 0 09:34:34 INFO - Browser initialized. 09:34:34 INFO - Running cycle 1/1 for kraken test... 09:34:34 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpKsgUO8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:46 INFO - PROCESS | 1911 | RSS: Main: 236204032 09:34:46 INFO - PROCESS | 1911 | 09:34:48 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:49 INFO - PROCESS | 1911 | RSS: Main: 281882624 09:34:49 INFO - PROCESS | 1911 | 09:34:51 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-dft) 09:34:52 INFO - PROCESS | 1911 | RSS: Main: 292372480 09:34:52 INFO - PROCESS | 1911 | 09:34:55 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-fft) 09:34:56 INFO - PROCESS | 1911 | RSS: Main: 279650304 09:34:56 INFO - PROCESS | 1911 | 09:34:58 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator) 09:34:59 INFO - PROCESS | 1911 | RSS: Main: 281919488 09:34:59 INFO - PROCESS | 1911 | 09:35:01 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:35:01 INFO - PROCESS | 1911 | RSS: Main: 282599424 09:35:01 INFO - PROCESS | 1911 | 09:35:04 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom) 09:35:05 INFO - PROCESS | 1911 | RSS: Main: 282701824 09:35:05 INFO - PROCESS | 1911 | 09:35:08 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate) 09:35:08 INFO - PROCESS | 1911 | RSS: Main: 282816512 09:35:08 INFO - PROCESS | 1911 | 09:35:11 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial) 09:35:12 INFO - PROCESS | 1911 | RSS: Main: 283090944 09:35:12 INFO - PROCESS | 1911 | 09:35:13 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:14 INFO - PROCESS | 1911 | RSS: Main: 315555840 09:35:14 INFO - PROCESS | 1911 | 09:35:16 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:17 INFO - PROCESS | 1911 | RSS: Main: 315629568 09:35:17 INFO - PROCESS | 1911 | 09:35:19 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:19 INFO - PROCESS | 1911 | RSS: Main: 322605056 09:35:19 INFO - PROCESS | 1911 | 09:35:22 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:22 INFO - PROCESS | 1911 | RSS: Main: 323559424 09:35:22 INFO - PROCESS | 1911 | 09:35:25 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:25 INFO - PROCESS | 1911 | RSS: Main: 323657728 09:35:25 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49288/tests/kraken/driver.html?testName=ai-astar) 09:35:27 INFO - PROCESS | 1911 | RSS: Main: 386371584 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | __start_tp_report 09:35:27 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 09:35:27 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 09:35:27 INFO - PROCESS | 1911 | |i|pagename|runs| 09:35:27 INFO - PROCESS | 1911 | |0;ai-astar;110;108;110;110;110;110;117;110;111;110 09:35:27 INFO - PROCESS | 1911 | |1;audio-beat-detection;156;122;145;160;119;142;141;118;171;153 09:35:27 INFO - PROCESS | 1911 | |2;audio-dft;184;183;186;186;185;183;187;183;238;256 09:35:27 INFO - PROCESS | 1911 | |3;audio-fft;83;88;106;159;45;76;84;84;152;74 09:35:27 INFO - PROCESS | 1911 | |4;audio-oscillator;90;89;136;81;77;83;116;78;82;119 09:35:27 INFO - PROCESS | 1911 | |5;imaging-gaussian-blur;90;88;90;96;134;121;91;87;90;86 09:35:27 INFO - PROCESS | 1911 | |6;imaging-darkroom;96;94;107;149;148;94;95;94;95;95 09:35:27 INFO - PROCESS | 1911 | |7;imaging-desaturate;85;98;137;135;86;86;86;88;82;77 09:35:27 INFO - PROCESS | 1911 | |8;json-parse-financial;55;53;55;54;53;54;53;65;55;53 09:35:27 INFO - PROCESS | 1911 | |9;json-stringify-tinderbox;62;64;63;77;72;71;65;69;66;66 09:35:27 INFO - PROCESS | 1911 | |10;stanford-crypto-aes;87;84;84;83;83;83;84;83;82;85 09:35:27 INFO - PROCESS | 1911 | |11;stanford-crypto-ccm;108;140;135;107;127;135;128;129;118;125 09:35:27 INFO - PROCESS | 1911 | |12;stanford-crypto-pbkdf2;152;127;141;140;141;129;141;141;143;141 09:35:27 INFO - PROCESS | 1911 | |13;stanford-crypto-sha256-iterative;68;67;66;65;63;67;65;66;67;66 09:35:27 INFO - PROCESS | 1911 | __end_tp_report 09:35:27 INFO - PROCESS | 1911 | __start_cc_report 09:35:27 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,1322 09:35:27 INFO - PROCESS | 1911 | __end_cc_report 09:35:27 INFO - PROCESS | 1911 | __startTimestamp1459874127913__endTimestamp 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | ------- Summary: start ------- 09:35:27 INFO - PROCESS | 1911 | Number of tests: 14 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#0] ai-astar Cycles:10 Average:110.60 Median:110.00 stddev:2.37 (2.2%) stddev-sans-first:2.50 09:35:27 INFO - PROCESS | 1911 | Values: 110.0 108.0 110.0 110.0 110.0 110.0 117.0 110.0 111.0 110.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:149.00 stddev:18.23 (12.2%) stddev-sans-first:18.69 09:35:27 INFO - PROCESS | 1911 | Values: 156.0 122.0 145.0 160.0 119.0 142.0 141.0 118.0 171.0 153.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#2] audio-dft Cycles:10 Average:197.10 Median:186.00 stddev:26.68 (14.3%) stddev-sans-first:27.87 09:35:27 INFO - PROCESS | 1911 | Values: 184.0 183.0 186.0 186.0 185.0 183.0 187.0 183.0 238.0 256.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#3] audio-fft Cycles:10 Average:95.10 Median:79.50 stddev:35.28 (44.4%) stddev-sans-first:37.15 09:35:27 INFO - PROCESS | 1911 | Values: 83.0 88.0 106.0 159.0 45.0 76.0 84.0 84.0 152.0 74.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:81.50 stddev:20.77 (25.5%) stddev-sans-first:21.94 09:35:27 INFO - PROCESS | 1911 | Values: 90.0 89.0 136.0 81.0 77.0 83.0 116.0 78.0 82.0 119.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#5] imaging-gaussian-blur Cycles:10 Average:97.30 Median:90.00 stddev:16.43 (18.3%) stddev-sans-first:17.22 09:35:27 INFO - PROCESS | 1911 | Values: 90.0 88.0 90.0 96.0 134.0 121.0 91.0 87.0 90.0 86.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#6] imaging-darkroom Cycles:10 Average:106.70 Median:94.50 stddev:22.37 (23.7%) stddev-sans-first:23.39 09:35:27 INFO - PROCESS | 1911 | Values: 96.0 94.0 107.0 149.0 148.0 94.0 95.0 94.0 95.0 95.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:86.00 stddev:21.73 (25.3%) stddev-sans-first:22.68 09:35:27 INFO - PROCESS | 1911 | Values: 85.0 98.0 137.0 135.0 86.0 86.0 86.0 88.0 82.0 77.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.50 stddev:3.62 (6.6%) stddev-sans-first:3.84 09:35:27 INFO - PROCESS | 1911 | Values: 55.0 53.0 55.0 54.0 53.0 54.0 53.0 65.0 55.0 53.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:4.70 (7.0%) stddev-sans-first:4.54 09:35:27 INFO - PROCESS | 1911 | Values: 62.0 64.0 63.0 77.0 72.0 71.0 65.0 69.0 66.0 66.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.40 (1.7%) stddev-sans-first:0.88 09:35:27 INFO - PROCESS | 1911 | Values: 87.0 84.0 84.0 83.0 83.0 83.0 84.0 83.0 82.0 85.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:128.50 stddev:11.13 (8.7%) stddev-sans-first:9.92 09:35:27 INFO - PROCESS | 1911 | Values: 108.0 140.0 135.0 107.0 127.0 135.0 128.0 129.0 118.0 125.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.60 Median:141.00 stddev:7.04 (5.0%) stddev-sans-first:5.87 09:35:27 INFO - PROCESS | 1911 | Values: 152.0 127.0 141.0 140.0 141.0 129.0 141.0 141.0 143.0 141.0 09:35:27 INFO - PROCESS | 1911 | 09:35:27 INFO - PROCESS | 1911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.41 (2.1%) stddev-sans-first:1.30 09:35:27 INFO - PROCESS | 1911 | Values: 68.0 67.0 66.0 65.0 63.0 67.0 65.0 66.0 67.0 66.0 09:35:27 INFO - PROCESS | 1911 | -------- Summary: end -------- 09:35:27 INFO - PROCESS | 1911 | 09:35:28 INFO - TEST-INFO | 1911: exit 0 09:35:28 INFO - TEST-OK | kraken | took 57067ms 09:35:28 INFO - SUITE-END | took 1169s 09:35:28 INFO - Completed test suite (00:19:29) 09:35:28 INFO - javascript benchmark 09:35:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3401.4047541680206, 3447.8620855165796, 3485.163560745422, 3503.351879902218, 3536.6463353664635, 5533.972330138344, 5590.944090559104, 5601.859953501159, 5602.019646561851, 5633.070543360351, 5603.831885043455, 5639.943600563993, 5709.914351284734, 5729.971350143254, 5735.455131762486, 5021.0, 5063.392392912847, 5071.847844564669, 5102.821401250957, 5198.714070726109, 5206.036883176605, 5206.661566998152, 5215.322008138936, 5264.526192642661, 5279.70961597112, 5030.57240134589, 5145.511176438233, 5149.2791009258735, 5187.910538786859, 5188.273641690166, 5124.205748109011, 5135.897282054338, 5143.3313669223135, 5149.2791009258735, 5151.793928242866, 4943.233798761198, 5033.597312215014, 5036.697798132123, 5045.823396181116, 5070.61970352225, 5530.5299049580835, 5543.445655434464, 5551.694656793875, 5554.333479982428, 5560.054790685593, 6044.2746870375395, 6145.754169833202, 6170.444659980623, 6193.81418557444, 6196.070589411579, 6133.365267548864, 6193.102000209944, 6208.906866397007, 6261.87476250477, 6264.655443950581, 5696.572757043238, 5743.62666426681, 5748.7125643717645, 5772.855678608026, 5794.304683438015, 6169.753209871555, 6323.683815809191, 6335.366463353628, 6338.778142764981, 6348.841278968062, 5958.791442299499, 6006.099085137177, 6006.309274433496, 6007.309159446632, 6009.45914867664, 6125.6017461851925, 6129.2032035835055, 6142.682951206388, 6223.875522489525, 6236.906446403307, 5215.24378965048, 6053.424924632153, 6115.848865095035, 6125.021800333928, 6134.069235337226, 6089.847753806191, 6176.474999624992, 6179.660118693425, 6181.938180618136, 6194.876102478015, 4746.169420351424, 4821.927671084936, 4826.276058591169, 4826.493218212037, 4864.100141473838, 4262.573742625713, 4309.482862056573, 4365.236083685342, 4405.933910991338, 4428.1365133799245, 5578.330600327906, 5634.211210430543, 5654.943450565442, 5658.519025882763, 5676.914846277309, 5094.719790411489, 6063.636181829104, 6163.537734669828, 6249.875002500015, 6279.843003924847, 5585.944140558542, 5651.406602306781, 5679.5172410345585, 5688.288963879515, 5688.488036076773, 5287.391949925731, 5301.363836339664, 5312.043832110257, 5316.548093412026, 5330.440303768126, 6293.590916590407, 6295.0, 6299.149614801943, 6312.368763123651, 6318.4313411793155, 5121.462246464068, 6058.27300723916, 6114.0828875669, 6128.472568454128, 6234.875302494015, 6259.96870015647, 6287.874242515216, 6292.842678933063, 6293.937060629518, 6296.6851657417865, 6125.173101631222, 6149.446549810538, 6162.322144564005, 6165.260168779775, 6176.907346389898, 6074.817755467343, 6143.757528501975, 6188.752449902134, 6205.751769929333, 6249.0, 6039.275286965592, 6040.251685483006, 6054.606450580698, 6071.119687645355, 6108.114323423168, 5853.882922341444, 6029.065494848305, 6033.155358249761, 6037.18498002764, 6037.849053773691, 5677.574181936454, 5761.251037365283, 5804.100364443518, 5817.5345972321265, 5887.322957859901, 5960.374160713062, 5984.760609575568, 6006.069059295816, 6012.819615411545, 6027.60820546663, 5688.715564221689, 5859.091840764689, 5863.061910094364, 5872.500837428695, 5890.352061273342], "unit": "score", "name": "dojo.html", "value": 5625.013745538245}, {"lowerIsBetter": false, "replicates": [462.2373084410724, 535.783007881808, 579.1370857422439, 627.3381582430535, 634.7905191286876, 30468.781248750052, 30942.226444338903, 37777.81111094447, 37845.62154378455, 37971.430428543594, 41995.69023703703, 42457.7877110614, 42533.78733106338, 42542.57457425432, 42727.786361068225, 9385.296102792301, 9704.854427183562, 9720.708378748614, 9728.270379721514, 9746.415215087081, 9463.858042129374, 9657.710268691915, 9667.758306042335, 9670.516474176264, 9677.806443871119, 9793.902060979406, 9859.063388978035, 9868.0, 9871.111599956002, 9880.752981175456, 9763.804723905518, 9829.115379615798, 9832.115109640095, 9832.606695732162, 9838.311318207765, 9525.19035881951, 9587.760305992337, 9658.0, 9660.71017869465, 9673.177779888647, 40432.79783601093, 41165.79417102925, 41585.58414415847, 41654.58345416567, 41748.79125604383, 2746.2036009557205, 3118.2672072063046, 3218.61376634803, 3252.317013427183, 3727.434477519448, 28832.27919302013, 29718.257043573867, 29760.0, 29782.915195936293, 30688.0, 2703.8918443262246, 2747.107190163185, 2781.1795520321552, 2828.278788908815, 2891.3060865392363, 411781.0, 412572.0, 414760.0, 415594.0, 416238.0, 45536.0, 62516.37483625196, 62541.37458625356, 62846.0, 63007.369926301064, 45374.77312613416, 45468.3179752304, 45483.0, 45496.77251613787, 45509.54490455119, 15121.924390377977, 15332.463363782437, 15381.538553843402, 15384.230788460532, 15416.922915385352, 12295.631131066082, 12373.814392783936, 12374.752504950031, 12386.504539818307, 12400.441980110916, 14255.429782808778, 14446.566603001927, 14878.479253226085, 14885.479008234659, 15001.0, 5317.867053323698, 6205.844853878599, 6415.743370265137, 6422.33473108664, 6437.324080971431, 942.4392486470539, 946.8248374050822, 994.955227014786, 1078.4068762180768, 1086.9456527173768, 28989.42021159565, 29064.0, 29490.11529654114, 29809.0, 29860.850695746383, 975.8731364922656, 1068.6847380022912, 1136.7953768321781, 1171.1216587559331, 1231.8569431041515, 14101.71796564063, 14931.626709332353, 14960.102393856403, 15312.081275123528, 15569.0, 467335.0, 472771.6361418171, 480575.0, 481312.0, 481591.5920420375, 58432.0, 58972.0, 59059.114113288335, 59089.0, 59313.70343148343, 1339.6583871112998, 1349.730053989206, 1351.5877657314613, 1448.8116544849102, 1488.2261224163374, 30026.549601755552, 30453.695463045085, 30457.695423045487, 30764.692353077076, 30939.69060309368, 51534.74232628813, 52423.0, 52949.0, 53006.0, 53109.0, 384792.0, 386982.0, 387318.0, 387880.9089318369, 389562.0, 28484.287892802844, 32847.0, 33465.16337091592, 33696.663033369354, 34002.659973400936, 41723.7913810429, 42066.0, 42093.94765130896, 42165.0, 42553.361699573914, 28105.43789124165, 33836.64653413836, 34013.65986340105, 34025.82987085148, 35101.0, 25090.37274068163, 34481.79313724008, 35610.28779424449, 35830.82084589561, 36802.0, 29223.58913884239, 31166.37667246688, 32991.0, 35994.64005359913, 36797.44803827998, 30556.541651874795, 32023.0, 32318.83840580782, 32446.0, 33094.33811323808, 18968.620627587094, 21472.0, 24205.152819651226, 24499.0, 24701.135460258804], "unit": "score", "name": "ext.html", "value": 18764.69296140918}, {"lowerIsBetter": false, "replicates": [351.93489204497183, 352.45193723759553, 356.3372127842213, 357.4977157094282, 361.36039210597227, 19273.807261927377, 19770.20919163232, 20735.274265400734, 21279.468013299676, 21320.36038918831, 19644.919529425875, 20296.59406811863, 20481.692774608393, 20779.16883324669, 20819.895900520514, 5507.201455788908, 5680.801171958982, 5726.971365143189, 5730.369659337491, 5736.938666346739, 4098.118904435546, 4211.410402543646, 5689.6017278790505, 5983.192269043667, 6273.12176295319, 6224.533160012995, 6231.594946328497, 6239.532035097386, 6243.250809902818, 6245.437910588046, 6026.969865150646, 6117.66352850593, 6203.75184992602, 6212.0371342441995, 6222.719977601018, 3633.509476220729, 5142.948570514284, 5339.252504649314, 5383.757730902119, 5405.189221616789, 23745.05019799206, 24177.87911060451, 24415.63376549353, 24809.0, 24853.0, 2160.2007257314895, 2264.818814494853, 2336.3224664847176, 2403.3871362802547, 2577.917274744612, 8378.0, 9838.114569688762, 14471.348789304506, 14785.0, 14808.259587020713, 1601.2714215032133, 1704.2756828348026, 1794.6270015186096, 1821.4717731857745, 1838.6874231380698, 82795.0, 85621.28757424817, 86159.0, 87878.0, 88733.55633221858, 9192.56397054781, 10582.259241853151, 10762.977517136016, 10996.560137594566, 11079.612213572485, 13565.186088834702, 13617.727645447036, 13624.591262262147, 13654.180749155083, 13658.317084145752, 8290.336773058141, 8491.660333586711, 8499.277561407349, 8565.657373705106, 8579.82840343202, 8543.658253669908, 8545.401821872534, 8593.613287402082, 8687.522186279815, 8688.218060374596, 4316.179925814085, 4375.890602734957, 4385.451818522684, 4424.911501770011, 4431.1137772445, 1741.8345257200547, 1796.6227092310762, 1813.5103522049237, 1819.0359109671895, 1858.0988220712943, 868.3964644571962, 904.2954031650387, 908.4821651658623, 1023.3706270643501, 1041.6041904076553, 18629.627407451775, 18894.716579251322, 19011.0, 19120.521986950436, 19335.323263685703, 790.3361176611673, 928.744595236302, 949.7245798718433, 996.2976101848179, 997.1673652500099, 10058.04448577384, 10305.381677099398, 10366.429846358522, 10462.895371046345, 10466.53548210324, 520851.0, 563514.0, 568037.0, 576201.0, 576230.0, 103411.4829425848, 113147.0, 114832.0, 116236.0, 120497.19254211194, 991.4002028772633, 1008.9192864570816, 1009.9444530551037, 1026.4200726589602, 1029.4441001858913, 14913.3289001993, 17242.137893105544, 17326.220320085373, 17807.73288400649, 17997.910010449865, 44335.77832110819, 45355.0, 48574.514254857, 49380.8026317767, 50035.74910627263, 54358.0, 69445.0, 72618.63690681513, 72794.0, 74008.0, 7771.494852834548, 7813.531188128731, 7882.211778822072, 7902.367810575255, 7959.4030447715495, 9115.36192466521, 11977.341246231192, 12229.816552751538, 12350.567730129402, 12478.126531142732, 10058.748531286483, 10147.934466881166, 10716.73208169802, 10747.193960453154, 10797.24419290642, 7968.920310796818, 10264.538095785558, 10506.737331566772, 10695.304805187638, 10709.571617135227, 9159.267258619162, 10528.420936848546, 10673.35959842412, 10678.89321106779, 10833.67498975032, 7312.707491700486, 7578.621068946641, 7741.264579864904, 7824.374050076094, 7927.762167134995, 8270.83458330818, 10316.845247321446, 10501.212409069198, 10513.737156571147, 10555.78328551013], "unit": "score", "name": "jquery.html", "value": 9122.681969062744}, {"lowerIsBetter": false, "replicates": [1451.8838492920568, 1582.2642471250867, 1600.631854673425, 1883.7927827938925, 2020.323191730771, 7761.340286075683, 7954.76135715928, 7964.681412743484, 7971.441999060068, 8009.91990080099, 8158.184181581853, 8429.030661473933, 8431.241188293052, 8443.788905277372, 8444.071152173272, 2407.410184504799, 2479.1818699829105, 2479.76442237988, 2480.528699547089, 2481.565725997943, 2144.6354119799594, 2213.4908970936613, 2217.345882964529, 2404.278716385086, 2483.4784695213934, 2150.3011521255653, 2357.222116701493, 2440.511897620474, 2444.3889027743066, 2445.4497738008986, 2392.83250172488, 2428.077330614373, 2431.3556907419547, 2435.452023294762, 2449.9755002449924, 2049.405672355015, 2376.2989917974237, 2431.4286142756437, 2432.4526981429212, 2436.5857804173156, 8610.44032137909, 8661.566921653892, 8684.0, 8684.60919258635, 8692.0, 5292.285541451932, 5440.156775699773, 5451.781928722886, 5455.263539422167, 5478.205660179252, 2980.2251414632133, 3497.475378693191, 3667.266546690646, 3675.61406052366, 3696.537932758405, 1033.4625994482901, 1046.2414749306693, 1057.6086847866338, 1058.878229003659, 1073.924825262232, 11597.014253788439, 11604.419779011016, 11639.534418623329, 11687.649370518813, 11699.122565807598, 4767.046590681808, 4773.307870358779, 4779.498152693986, 4838.7338696372035, 4855.732934688626, 9896.20830333586, 9897.406155630686, 9909.603615855429, 9916.851247231298, 9917.057879501435, 5445.074337362658, 5448.482394172626, 5456.727163641802, 5458.099413596791, 5470.753816078286, 4902.411710594752, 4977.40271167455, 4978.2034874419915, 4985.401751789808, 4988.625853061035, 3846.0577158595765, 3859.073822282688, 3889.8055097245024, 3918.9804050980133, 3920.3335432976464, 1118.5078565431184, 1148.4602236948622, 1197.0363857095122, 1255.5856567332758, 1289.374653293152, 1144.210494758614, 1154.705550084723, 1174.2543484886987, 1377.7726675098497, 1416.9362378692983, 7872.0, 7948.483348582324, 7956.880646790303, 8295.8340833183, 8296.377771667148, 1131.095123900876, 1162.773259214445, 1219.4878151176526, 1224.7917853964848, 1251.2805137046234, 5946.405359464019, 5972.85067873298, 5974.850628734316, 6010.038393857049, 6019.036954087325, 9856.556454959544, 10389.272750907365, 10436.42599657011, 10495.0, 10521.736956576147, 10143.289969702199, 10504.212184086224, 10505.894941050492, 10594.258401911946, 10603.045725884707, 8202.343812494986, 8251.793705157419, 8256.793580160544, 8308.252257296872, 8319.376046796515, 7603.9619801902845, 7819.726309579138, 7854.842903142019, 7864.292213700565, 7962.203779621991, 9266.351355405057, 9334.813303734023, 9396.624135034523, 9506.287028472754, 9540.904590954002, 9269.768255793659, 9543.33196676226, 9700.12698857078, 9770.706878793648, 9787.972262912577, 7288.708451661874, 7326.96336518314, 7395.297446742766, 7422.777316680508, 7426.405887529093, 7967.84064318722, 8175.100738918595, 8201.13888041771, 8205.220504052106, 8212.17878212174, 6005.519558435228, 7237.0, 7373.926260737324, 7410.370118539984, 7565.8108547284555, 6420.7431702731365, 6783.728650853911, 7064.364207221375, 7104.2239440139965, 7182.245864184186, 7429.5542267464125, 7592.164861865301, 7598.0502437195355, 7603.0876294844975, 7612.733554325572, 6811.829704257433, 6846.726130954706, 6874.8625027500175, 6886.414654754402, 6898.620575868375, 6937.202221744564, 7001.299870012958, 7025.789226323219, 7047.08387909589, 7047.7180912762915], "unit": "score", "name": "mootools.html", "value": 4859.705313427518}, {"lowerIsBetter": false, "replicates": [317.1073428299337, 320.31612507296916, 324.54725657707496, 324.7126293230493, 328.7337256821974, 6487.740490380379, 6490.740370385185, 6503.772367967122, 6509.153810004705, 6516.185476815404, 6344.6510441925675, 6442.420182183602, 6470.773522926698, 6472.773452929148, 6483.643399613019, 4585.174668559658, 4684.5549672781035, 4712.3873896393425, 4760.785764640599, 4804.711717296956, 4755.64332675049, 4759.595434388081, 4768.570828625423, 4769.236922092466, 4792.185328494164, 4704.458987216462, 4710.764461776897, 4712.316714076457, 4723.952760472385, 4726.385569875912, 4542.477615074259, 4602.171609110359, 4724.102420540121, 4737.905241895177, 4756.928646070294, 3358.395488812013, 4048.817803198863, 4071.3282308419075, 4073.307537718595, 4094.3653733671326, 6238.126662267241, 6252.406021427957, 6253.562250642457, 6260.655663938482, 6294.181756371642, 5542.473465020817, 5551.250581171531, 5554.638948468377, 5558.277423934863, 5589.217509548666, 6842.110525631636, 6848.246692863781, 6863.965680171617, 6876.277990810943, 6883.65581720917, 4458.643308535342, 4585.931211031837, 4610.193216187154, 4614.976925115353, 4642.094791515656, 7073.681684324218, 7178.892316615255, 7277.490575659706, 7283.4537409694485, 7302.2697730226555, 3933.724639275223, 4721.102990431807, 4721.8347357842995, 4721.866751979569, 4724.480307166209, 4784.114938736345, 4797.232442809203, 4798.832040878622, 4817.229243321051, 4817.8313759018265, 5597.776088956396, 5602.971985140048, 5604.103343465026, 5608.85977850557, 5623.718814059281, 5562.554995600342, 6586.176727909012, 6913.723451062002, 6925.653717314114, 6950.826229344206, 1648.4724888035714, 1664.9001059936443, 1673.1383337581156, 1675.4387280261249, 1676.5892356372524, 1068.5405275731355, 1076.311160857052, 1097.1058587251364, 1101.2896681640457, 1102.536934487517, 6270.275674189635, 6429.6463694496315, 6449.96775016122, 6597.043428702811, 6597.505187110986, 7234.059572255678, 7255.0, 7258.056452661121, 7262.745803896838, 7272.127344718668, 6642.236142843635, 6714.29499902513, 6725.529212955144, 6734.225564060098, 6744.696488658022, 3768.811559422018, 3811.5426148862316, 3812.1422679897355, 3820.4651348810635, 3824.9043773905873, 7204.783856484314, 7542.849143017219, 7546.471746977769, 7567.810804729816, 7588.62056897153, 7388.815279617945, 7396.704131834666, 7411.962940185264, 7413.147488038837, 7453.291937265951, 7513.436492262993, 7520.398368130536, 7537.54774713508, 7540.057492813288, 7546.094468663796, 6895.275996020346, 7172.318629730167, 7189.784306470814, 7199.676014579251, 7206.89189662166, 5755.424457554211, 5881.882362352814, 7008.859822803413, 7089.539179953286, 7113.253108423748, 7478.813029674302, 7513.8497230054, 7523.6833554126715, 7527.887081693889, 7543.622818859145, 4707.29390591414, 4712.952870471388, 4723.338732577373, 4726.598239149711, 4740.431148262092, 6455.903161452488, 7155.606441645759, 7160.677769500281, 7162.140543134858, 7165.641717914188, 5476.808311709071, 6722.932770672231, 6934.133233345832, 6951.582905025714, 6957.617331046638, 5615.550755939434, 6844.384005439534, 6873.243943166348, 6890.517663763489, 6915.066466027022, 6708.127943367331, 6734.393904548614, 6746.9325306746305, 6757.425618822259, 6775.661216939232, 6428.742850286123, 6895.172579290316, 6917.308269173042, 6926.653667316513, 6927.44580433554, 5979.0, 5985.802839432044, 6159.260888693386, 6617.702203400762, 6743.561668491729], "unit": "score", "name": "prototype.html", "value": 5062.8407028417005}, {"lowerIsBetter": false, "replicates": [629.2480485819445, 668.3717305732608, 700.1947760075909, 709.2942522190422, 783.3654739660875, 15048.398064077437, 15325.0, 15330.846691533081, 15336.46322378717, 15348.155851428168, 13419.865801341984, 14206.36071376788, 14236.644083897907, 14244.430222791076, 14244.928775356135, 733.3729661139729, 744.7951813251373, 913.6756451459736, 916.4913473022469, 942.2367882015556, 931.9720408387759, 935.8034812689343, 936.8360536906048, 937.2689302344182, 938.6761567259284, 980.2745967983676, 990.1089019882091, 990.1583653894169, 991.1179050644931, 992.3301771304377, 775.3061010395693, 970.7815741458151, 990.8414653655452, 991.4051569058579, 992.503748125937, 717.2576383443111, 731.6634348199834, 732.3518685962908, 736.6243215959845, 737.4063878577742, 14843.0, 14912.62718432037, 14922.40310387594, 14933.626659333495, 14978.850211497855, 12342.75314493714, 12365.629031129081, 12468.688282792911, 12627.684307892285, 12646.304453255067, 9660.855087173699, 9790.0, 9998.200143988464, 10130.24023198263, 10348.379097254114, 3552.378333791576, 3597.244578638463, 3625.546806649169, 3699.648533389324, 3738.700903927679, 73487.0, 73887.63056184739, 74101.62949185219, 74221.0, 74239.62880185619, 9428.811423771485, 9462.384944978554, 9482.478463684563, 9722.708318750307, 9776.657816976372, 21892.89053554722, 21976.34070977841, 21981.560368792856, 22001.0, 22021.559568808534, 7254.093238345207, 7279.2720727927845, 7540.849183016309, 7564.016677831846, 7796.844063118706, 4048.6963477739287, 4076.381027423578, 4077.7145599808323, 4107.958920410817, 4126.525449573277, 3555.8577656893954, 3599.9640003600152, 3613.638636136418, 3620.420732682758, 3627.3652110881017, 638.0747915522511, 654.3652656922777, 657.5890068707058, 658.9703463344161, 671.7783131566571, 541.6804085589521, 548.9670619762827, 597.7685966908183, 611.3366996808423, 612.4549151255386, 8016.559089250147, 8641.438306510183, 8654.31365134248, 8812.779680508038, 8829.426087304304, 518.7250757098743, 541.7697478571591, 573.0258560447256, 601.2544444888307, 635.9682015899186, 3807.428885667117, 3810.65704086628, 3877.2439374322303, 3968.4245784361106, 4055.574164712663, 86845.56577217074, 87717.56141219253, 88688.66966995501, 88770.11229887747, 89102.66346004815, 77558.61220693974, 77858.0, 78162.6091869537, 78305.21694783094, 78446.6077669608, 60643.0, 62520.37479625145, 63460.365396346366, 64168.0, 66756.33243667598, 7630.4277179212895, 7909.723159689614, 8140.185981401813, 8283.958580207302, 8299.543525105935, 46270.53729462662, 47168.292475613576, 49592.75203623959, 49683.50949471522, 50282.748586256836, 67840.64318713697, 68613.0, 68757.0, 68769.65615171893, 69091.0, 10980.835287470854, 11000.834987475355, 11005.669829905115, 11114.610988615359, 11222.494987725735, 11622.302661840316, 11756.647300580997, 11909.880901191224, 11922.225055371373, 11928.880711192776, 11099.667009989713, 11175.329480231212, 11204.43977801123, 11328.263662861887, 11366.785974217499, 11187.0, 11198.0, 11386.397999969888, 11477.885221147682, 11856.940715296369, 10931.890681093088, 10985.450727463434, 11023.393713345842, 11072.501737421997, 11085.057770089632, 9355.204807591159, 9355.48544830041, 9528.523573821143, 9665.468399238109, 10001.599936002769, 8052.677892884219, 8872.0, 9662.9033709662, 9677.612895484102, 9734.75663108428], "unit": "score", "name": "yui.html", "value": 6869.949567569805}], "name": "dromaeo_css", "value": 7389.184319249886}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 110.0, 110.0, 110.0, 110.0, 117.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 145.0, 160.0, 119.0, 142.0, 141.0, 118.0, 171.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 142.7}, {"lowerIsBetter": true, "replicates": [184.0, 183.0, 186.0, 186.0, 185.0, 183.0, 187.0, 183.0, 238.0, 256.0], "unit": "score", "name": "audio-dft", "value": 197.1}, {"lowerIsBetter": true, "replicates": [83.0, 88.0, 106.0, 159.0, 45.0, 76.0, 84.0, 84.0, 152.0, 74.0], "unit": "score", "name": "audio-fft", "value": 95.1}, {"lowerIsBetter": true, "replicates": [90.0, 89.0, 136.0, 81.0, 77.0, 83.0, 116.0, 78.0, 82.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 95.1}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 90.0, 96.0, 134.0, 121.0, 91.0, 87.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.3}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 107.0, 149.0, 148.0, 94.0, 95.0, 94.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 106.7}, {"lowerIsBetter": true, "replicates": [85.0, 98.0, 137.0, 135.0, 86.0, 86.0, 86.0, 88.0, 82.0, 77.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [55.0, 53.0, 55.0, 54.0, 53.0, 54.0, 53.0, 65.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 63.0, 77.0, 72.0, 71.0, 65.0, 69.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 84.0, 83.0, 83.0, 83.0, 84.0, 83.0, 82.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [108.0, 140.0, 135.0, 107.0, 127.0, 135.0, 128.0, 129.0, 118.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 141.0, 140.0, 141.0, 129.0, 141.0, 141.0, 143.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 65.0, 63.0, 67.0, 65.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1477.6999999999998}]} 09:35:28 INFO - Return code: 0 09:35:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:35:28 ERROR - # TBPL SUCCESS # 09:35:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:35:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:35:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:35:28 INFO - 2016-04-05 09:35:28.766 screenresolution[1915:10728] starting screenresolution argv=screenresolution get 09:35:28 INFO - 2016-04-05 09:35:28.769 screenresolution[1915:10728] Display 0: 1600x1200x32@60 09:35:28 INFO - 2016-04-05 09:35:28.774 screenresolution[1916:10731] starting screenresolution argv=screenresolution list 09:35:28 INFO - Available Modes on Display 0 09:35:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:35:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:35:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:35:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:35:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:35:29 INFO - Intel Iris: 09:35:29 INFO - Chipset Model: Intel Iris 09:35:29 INFO - Type: GPU 09:35:29 INFO - Bus: Built-In 09:35:29 INFO - VRAM (Dynamic, Max): 1536 MB 09:35:29 INFO - Vendor: Intel (0x8086) 09:35:29 INFO - Device ID: 0x0a2e 09:35:29 INFO - Revision ID: 0x0009 09:35:29 INFO - Displays: 09:35:29 INFO - Display: 09:35:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:35:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:35:29 INFO - Display Serial Number: 1600x1200 60 09:35:29 INFO - Main Display: Yes 09:35:29 INFO - Mirror: Off 09:35:29 INFO - Online: Yes 09:35:29 INFO - Rotation: Supported 09:35:29 INFO - Return code: 0 09:35:29 INFO - Running post-action listener: _resource_record_post_action 09:35:29 INFO - Running post-run listener: _resource_record_post_run 09:35:30 INFO - Total resource usage - Wall time: 1206s; CPU: 52.0%; Read bytes: 32284160; Write bytes: 703828480; Read time: 320; Write time: 1851 09:35:30 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390554112; Write bytes: 385463808; Read time: 29660; Write time: 685 09:35:30 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 30526976; Write bytes: 298814464; Read time: 302; Write time: 1124 09:35:30 INFO - Running post-run listener: _upload_blobber_files 09:35:30 INFO - Blob upload gear active. 09:35:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:35:30 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 09:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:35:30 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:32 INFO - (blobuploader) - INFO - Done attempting. 09:35:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:35:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:35:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:34 INFO - (blobuploader) - INFO - Done attempting. 09:35:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:35:34 INFO - Return code: 0 09:35:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:35:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:35:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e1021e80cb0794ca4ff781f0457bc3bac956f1a9dcde291428e35af6898cf0719027050116f67d12c80ad77c6f47c6168a969e8826a992b8a03635905efe1d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00b644a94612de4b7c99ffd190d3ab51055386c2b544f5b7496c8d6fbda6879ce21f70543b1c2f416386ad9cc58729c7fd9d0f3fd91d68304ae103da818f9b1f"} 09:35:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:35:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:35:34 INFO - Contents: 09:35:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e1021e80cb0794ca4ff781f0457bc3bac956f1a9dcde291428e35af6898cf0719027050116f67d12c80ad77c6f47c6168a969e8826a992b8a03635905efe1d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00b644a94612de4b7c99ffd190d3ab51055386c2b544f5b7496c8d6fbda6879ce21f70543b1c2f416386ad9cc58729c7fd9d0f3fd91d68304ae103da818f9b1f"} 09:35:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:35:34 INFO - Copying logs to upload dir... 09:35:34 INFO - mkdir: /builds/slave/test/build/upload/logs 09:35:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.499232 ========= master_lag: 11.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-05 09:35:45.267690) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-04-05 09:35:45.272053) ========= 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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e1021e80cb0794ca4ff781f0457bc3bac956f1a9dcde291428e35af6898cf0719027050116f67d12c80ad77c6f47c6168a969e8826a992b8a03635905efe1d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00b644a94612de4b7c99ffd190d3ab51055386c2b544f5b7496c8d6fbda6879ce21f70543b1c2f416386ad9cc58729c7fd9d0f3fd91d68304ae103da818f9b1f"} build_url:https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011037 build_url: 'https://queue.taskcluster.net/v1/task/HKd1ZJB9TL-lyjw02YTaJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e1021e80cb0794ca4ff781f0457bc3bac956f1a9dcde291428e35af6898cf0719027050116f67d12c80ad77c6f47c6168a969e8826a992b8a03635905efe1d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00b644a94612de4b7c99ffd190d3ab51055386c2b544f5b7496c8d6fbda6879ce21f70543b1c2f416386ad9cc58729c7fd9d0f3fd91d68304ae103da818f9b1f"}' ========= master_lag: 8.90 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-04-05 09:35:54.179549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 09:35:54.179905) ========= 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.Ybm4Y2Bddw/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.kDk9H5KOVP/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.005327 ========= master_lag: 1.58 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 09:35:55.763238) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 09:35:55.763566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 09:35:55.772773) ========= ========= Total master_lag: 55.76 =========