builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0113 starttime: 1457980917.5 results: success (0) buildid: 20160314103428 builduid: 51713045d2d34761809001124717e515 revision: 98dbd52b1b67eb85f4605b027ead33a3a847ce9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.503398) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.503836) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.504150) ========= 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.yOTUKnCBY4/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.snRGlPGo46/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.005484 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.528827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.529133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.547442) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.547755) ========= 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.yOTUKnCBY4/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.snRGlPGo46/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.005477 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.596045) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.596384) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.596734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.597047) ========= 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.yOTUKnCBY4/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.snRGlPGo46/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-03-14 11:41:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.5M=0.001s 2016-03-14 11:41:57 (17.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160309 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.774064) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.774434) ========= 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.yOTUKnCBY4/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.snRGlPGo46/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.025222 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.822730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.823089) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98dbd52b1b67eb85f4605b027ead33a3a847ce9a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98dbd52b1b67eb85f4605b027ead33a3a847ce9a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yOTUKnCBY4/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.snRGlPGo46/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-03-14 11:41:57,897 truncating revision to first 12 chars 2016-03-14 11:41:57,897 Setting DEBUG logging. 2016-03-14 11:41:57,897 attempt 1/10 2016-03-14 11:41:57,897 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/98dbd52b1b67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 11:41:58,313 unpacking tar archive at: mozilla-aurora-98dbd52b1b67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656990 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:58.496860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:58.497366) ========= echo 98dbd52b1b67eb85f4605b027ead33a3a847ce9a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'98dbd52b1b67eb85f4605b027ead33a3a847ce9a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yOTUKnCBY4/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.snRGlPGo46/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 98dbd52b1b67eb85f4605b027ead33a3a847ce9a program finished with exit code 0 elapsedTime=0.005644 script_repo_revision: '98dbd52b1b67eb85f4605b027ead33a3a847ce9a' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:58.546736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:58.547121) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:58.560986) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-03-14 11:41:58.561291) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yOTUKnCBY4/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.snRGlPGo46/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 11:41:58 INFO - MultiFileLogger online at 20160314 11:41:58 in /builds/slave/test 11:41:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:41:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:41:58 INFO - {'append_to_log': False, 11:41:58 INFO - 'base_work_dir': '/builds/slave/test', 11:41:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:41:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:41:58 INFO - 'branch': 'Mozilla-Aurora', 11:41:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:41:58 INFO - 'config_files': ('talos/mac_config.py',), 11:41:58 INFO - 'default_actions': ('clobber', 11:41:58 INFO - 'read-buildbot-config', 11:41:58 INFO - 'download-and-extract', 11:41:58 INFO - 'populate-webroot', 11:41:58 INFO - 'create-virtualenv', 11:41:58 INFO - 'install', 11:41:58 INFO - 'run-tests'), 11:41:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:41:58 INFO - 'download_minidump_stackwalk': True, 11:41:58 INFO - 'download_symbols': 'ondemand', 11:41:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:41:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:41:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:41:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:41:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:41:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:41:58 INFO - 'installer_path': 'installer.exe', 11:41:58 INFO - 'log_level': 'info', 11:41:58 INFO - 'log_name': 'talos', 11:41:58 INFO - 'log_to_console': True, 11:41:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:41:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:41:58 INFO - 'opt_config_files': (), 11:41:58 INFO - 'pip_index': False, 11:41:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:58 INFO - 'cmd': ('bash', 11:41:58 INFO - '-c', 11:41:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:58 INFO - 'enabled': True, 11:41:58 INFO - 'halt_on_failure': False, 11:41:58 INFO - 'name': 'check_screen_resolution'},), 11:41:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:58 INFO - 'cmd': ('bash', 11:41:58 INFO - '-c', 11:41:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:58 INFO - 'enabled': True, 11:41:58 INFO - 'halt_on_failure': False, 11:41:58 INFO - 'name': 'check_screen_resolution'},), 11:41:58 INFO - 'run_cmd_checks_enabled': True, 11:41:58 INFO - 'sps_profile': False, 11:41:58 INFO - 'sps_profile_interval': 0, 11:41:58 INFO - 'suite': 'dromaeojs', 11:41:58 INFO - 'system_bits': '32', 11:41:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:41:58 INFO - 'title': 't-yosemite-r7-0113', 11:41:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:41:58 INFO - 'use_talos_json': True, 11:41:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:41:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:41:58 INFO - 'work_dir': 'build'} 11:41:58 INFO - ##### 11:41:58 INFO - ##### Running clobber step. 11:41:58 INFO - ##### 11:41:58 INFO - Running pre-action listener: _resource_record_pre_action 11:41:58 INFO - Running main action method: clobber 11:41:58 INFO - rmtree: /builds/slave/test/build 11:41:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:42:00 INFO - Running post-action listener: _resource_record_post_action 11:42:00 INFO - ##### 11:42:00 INFO - ##### Running read-buildbot-config step. 11:42:00 INFO - ##### 11:42:00 INFO - Running pre-action listener: _resource_record_pre_action 11:42:00 INFO - Running main action method: read_buildbot_config 11:42:00 INFO - Using buildbot properties: 11:42:00 INFO - { 11:42:00 INFO - "project": "", 11:42:00 INFO - "product": "firefox", 11:42:00 INFO - "script_repo_revision": "production", 11:42:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:42:00 INFO - "repository": "", 11:42:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:42:00 INFO - "buildid": "20160314103428", 11:42:00 INFO - "pgo_build": "False", 11:42:00 INFO - "basedir": "/builds/slave/test", 11:42:00 INFO - "buildnumber": 126, 11:42:00 INFO - "slavename": "t-yosemite-r7-0113", 11:42:00 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:42:00 INFO - "platform": "yosemite_r7", 11:42:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:42:00 INFO - "branch": "mozilla-aurora", 11:42:00 INFO - "repo_path": "releases/mozilla-aurora", 11:42:00 INFO - "revision": "98dbd52b1b67eb85f4605b027ead33a3a847ce9a", 11:42:00 INFO - "stage_platform": "macosx64", 11:42:00 INFO - "builduid": "51713045d2d34761809001124717e515", 11:42:00 INFO - "slavebuilddir": "test" 11:42:00 INFO - } 11:42:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 11:42:00 INFO - Running post-action listener: _resource_record_post_action 11:42:00 INFO - ##### 11:42:00 INFO - ##### Running download-and-extract step. 11:42:00 INFO - ##### 11:42:00 INFO - Running pre-action listener: _resource_record_pre_action 11:42:00 INFO - Running main action method: download_and_extract 11:42:00 INFO - mkdir: /builds/slave/test/build/tests 11:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:00 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:42:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 11:42:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 11:42:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 11:42:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 11:42:02 INFO - Downloaded 1277 bytes. 11:42:02 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 11:42:02 INFO - Using the following test package requirements: 11:42:02 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:42:02 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:02 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 11:42:02 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:02 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 11:42:02 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:02 INFO - u'jsshell-mac.zip'], 11:42:02 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:02 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 11:42:02 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:42:02 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:02 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 11:42:02 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:02 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 11:42:02 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:02 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 11:42:02 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:42:02 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:02 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 11:42:02 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:02 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:42:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:42:04 INFO - Downloaded 17864916 bytes. 11:42:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:42:07 INFO - Return code: 0 11:42:07 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:07 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:42:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:42:08 INFO - Downloaded 17864916 bytes. 11:42:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:42:11 INFO - Return code: 0 11:42:11 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')]} 11:42:11 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:42:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:42:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:42:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:42:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:42:12 INFO - Downloaded 10845161 bytes. 11:42:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:42:13 INFO - Return code: 0 11:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:13 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 11:42:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:42:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:42:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 11:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 11:42:18 INFO - Downloaded 115007077 bytes. 11:42:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:42:18 INFO - mkdir: /builds/slave/test/properties 11:42:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:42:18 INFO - Writing to file /builds/slave/test/properties/build_url 11:42:18 INFO - Contents: 11:42:18 INFO - build_url:https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:42:19 INFO - Running post-action listener: _resource_record_post_action 11:42:19 INFO - Running post-action listener: set_extra_try_arguments 11:42:19 INFO - ##### 11:42:19 INFO - ##### Running populate-webroot step. 11:42:19 INFO - ##### 11:42:19 INFO - Running pre-action listener: _resource_record_pre_action 11:42:19 INFO - Running main action method: populate_webroot 11:42:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:42:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:42:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:42:19 INFO - '--tppagecycles', 11:42:19 INFO - '7'], 11:42:19 INFO - 'tests': ['tsvgm']}}, 11:42:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:42:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:42:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:42:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:42:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'tests': ['damp', 'tps']}, 11:42:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['damp', 'tps']}, 11:42:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:42:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:19 INFO - 'other': {'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other_l64': {'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other_nol64': {'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'svgr': {'tests': ['tsvgx', 11:42:19 INFO - 'tsvgr_opacity', 11:42:19 INFO - 'tart', 11:42:19 INFO - 'tscrollx', 11:42:19 INFO - 'cart']}, 11:42:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['tsvgx', 11:42:19 INFO - 'tsvgr_opacity', 11:42:19 INFO - 'tart', 11:42:19 INFO - 'tscrollx', 11:42:19 INFO - 'cart']}, 11:42:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'tests': ['tp5o']}, 11:42:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['tp5o']}, 11:42:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--xperf_path', 11:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:19 INFO - 'tests': ['tp5n']}, 11:42:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--e10s', 11:42:19 INFO - '--xperf_path', 11:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:19 INFO - 'tests': ['tp5n']}}, 11:42:19 INFO - 'talos.zip': {'path': '', 11:42:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:42:19 INFO - Running post-action listener: _resource_record_post_action 11:42:19 INFO - ##### 11:42:19 INFO - ##### Running create-virtualenv step. 11:42:19 INFO - ##### 11:42:19 INFO - Running pre-action listener: _resource_record_pre_action 11:42:19 INFO - Running main action method: create_virtualenv 11:42:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:42:19 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 11:42:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:42:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:19 INFO - Using real prefix '/tools/python27' 11:42:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:42:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:22 INFO - Installing pip.................done. 11:42:22 INFO - Return code: 0 11:42:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:22 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 0x100e19a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e0d95780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, '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.yOTUKnCBY4/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.snRGlPGo46/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 11:42:22 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 11:42:22 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 11:42:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:42:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:22 INFO - 'HOME': '/Users/cltbld', 11:42:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:22 INFO - 'LOGNAME': 'cltbld', 11:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:22 INFO - 'MOZ_NO_REMOTE': '1', 11:42:22 INFO - 'NO_EM_RESTART': '1', 11:42:22 INFO - 'PAGER': '/bin/cat', 11:42:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:22 INFO - 'PWD': '/builds/slave/test', 11:42:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:22 INFO - 'SHELL': '/bin/bash', 11:42:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:42:22 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:42:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:22 INFO - 'USER': 'cltbld', 11:42:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:22 INFO - 'XPC_FLAGS': '0x0', 11:42:22 INFO - 'XPC_SERVICE_NAME': '0', 11:42:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:23 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 11:42:23 INFO - Cleaning up... 11:42:23 INFO - Return code: 0 11:42:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:23 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 0x100e19a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e0d95780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, '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.yOTUKnCBY4/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.snRGlPGo46/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 11:42:23 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 11:42:23 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 11:42:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:42:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:23 INFO - 'HOME': '/Users/cltbld', 11:42:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:23 INFO - 'LOGNAME': 'cltbld', 11:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:23 INFO - 'MOZ_NO_REMOTE': '1', 11:42:23 INFO - 'NO_EM_RESTART': '1', 11:42:23 INFO - 'PAGER': '/bin/cat', 11:42:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:23 INFO - 'PWD': '/builds/slave/test', 11:42:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:23 INFO - 'SHELL': '/bin/bash', 11:42:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:42:23 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:42:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:23 INFO - 'USER': 'cltbld', 11:42:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:23 INFO - 'XPC_FLAGS': '0x0', 11:42:23 INFO - 'XPC_SERVICE_NAME': '0', 11:42:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:23 INFO - Downloading/unpacking psutil>=0.7.1 11:42:23 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 11:42:23 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 11:42:23 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 11:42:23 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 11:42:23 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 11:42:23 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 11:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:26 INFO - Installing collected packages: psutil 11:42:26 INFO - Running setup.py install for psutil 11:42:26 INFO - building 'psutil._psutil_osx' extension 11:42:26 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 11:42:27 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 11:42:27 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 11:42:27 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 11:42:27 INFO - building 'psutil._psutil_posix' extension 11:42:27 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 11:42:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:42:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:42:27 INFO - ^ 11:42:27 INFO - 1 warning generated. 11:42:27 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 11:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:27 INFO - Successfully installed psutil 11:42:27 INFO - Cleaning up... 11:42:27 INFO - Return code: 0 11:42:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42: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')]} 11:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100e19a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e0d95780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, '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.yOTUKnCBY4/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.snRGlPGo46/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 11:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:42:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:42:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:27 INFO - 'HOME': '/Users/cltbld', 11:42:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:27 INFO - 'LOGNAME': 'cltbld', 11:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:27 INFO - 'MOZ_NO_REMOTE': '1', 11:42:27 INFO - 'NO_EM_RESTART': '1', 11:42:27 INFO - 'PAGER': '/bin/cat', 11:42:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:27 INFO - 'PWD': '/builds/slave/test', 11:42:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:27 INFO - 'SHELL': '/bin/bash', 11:42:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:42:27 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:42:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:27 INFO - 'USER': 'cltbld', 11:42:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:27 INFO - 'XPC_FLAGS': '0x0', 11:42:27 INFO - 'XPC_SERVICE_NAME': '0', 11:42:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:42:27 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 11:42:27 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 11:42:27 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 11:42:27 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 11:42:27 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 11:42:27 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 11:42:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:42:30 INFO - Installing collected packages: mozsystemmonitor 11:42:30 INFO - Running setup.py install for mozsystemmonitor 11:42:30 INFO - Successfully installed mozsystemmonitor 11:42:30 INFO - Cleaning up... 11:42:30 INFO - Return code: 0 11:42:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42: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')]} 11:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:30 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 0x100e19a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e0d95780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, '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.yOTUKnCBY4/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.snRGlPGo46/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 11:42:30 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 11:42:30 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 11:42:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:42:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:30 INFO - 'HOME': '/Users/cltbld', 11:42:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:30 INFO - 'LOGNAME': 'cltbld', 11:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:30 INFO - 'MOZ_NO_REMOTE': '1', 11:42:30 INFO - 'NO_EM_RESTART': '1', 11:42:30 INFO - 'PAGER': '/bin/cat', 11:42:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:30 INFO - 'PWD': '/builds/slave/test', 11:42:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:30 INFO - 'SHELL': '/bin/bash', 11:42:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:42:30 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:42:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:30 INFO - 'USER': 'cltbld', 11:42:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:30 INFO - 'XPC_FLAGS': '0x0', 11:42:30 INFO - 'XPC_SERVICE_NAME': '0', 11:42:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:32 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:34 INFO - Downloading docopt-0.6.1.tar.gz 11:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:34 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:34 INFO - Running setup.py install for blobuploader 11:42:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:34 INFO - Running setup.py install for requests 11:42:34 INFO - Running setup.py install for docopt 11:42:35 INFO - Successfully installed blobuploader requests docopt 11:42:35 INFO - Cleaning up... 11:42:35 INFO - Return code: 0 11:42:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42: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')]} 11:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:35 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 0x100e19a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e0d95780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, '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.yOTUKnCBY4/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.snRGlPGo46/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 11:42:35 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 11:42:35 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 11:42:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:42:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:35 INFO - 'HOME': '/Users/cltbld', 11:42:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:35 INFO - 'LOGNAME': 'cltbld', 11:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:35 INFO - 'MOZ_NO_REMOTE': '1', 11:42:35 INFO - 'NO_EM_RESTART': '1', 11:42:35 INFO - 'PAGER': '/bin/cat', 11:42:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:35 INFO - 'PWD': '/builds/slave/test', 11:42:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:35 INFO - 'SHELL': '/bin/bash', 11:42:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:42:35 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:42:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:35 INFO - 'USER': 'cltbld', 11:42:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:35 INFO - 'XPC_FLAGS': '0x0', 11:42:35 INFO - 'XPC_SERVICE_NAME': '0', 11:42:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:35 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-ShwBRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:35 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-nM5PYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:35 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-cYYf00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:35 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Fxx2bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:35 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-EU3V3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:35 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-yTUldE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-NE45fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-4uKmHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-YRAD_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-frrcCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-ppjdpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-LlZ5u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-UtXhU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-W7yClv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-9RSc_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:36 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-fOivD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:37 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-mkqqOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:37 INFO - Running setup.py install for manifestparser 11:42:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozcrash 11:42:37 INFO - Running setup.py install for mozdebug 11:42:37 INFO - Running setup.py install for mozdevice 11:42:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozfile 11:42:37 INFO - Running setup.py install for mozhttpd 11:42:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozinfo 11:42:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozInstall 11:42:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozleak 11:42:38 INFO - Running setup.py install for mozlog 11:42:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for moznetwork 11:42:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozprocess 11:42:38 INFO - Running setup.py install for mozprofile 11:42:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Running setup.py install for mozrunner 11:42:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Running setup.py install for mozscreenshot 11:42:39 INFO - Running setup.py install for moztest 11:42:39 INFO - Running setup.py install for mozversion 11:42:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:39 INFO - Cleaning up... 11:42:39 INFO - Return code: 0 11:42:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42: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')]} 11:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:39 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 0x100e19a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e0d95780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, '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.yOTUKnCBY4/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.snRGlPGo46/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 11:42:39 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 11:42:39 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 11:42:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:42:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:39 INFO - 'HOME': '/Users/cltbld', 11:42:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:39 INFO - 'LOGNAME': 'cltbld', 11:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:39 INFO - 'MOZ_NO_REMOTE': '1', 11:42:39 INFO - 'NO_EM_RESTART': '1', 11:42:39 INFO - 'PAGER': '/bin/cat', 11:42:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:39 INFO - 'PWD': '/builds/slave/test', 11:42:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:39 INFO - 'SHELL': '/bin/bash', 11:42:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:42:39 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:42:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:39 INFO - 'USER': 'cltbld', 11:42:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:39 INFO - 'XPC_FLAGS': '0x0', 11:42:39 INFO - 'XPC_SERVICE_NAME': '0', 11:42:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:39 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-m80zDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:40 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-0ILbY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:40 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-N2gOYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:40 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-zsK5xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:40 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-cbgMC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:40 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-xco4Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:40 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-HpQfBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:40 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-t59oN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:40 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-uIh_9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:40 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-jNQ1lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:41 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)) 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:41 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-_nPb2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:41 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)) 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:41 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-qeULLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:41 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)) 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:41 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-QOWNmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:41 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)) 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:41 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-nrJYqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:41 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)) 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:41 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-ldciku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:41 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)) 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:41 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-hmsKat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:41 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)) 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:41 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-DWql8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:41 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)) 11:42:41 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)) 11:42:41 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)) 11:42:41 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)) 11:42:41 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)) 11:42:41 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)) 11:42:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:41 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 11:42:41 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 11:42:41 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 11:42:41 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 11:42:41 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 11:42:41 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 11:42:44 INFO - Downloading blessings-1.6.tar.gz 11:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:42:44 INFO - Installing collected packages: blessings 11:42:44 INFO - Running setup.py install for blessings 11:42:44 INFO - Successfully installed blessings 11:42:44 INFO - Cleaning up... 11:42:44 INFO - Return code: 0 11:42:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:44 INFO - Reading from file tmpfile_stdout 11:42:44 INFO - Current package versions: 11:42:44 INFO - blessings == 1.6 11:42:44 INFO - blobuploader == 1.2.4 11:42:44 INFO - docopt == 0.6.1 11:42:44 INFO - manifestparser == 1.1 11:42:44 INFO - mozInstall == 1.12 11:42:44 INFO - mozcrash == 0.17 11:42:44 INFO - mozdebug == 0.1 11:42:44 INFO - mozdevice == 0.48 11:42:44 INFO - mozfile == 1.2 11:42:44 INFO - mozhttpd == 0.7 11:42:44 INFO - mozinfo == 0.9 11:42:44 INFO - mozleak == 0.1 11:42:44 INFO - mozlog == 3.1 11:42:44 INFO - moznetwork == 0.27 11:42:44 INFO - mozprocess == 0.22 11:42:44 INFO - mozprofile == 0.28 11:42:44 INFO - mozrunner == 6.11 11:42:44 INFO - mozscreenshot == 0.1 11:42:44 INFO - mozsystemmonitor == 0.0 11:42:44 INFO - moztest == 0.7 11:42:44 INFO - mozversion == 1.4 11:42:44 INFO - psutil == 3.1.1 11:42:44 INFO - requests == 1.2.3 11:42:44 INFO - wsgiref == 0.1.2 11:42:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:44 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 0x100e19a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e0d95780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, '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.yOTUKnCBY4/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.snRGlPGo46/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 11:42:44 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 11:42:44 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 11:42:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:42:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:44 INFO - 'HOME': '/Users/cltbld', 11:42:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:44 INFO - 'LOGNAME': 'cltbld', 11:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:44 INFO - 'MOZ_NO_REMOTE': '1', 11:42:44 INFO - 'NO_EM_RESTART': '1', 11:42:44 INFO - 'PAGER': '/bin/cat', 11:42:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:44 INFO - 'PWD': '/builds/slave/test', 11:42:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:44 INFO - 'SHELL': '/bin/bash', 11:42:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:42:44 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:42:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:44 INFO - 'USER': 'cltbld', 11:42:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:44 INFO - 'XPC_FLAGS': '0x0', 11:42:44 INFO - 'XPC_SERVICE_NAME': '0', 11:42:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:45 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)) 11:42:45 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)) 11:42:45 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)) 11:42:45 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)) 11:42:45 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)) 11:42:45 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)) 11:42:45 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)) 11:42:45 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)) 11:42:45 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)) 11:42:45 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)) 11:42:45 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)) 11:42:45 INFO - Cleaning up... 11:42:45 INFO - Return code: 0 11:42:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:42:45 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')]} 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:45 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')]} 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:45 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 0x100e19a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e0d95780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, '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.yOTUKnCBY4/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.snRGlPGo46/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 11:42:45 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 11:42:45 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 11:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:45 INFO - 'HOME': '/Users/cltbld', 11:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:45 INFO - 'LOGNAME': 'cltbld', 11:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:45 INFO - 'MOZ_NO_REMOTE': '1', 11:42:45 INFO - 'NO_EM_RESTART': '1', 11:42:45 INFO - 'PAGER': '/bin/cat', 11:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:45 INFO - 'PWD': '/builds/slave/test', 11:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:45 INFO - 'SHELL': '/bin/bash', 11:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:42:45 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:45 INFO - 'USER': 'cltbld', 11:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:45 INFO - 'XPC_FLAGS': '0x0', 11:42:45 INFO - 'XPC_SERVICE_NAME': '0', 11:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:45 INFO - Downloading/unpacking jsonschema 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:42:47 INFO - Downloading/unpacking functools32 (from jsonschema) 11:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:47 INFO - Downloading functools32-3.2.3-2.tar.gz 11:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:42:48 INFO - warning: no files found matching '*.txt' 11:42:48 INFO - no previously-included directories found matching 'build' 11:42:48 INFO - no previously-included directories found matching 'dist' 11:42:48 INFO - no previously-included directories found matching '.git*' 11:42:48 INFO - Installing collected packages: jsonschema, functools32 11:42:48 INFO - Running setup.py install for functools32 11:42:48 INFO - warning: no files found matching '*.txt' 11:42:48 INFO - no previously-included directories found matching 'build' 11:42:48 INFO - no previously-included directories found matching 'dist' 11:42:48 INFO - no previously-included directories found matching '.git*' 11:42:48 INFO - Successfully installed jsonschema functools32 11:42:48 INFO - Cleaning up... 11:42:48 INFO - Return code: 0 11:42:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:42:48 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')]} 11:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:48 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')]} 11:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:48 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 0x100e19a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e0d95780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, '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.yOTUKnCBY4/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.snRGlPGo46/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 11:42:48 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 11:42:48 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 11:42:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:42:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:48 INFO - 'HOME': '/Users/cltbld', 11:42:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:48 INFO - 'LOGNAME': 'cltbld', 11:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:48 INFO - 'MOZ_NO_REMOTE': '1', 11:42:48 INFO - 'NO_EM_RESTART': '1', 11:42:48 INFO - 'PAGER': '/bin/cat', 11:42:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:48 INFO - 'PWD': '/builds/slave/test', 11:42:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:48 INFO - 'SHELL': '/bin/bash', 11:42:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:42:48 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:42:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:48 INFO - 'USER': 'cltbld', 11:42:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:48 INFO - 'XPC_FLAGS': '0x0', 11:42:48 INFO - 'XPC_SERVICE_NAME': '0', 11:42:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:48 INFO - Downloading/unpacking flake8 11:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:42:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:42:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:42:51 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 11:42:51 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 11:42:51 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 11:42:51 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 11:42:51 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 11:42:51 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 11:42:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:42:51 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 11:42:51 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 11:42:51 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 11:42:51 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 11:42:51 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 11:42:51 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 11:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:42:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:52 INFO - no previously-included directories found matching 'docs/_build' 11:42:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:42:52 INFO - Running setup.py install for pep8 11:42:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:52 INFO - no previously-included directories found matching 'docs/_build' 11:42:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:42:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:42:52 INFO - Cleaning up... 11:42:52 INFO - Return code: 0 11:42:52 INFO - Running post-action listener: _resource_record_post_action 11:42:52 INFO - Running post-action listener: _start_resource_monitoring 11:42:52 INFO - Starting resource monitoring. 11:42:52 INFO - ##### 11:42:52 INFO - ##### Running install step. 11:42:52 INFO - ##### 11:42:52 INFO - Running pre-action listener: _resource_record_pre_action 11:42:52 INFO - Running main action method: install 11:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:52 INFO - Reading from file tmpfile_stdout 11:42:52 INFO - Detecting whether we're running mozinstall >=1.0... 11:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:42:52 INFO - Reading from file tmpfile_stdout 11:42:52 INFO - Output received: 11:42:52 INFO - Usage: mozinstall [options] installer 11:42:52 INFO - Options: 11:42:52 INFO - -h, --help show this help message and exit 11:42:52 INFO - -d DEST, --destination=DEST 11:42:52 INFO - Directory to install application into. [default: 11:42:52 INFO - "/builds/slave/test"] 11:42:52 INFO - --app=APP Application being installed. [default: firefox] 11:42:52 INFO - mkdir: /builds/slave/test/build/application 11:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:43:24 INFO - Reading from file tmpfile_stdout 11:43:24 INFO - Output received: 11:43:24 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:43:24 INFO - Running post-action listener: _resource_record_post_action 11:43:24 INFO - ##### 11:43:24 INFO - ##### Running run-tests step. 11:43:24 INFO - ##### 11:43:24 INFO - Running pre-action listener: _resource_record_pre_action 11:43:24 INFO - Running main action method: run_tests 11:43:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:43:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:43:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:43:25 INFO - 2016-03-14 11:43:25.004 screenresolution[1646:7503] starting screenresolution argv=screenresolution get 11:43:25 INFO - 2016-03-14 11:43:25.006 screenresolution[1646:7503] Display 0: 1600x1200x32@60 11:43:25 INFO - 2016-03-14 11:43:25.012 screenresolution[1647:7505] starting screenresolution argv=screenresolution list 11:43:25 INFO - Available Modes on Display 0 11:43:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:43:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:43:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:43:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:43:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:43:25 INFO - Intel Iris: 11:43:25 INFO - Chipset Model: Intel Iris 11:43:25 INFO - Type: GPU 11:43:25 INFO - Bus: Built-In 11:43:25 INFO - VRAM (Dynamic, Max): 1536 MB 11:43:25 INFO - Vendor: Intel (0x8086) 11:43:25 INFO - Device ID: 0x0a2e 11:43:25 INFO - Revision ID: 0x0009 11:43:25 INFO - Displays: 11:43:25 INFO - Display: 11:43:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:43:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:43:25 INFO - Display Serial Number: 1600x1200 60 11:43:25 INFO - Main Display: Yes 11:43:25 INFO - Mirror: Off 11:43:25 INFO - Online: Yes 11:43:25 INFO - Rotation: Supported 11:43:25 INFO - Return code: 0 11:43:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:43:25 INFO - Python 2.7.3 11:43:25 INFO - Return code: 0 11:43:25 INFO - grabbing minidump binary from tooltool 11:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:25 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 0x100cbdd30>, '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 0x100b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cb4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:43:25 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 11:43:25 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 11:43:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:43:25 INFO - Return code: 0 11:43:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:43:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:43:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:43:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:43:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:43:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:43:26 INFO - Return code: 0 11:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.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 11:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.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 11:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yOTUKnCBY4/Render', 11:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:26 INFO - 'HOME': '/Users/cltbld', 11:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:26 INFO - 'LOGNAME': 'cltbld', 11:43:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:26 INFO - 'MOZ_NO_REMOTE': '1', 11:43:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:26 INFO - 'NO_EM_RESTART': '1', 11:43:26 INFO - 'PAGER': '/bin/cat', 11:43:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:26 INFO - 'PWD': '/builds/slave/test', 11:43:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:26 INFO - 'SHELL': '/bin/bash', 11:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snRGlPGo46/Listeners', 11:43:26 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 11:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:26 INFO - 'USER': 'cltbld', 11:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:26 INFO - 'XPC_FLAGS': '0x0', 11:43:26 INFO - 'XPC_SERVICE_NAME': '0', 11:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.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 11:43:26 INFO - mozversion application_buildid: 20160314103428 11:43:26 INFO - mozversion application_changeset: 98dbd52b1b67eb85f4605b027ead33a3a847ce9a 11:43:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:43:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:43:26 INFO - mozversion application_name: Firefox 11:43:26 INFO - mozversion application_remotingname: firefox-dev 11:43:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:43:26 INFO - mozversion application_vendor: Mozilla 11:43:26 INFO - mozversion application_version: 47.0a2 11:43:26 INFO - mozversion platform_buildid: 20160314103428 11:43:26 INFO - mozversion platform_changeset: 98dbd52b1b67eb85f4605b027ead33a3a847ce9a 11:43:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:43:26 INFO - mozversion platform_version: 47.0a2 11:43:26 INFO - using testdate: 1457981006 11:43:26 INFO - actual date: 1457981006 11:43:26 INFO - starting webserver on 'localhost:49273' 11:43:26 INFO - SUITE-START | Running 2 tests 11:43:26 INFO - TEST-START | dromaeo_css 11:43:26 INFO - operating with platform_type : mac_ 11:43:26 INFO - Initialising browser for dromaeo_css test... 11:43:26 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmphvRbku/profile http://localhost:49273/getInfo.html) 11:43:29 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 11:43:29 INFO - PROCESS | 1665 | colorDepth:24 11:43:29 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 11:43:29 INFO - PROCESS | 1665 | __metrics 11:43:29 INFO - PROCESS | 1665 | 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" 11:43:29 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:43:29 INFO - TEST-INFO | 1665: exit 0 11:43:29 INFO - Browser initialized. 11:43:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:43:29 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmphvRbku/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:41 INFO - PROCESS | 1667 | RSS: Main: 210305024 11:43:41 INFO - PROCESS | 1667 | 11:44:33 INFO - PROCESS | 1667 | 1457981073323 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] 11:46:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 11:46:44 INFO - PROCESS | 1667 | RSS: Main: 329699328 11:46:44 INFO - PROCESS | 1667 | 11:49:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 11:49:47 INFO - PROCESS | 1667 | RSS: Main: 344551424 11:49:47 INFO - PROCESS | 1667 | 11:52:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 11:52:50 INFO - PROCESS | 1667 | RSS: Main: 348921856 11:52:50 INFO - PROCESS | 1667 | 11:55:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 11:55:52 INFO - PROCESS | 1667 | RSS: Main: 307015680 11:55:52 INFO - PROCESS | 1667 | 11:58:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 11:58:56 INFO - PROCESS | 1667 | RSS: Main: 309321728 11:58:56 INFO - PROCESS | 1667 | 12:01:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 12:01:59 INFO - PROCESS | 1667 | RSS: Main: 364756992 12:01:59 INFO - PROCESS | 1667 | 12:01:59 INFO - PROCESS | 1667 | __start_tp_report 12:01:59 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 12:01:59 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 12:01:59 INFO - PROCESS | 1667 | |i|pagename|runs| 12:01:59 INFO - PROCESS | 1667 | |0;dojo.html;3493.021953852921;3539.5929468111176;3548.828886467466;3563.7861728296302;3614.1145419372256;5879.7354119064585;5885.11723241514;5891.941080589193;5926.170336152942;5931.911021334683;5870.88258234835;5889.705514724257;5906.940930590693;5915.142304365875;5928.940710592893;5181.300524429192;5239.580833533328;5250.606204534656;5287.365516138068;5302.363716354023;5349.983503134412;5350.625456218067;5366.9463305367035;5368;5370.973145134289;5281.815136470224;5331.253624492574;5346.4118946915805;5354.089804733185;5354.812581559646;5332.253484512172;5363.973180134074;5366.141417373202;5368.677879327252;5375.784968601251;5049.34358533392;5275.366955965271;5295.443978382292;5300.602454815866;5310.522053015247;5712;5739.62692424991;5756.913646295309;5782.768689252425;5786.421357864222;6241.531885108635;6335.04974253861;6341.239051313826;6352.587081839665;6373.203349581302;6266.216722909637;6270.059491076329;6332.968335158294;6334.746610135589;6346.428821406095;6020.879582408371;6030.155778191057;6035.3059398169335;6039.7282122304605;6048.879022419615;5354.196870469461;6253.6873156342;6379.234491861006;6381.1066450696935;6406.743730250831;6319.778807741707;6326.905096423558;6327.335629758901;6336.746530138743;6351.650659213695;6322.051692246107;6326.272478665012;6331.493480521547;6334.398232167937;6343.270523889812;6235.469985051322;6278.623282603058;6279.309275979638;6332.651704156224;6351.587146835441;6251.499880009588;6277.058441233851;6303.716332765037;6310.368963103745;6311.368863113744;4908.656394052454;4911.631627627942;4920.21276595743;4920.655554111249;4944.851654450372;4388.758618275961;4434.33484977256;4473.083017981306;4514.255147900625;4539.477960034572;5850.385709500526;5854.326752423526;5864.765409383577;5871.588988770745;5878.147668588031;6278.529110316745;6305.621662700252;6305.716242768995;6307.24313082433;6315.5894866833505;5727.255456790591;5810.389909059572;5817.970910145506;5855.238818953594;5908.852278693067;5443.8082676339;5474.151506516497;5494;5495.038368285614;5502.284702988666;6369.522285828489;6387.520935929824;6396.648184349905;6397.520185986163;6399.840003999844;6253.6560489173535;6255;6279.466245369012;6319.083732858801;6337.556371053982;6376.171097757262;6385.010323399881;6407.551471396958;6407.8398040047505;6409.615423074444;6241.500679945684;6325.399087086719;6334.4932405406535;6334.556581039283;6352.650604216812;6251;6274.843128921813;6286.591371560834;6304.085907543472;6315.3053164152825;6270.184875966278;6308.306086330408;6310.716017779119;6314.62112273265;6315.179026726496;5641.576881733804;6120.26428866606;6192.504599632109;6258.311585725658;6309.337519560564;5986.371430999682;5989.820305390671;6144.151240645752;6152.538559608137;6179.3202747698615;6283.3088360281245;6294.181756371826;6300.71646775887;6305.085762564494;6316.05259211122;6044.969775151096;6049.274087109575;6134.754609815736;6172.043333283348;6175.228096487939 12:01:59 INFO - PROCESS | 1667 | |1;ext.html;476.73541184642534;551.2062629813066;597.6832278892186;672.0826072411157;678.3758941773568;31890;40163.39754903679;40626.59373406265;40775;40856.79571602138;36797;43815.56184438155;44080.77959610205;44197.8950526237;44396.33405498912;9768.804623907517;10006;10013;10019.148372388356;10020.599176032987;8628.741137765877;9724.270679699015;9934.205263578897;9951.004899510028;9977.50112494376;9869.161121304662;10063.29556931015;10066.144377727866;10073.64742234022;10084.848727269096;9936.105750482455;10003.74990625233;10025.94727553611;10043.296969212159;10055.095041446304;9799.510024498746;9906.05892440217;9916.851247231298;9935.552900119512;10049.145822605087;42929.785351073355;43488;43655.90860228488;43683;43746.34380484295;3146.181992681896;3263.1515805890403;3415.4023045967106;3672.394054980925;3730.403135498307;29671;29716.851415743;29948;30351;30605.846970765226;2792.5950737143203;2811.5923191137376;2850.2874281429645;2873.1380585824377;2880.6687230968496;501894;502071.4896425531;503663.4816825892;504383;504509;70539.64730176317;70931.64534177296;71029.28970710227;71067.64466177636;71174;76549;80639.06579618229;80839.19160808434;80882;80997.59501202457;15812.92093539548;18524.536886577673;18679.97260150705;18702.81297187038;18733.531661708294;13993.580192594238;14093.929530352487;14119.294035298193;14141.71716565663;14166.504172353918;23175;23496.530069398857;23539.764602353756;23545.7645423547;23687.881560592086;7517.473776835678;8482.363822713321;9618.711438656712;9645.202891161485;9666.275029372826;960.4381436859376;974.2498276327188;1049.0715716590719;1076.6393258258415;1158.154547180563;30709.539356909663;30757.538636920464;30840.53739193914;31077.689223107933;31336.843315783277;953.8616900549381;1143.7598104398003;1167.3637867362308;1168.485866218861;1241.6585439004166;15512;16150.434734784227;16294;16358.263878125514;16373.099479528502;562754;569684;572110;574400;580508;60001.699991499765;62178.445538860986;62209.688951554956;62225.37774622286;62305.06542401868;1435.224978511592;1489.5233525271808;1525.3212320517264;1530.5178868656337;1563.788888500038;24738.628920565847;24751.38121546904;28887.855560722903;29395.853020735616;30302.545461817648;47082.76458617685;47253.76373118113;47501.52498474971;47515.28727069028;47540.762296188295;300035;300696;302503;302762;303575;28795.712042879302;34546.136346591535;34612.307753845285;34725;35019.124521887155;42001.78999104985;42240;42387.152256955305;44201.77899110484;44412.77793611011;34744;36032.4595131068;36074.63925360713;36235.818820905726;36834.63165368312;34711.82644086763;35905.64094359023;35947.10132246715;36288.81855590811;36574.817125915266;33489.99530014103;36553.63446365502;36979.81510092432;37919;38054.80972595119;31987;32147.671782786158;32328.35343293168;32688;32927.341453170324;24395.39011524726;24479.977642033577;24562.754372456046;24593;24838.37904052413 12:01:59 INFO - PROCESS | 1667 | |2;jquery.html;359.83627449510476;385.1238432565912;386.21790873481194;390.66988394806395;393.87592908233887;19531.804681953177;21085.578288434222;21357.893210533945;21826.126954921805;21847;12245.63263102106;12629.368531573407;21142.365729028115;21423.464413389673;21450.89274553629;5398.406175320712;5543.251661025771;5599.384067752544;5599.888002239953;5600.0759874620635;4187.790610469479;4366.19225443294;5976.73104710289;6204.069389591552;6215.751369945219;5956.791512297071;6187;6198.8450288742915;6201.224846894138;6203.348648391921;5878.941210587882;6174.444300012976;6175.7220925058255;6182.72177752;6192.628442293454;3226;5659.5755318351285;5888.175655408247;5891.646501209942;5892.852678683024;13893.305334733222;13927.373268202955;13936.58190254294;24544.01823927041;25234;2101.1385332013956;2188.365374041526;2209.436593668604;2255.6954811100454;2266.9206577769864;10053.748656283578;10078.042585954323;10411.167106631452;13456.730865382637;14669.902431776492;1774.9290028398848;1835.1741716227618;1859.6466671332403;1869.813018698133;1890.0455270088655;96214;102890.48554757253;114063.42968285189;115939;117104;9888.752781180385;12039.518419263131;12126.029917606571;12127.818082728767;12230.694232644077;14656.413743450143;14721.337539810735;14752.336144873507;14762.335694893756;14785.630359241106;11545.480453379618;11720.531178752924;11739.706507337214;11797.17419780607;12010.919017288312;8480.727890816426;9656.468894210886;9715.562799674031;9874.061964113398;10239.334443261165;9107.087511622634;9153.588088536031;9203.953980230055;9245.260379169651;9256.95371523138;3198.8080715157166;3737.1404576947452;3747.3837746574686;3754.9436758448646;3789.905252368658;886.8802711633847;917.9036201198911;998.1216529454034;1093.6882988348282;1119.1774046076127;19001.524961876064;20871.478213044797;21321.36035918925;21524;21769.203493859826;1002.8846682631445;1025.5897640943533;1031.7369070886875;1034.462079718542;1036.6164519127972;11087.83368249477;11461.312321260752;11485.885141148648;11498.597549085742;11504.94247528757;668311;692868;709163;709368;710239;101034.49482752687;102941;112163.43918280356;118738;121362;1049.9632512862013;1052.9789404211872;1062.7236918401272;1065.2064212161833;1066.7066556696816;18319.287786811423;18700.438986830417;19068.618627627093;19123.617527649647;19185.136668849656;51016.48983510117;54067.72966135301;54130.91738165294;54252.45747542474;55136;67143.66428167828;73791.63104184445;73823.26176738164;73841.6307918457;73873.89189162059;8201.671933122609;8311.16888311164;8347.332213423033;8440.324774018187;8624.913750862412;12172.695682608006;13504.86495135036;13619;13853.584392468241;13893.513727019506;10580.682579522627;11792.646220613395;11807.881921180679;11875.346855922662;11911.940440297743;10178.694639160836;11211.383373914514;11673;11754.529818807152;11928.105392095455;11858.16992810495;12025.338606376383;12032.578859739868;12150.331731754839;12376;8444.746657600283;8476.36427267945;8629;8694.610419755316;8910.376273660782;10770.138388929023;10862.674119776419;11446;12076.45655945467;12246.326452045223 12:01:59 INFO - PROCESS | 1667 | |3;mootools.html;1513.8940274180811;1638.9262483188256;1661.8836681432301;1992.521794769255;2063.7007633893086;8403.747887563368;8979.775505612362;9152.313576481758;9167.816643667122;9181.724548263546;9002.32482563807;9259.444433334005;9259.861102083458;9261.768455788608;9328.48693321867;2291.1522736587485;2531.6708827852353;2581.66438363013;2591.6889973203147;2615.3330900620317;2238.876861772602;2621.1743300860167;2625.7111717711036;2625.9868700656566;2627.2249686342575;2523.6466894634764;2611.791056715458;2617.947641047178;2619.9083032093786;2620.082970960158;2578.1749840051193;2605;2614.3333449970137;2625.0812215724536;2625.146827281141;2564.8717564121907;2586.314626623946;2591.961120583193;2606.361441446839;2608.765211131007;9288.396254243453;9380.155785979294;9381.5309234538;9403.247740180768;9455.858162127573;4946.975265123651;5641.18202860587;5758.049921762904;5806.187133801272;5813.215215945877;3696.31618150643;3765.755225910307;3824.521934758155;3837.1750073734;3845.6731177849915;1076.9892301077045;1130.6890605083586;1653.3634550697948;1688.7213609754376;1705.3434427745283;12489.937550312281;12555.246685198827;12603.558875439316;12608.621741347773;12613;4800.255960326155;4845.1278769821065;4900.681455705368;4917.852464426073;4953.826616068421;8288.58557072144;9673.516324183762;9696.466694331739;9704;9717.9028209717;5543.584231182596;5576.749046292926;5580.469855363734;5598.524125449382;5608.691521966331;4610.05493873755;4943.406791185081;5051.444341122474;5093.8726531837;5103.157978933435;3851.9807400963377;3919.0790164311366;3921.254961557295;3958.2083583283456;3962.286788378062;1171.1158075652997;1172.9061675065975;1184.6979020349756;1186.4779497021284;1230.2556953043459;1387.0360099730792;1398.2100113435877;1415.568251683226;1421.85070567591;1446.8263808342856;8624.310055195569;8859.689910853089;8863.822723545492;8873.378863479624;8877.689280875138;1254.3790823542404;1264.2225031605496;1267.0560432477862;1268.5686866465446;1300.3108352573151;6398.2641996170105;6430.228372595225;6502.544821862519;6510.707018184193;6519.989401642753;11114.777704445865;11452.828207576893;11629.302241865515;11648.650540483799;11729.530818767324;11366.431678416046;11431.542738290542;11554.480048397842;11574.88425115738;11634.360110193851;8790.824183516293;8826.86759698605;8840.204381605816;8880.822383552422;8910.910890891138;8199;8349.415540912078;8422.915770842214;8423.241908228289;8430.578471076544;10212.13196878244;10246.333988290737;10313.174946004452;10433.739156521147;10499.212559057949;9080.500572468578;10485.318454300446;10699.358038517714;10706.357618542912;10909.34543927367;6438.806835794933;6647.634380109141;6790.72837086511;6993.755218567326;7192.921061840766;8650.697225597074;8664.610092545976;8729.170728780755;8738.563071846509;8748.737537873874;7613.847723045619;7685.269899359552;7751.496152750054;7836.725714600189;7863.567503787347;7516.098068231847;7578.280063393969;7589.241075892367;7707.306342429209;7715.151333353215;8073.555954422563;8147.714829980922;8148.714794982147;8155.79610509742;8160.14318496573;7223.133224013152;7339.486235963432;7349.632518373953;7364.852702946018;7370.189279179393;7478.962605186939;7489.66296516669;7528.021357223526;7530.548167109991;7554.357879580297 12:01:59 INFO - PROCESS | 1667 | |4;prototype.html;336.3290235979221;340.36521886681345;343.2037672599567;347.45102737674466;351.93489204497155;6634.303398143192;6650.06899034135;6727.899081513781;6746.426553742932;6867.965660171692;6613.338666133384;6624.138861947952;6638.535302528825;6645.302243264448;6678.465722742181;4352.412424322723;4608.147492713859;4766.5471780181;4766.7616619169075;4941.925871111918;4882.731449770261;4883.511648835123;4886.755662216893;4887.657863949525;4893.3638626978445;4820.903581928359;4846.878828029292;4909.8036078557;4913.82801601944;4914.778834952418;4262.680298977589;4473.955260447403;4677.976610116944;4917.188663870457;4918.139325618038;4200.663946884242;4207.852725154636;4225.640820530259;4230.682698797603;4233.936490952638;5623.9437605623825;5983.431574000507;6382.61704297739;6384.52116091295;6385.393387628168;5834.27071616048;5846.444587764156;5853.443922827367;5859.1797148399255;5876.177335173036;6844.247132815386;7094.432445404407;7097.112860892388;7110.57336559808;7114.110736157981;4774.4509381420885;4783.015048754763;4791.712497250176;4793.712377257376;4794.49657785931;7372.631368431611;7441.66512506933;7445.9627701861145;7464.589447580381;7475.401967842559;4011.859584914572;4852.56326930578;4863.878403039952;4867.342908707279;4871.415430148334;4913.484084171182;4913.582345500601;4914.238293064581;4926.926096108561;4932.728699921467;4761.9047619048115;5801.303843538718;5840.8247752567495;5857.70711464425;5860.8534786629825;6275.905861412082;6833.897491537631;6879.931200688029;7164.785056448315;7197.748078817321;1638.0417455788497;1664.5588918936492;1666.908320042385;1667.8415550522682;1668.457751230855;1016;1056.4928834159646;1065.733566608348;1069.2996087562658;1092.6012005617893;4621.699589526737;4996.300517927493;5475.835724928259;6378.712957916905;6518.054882042172;7333.74331898381;7336.523125996793;7363.337299643058;7444.813879652944;7468.10382754073;5419.458054194549;6555.2133743951035;6557.672116394161;6573.408393244631;6581.177352830896;3834.884953451401;3875.147467557133;3878.903027424337;3885.630865067814;3913.471681323042;6814.773340798703;7323.0480037595835;7412.85174296511;7650.19672934345;7665.501742386727;7646.273604007611;7672.693092276358;7679.923200768033;7698.769036928901;7702.961485192538;7683.923160768432;7684.4236682250175;7687.385009199251;7692.000039994765;7700.9614951926005;7168.641567921687;7418.740344087931;7448.47860649771;7450.590217537871;7457.993170921856;7305.488615797056;7315.195328513752;7332.266773322625;7343.3390994810725;7350.228226036403;7598.696052157852;7662.463627546242;7666.8083297918;7670.309672129535;7698.307152356315;4697.694649847749;4729.597984171384;4730.148573256847;4730.243161094346;4737.8341758038305;7159;7375.409967202503;7387.4459415545125;7413.66638501258;7422.220666830121;7073.752418665322;7171;7175.174854891546;7180.210176880434;7200.423966082805;7111.6799744010605;7173.964130179315;7178.425725941807;7184.712611495482;7191.820204494929;6974.895376569254;7010.404115650227;7020.262872398529;7024.929750702428;7039.964800175966;6810.182778066664;7117.8576428470105;7157.212706602374;7169.247229041084;7169.928300716926;6706.429953454011;6828.2830302819475;6859.348361905611;6896.93103068983;6968.3728464438445 12:01:59 INFO - PROCESS | 1667 | |5;yui.html;729.2816575672964;737.1301863800713;748.8614606297836;755.9924400755995;787.9054513458384;15357.846421535782;15536;15565.92217038916;15573.065616063044;15577.844221557782;14307.642308942282;14461.060031097972;14464.059836110646;14478.131312121253;14482.058666186691;817.2032268538187;827.7889138269733;942.4251206763869;997.6657819630433;1040.2874031288554;1025.2669341420883;1028.028513055163;1029.1766586730585;1029.3309348923221;1031.3244824639835;1075.3118004477142;1078.250615822004;1082.886296938822;1082.9296095753791;1084.1164450972472;849.6771226933756;1031.8142734307821;1051.7265510967204;1057.5505410200633;1060.8355704865796;792.4136139256966;793.7737744742778;794.5550491724595;795.1730200591378;798.2217338095369;15376.308066136939;15447.382104715798;15467.226638668022;15469.5359139226;15478.148701821396;12371.195872268363;12506.687332816662;13091.86908130916;13408.329583520785;13676.246909665628;10244.28290019699;10260.384376937407;10510.737231569196;10543;10792.51433685486;3498;3499.6675315844955;3565.893023209308;3643.344198044351;3656.981715091434;86053;86662.26675466455;86987;89402;91330.5433472835;9643.662471813454;9873.210143188528;9998.850017249748;10249.538770755185;10624;23408.76591234066;23412.531749364916;23425.180118695764;23444;23455.648165277533;7460.0674915635545;7516.549007059594;7572.507786993828;7691.923080769233;7760.805979850549;3994.400839873984;4049.392591111357;4143.502779666399;4207.663386929038;4216.9789151054665;3752.418375151856;3786.6970642348547;3800.3349413852466;3801.752886062397;3812.1041555234497;680.2211467869262;701.1866235167283;713.6717110129399;727.0911360799001;741.2846603027996;534.5353730777641;547.3814589513823;547.7606691991172;558.5001423725743;576.0725232375871;7099.432045436456;8452.408331416742;8538.188872057144;8559.657613695506;8601.956990215009;590.6042951222691;594.8453402115481;607.3774381259244;623.233422889848;623.9376062393725;3860.864869729546;3916.8629097981434;4067.2678917795083;4230.936535951963;4265.210935976854;73715;97834.53248201283;100583;102378;102389.48805255926;68611.31388686149;81296;81479.59260203662;82851.5857420709;85098;71218.64390678014;76562;76992.61503692446;77303.84044239341;78326.86692532348;8474.449160804528;8612.18184272493;8621.310295176245;8663.566821658766;8841.823163536565;44929;48398.54804355875;49271.507284926694;50759.731006725124;52386.47613523968;65572.34427655854;72336;73663;76159.61920190364;76674.61662691651;8510.191531804468;9673.081057299545;9911.157551608194;10045.196384289386;10260.230482713976;12031.939840300742;12177.086718496326;12273.69315767113;12344.75310493803;12872.22766634005;11480.483378247833;11525.481353338952;11609.245399049034;11903.880961190624;11931.463084161407;11789.410529473664;12318.322492263012;12349.691257718629;12394.504219831106;12404.75190496167;10869.293495923055;11467.197296189186;11494.080473561928;11500.367479788358;11702.648920532398;8328.292095171979;9787.825460944447;9870.358426702242;10299.536520856429;10332.741681458023;8928.15182557656;8956.596953137256;9537.761555961157;9887.73170502202;10032.394816829565 12:01:59 INFO - PROCESS | 1667 | __end_tp_report 12:01:59 INFO - PROCESS | 1667 | __start_cc_report 12:01:59 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1056 12:01:59 INFO - PROCESS | 1667 | __end_cc_report 12:01:59 INFO - PROCESS | 1667 | __startTimestamp1457982119684__endTimestamp 12:01:59 INFO - PROCESS | 1667 | 12:01:59 INFO - PROCESS | 1667 | ------- Summary: start ------- 12:01:59 INFO - PROCESS | 1667 | Number of tests: 6 12:01:59 INFO - PROCESS | 1667 | 12:01:59 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5854.68 Median:6134.75 stddev:638.06 (10.4%) stddev-sans-first:612.53 12:01:59 INFO - PROCESS | 1667 | Values: 3493.0 3539.6 3548.8 3563.8 3614.1 5879.7 5885.1 5891.9 5926.2 5931.9 5870.9 5889.7 5906.9 5915.1 5928.9 5181.3 5239.6 5250.6 5287.4 5302.4 5350.0 5350.6 5366.9 5368.0 5371.0 5281.8 5331.3 5346.4 5354.1 5354.8 5332.3 5364.0 5366.1 5368.7 5375.8 5049.3 5275.4 5295.4 5300.6 5310.5 5712.0 5739.6 5756.9 5782.8 5786.4 6241.5 6335.0 6341.2 6352.6 6373.2 6266.2 6270.1 6333.0 6334.7 6346.4 6020.9 6030.2 6035.3 6039.7 6048.9 5354.2 6253.7 6379.2 6381.1 6406.7 6319.8 6326.9 6327.3 6336.7 6351.7 6322.1 6326.3 6331.5 6334.4 6343.3 6235.5 6278.6 6279.3 6332.7 6351.6 6251.5 6277.1 6303.7 6310.4 6311.4 4908.7 4911.6 4920.2 4920.7 4944.9 4388.8 4434.3 4473.1 4514.3 4539.5 5850.4 5854.3 5864.8 5871.6 5878.1 6278.5 6305.6 6305.7 6307.2 6315.6 5727.3 5810.4 5818.0 5855.2 5908.9 5443.8 5474.2 5494.0 5495.0 5502.3 6369.5 6387.5 6396.6 6397.5 6399.8 6253.7 6255.0 6279.5 6319.1 6337.6 6376.2 6385.0 6407.6 6407.8 6409.6 6241.5 6325.4 6334.5 6334.6 6352.7 6251.0 6274.8 6286.6 6304.1 6315.3 6270.2 6308.3 6310.7 6314.6 6315.2 5641.6 6120.3 6192.5 6258.3 6309.3 5986.4 5989.8 6144.2 6152.5 6179.3 6283.3 6294.2 6300.7 6305.1 6316.1 6045.0 6049.3 6134.8 6172.0 6175.2 12:01:59 INFO - PROCESS | 1667 | 12:01:59 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:62051.08 Median:34881.56 stddev:126051.38 (361.4%) stddev-sans-first:126320.21 12:01:59 INFO - PROCESS | 1667 | Values: 476.7 551.2 597.7 672.1 678.4 31890.0 40163.4 40626.6 40775.0 40856.8 36797.0 43815.6 44080.8 44197.9 44396.3 9768.8 10006.0 10013.0 10019.1 10020.6 8628.7 9724.3 9934.2 9951.0 9977.5 9869.2 10063.3 10066.1 10073.6 10084.8 9936.1 10003.7 10025.9 10043.3 10055.1 9799.5 9906.1 9916.9 9935.6 10049.1 42929.8 43488.0 43655.9 43683.0 43746.3 3146.2 3263.2 3415.4 3672.4 3730.4 29671.0 29716.9 29948.0 30351.0 30605.8 2792.6 2811.6 2850.3 2873.1 2880.7 501894.0 502071.5 503663.5 504383.0 504509.0 70539.6 70931.6 71029.3 71067.6 71174.0 76549.0 80639.1 80839.2 80882.0 80997.6 15812.9 18524.5 18680.0 18702.8 18733.5 13993.6 14093.9 14119.3 14141.7 14166.5 23175.0 23496.5 23539.8 23545.8 23687.9 7517.5 8482.4 9618.7 9645.2 9666.3 960.4 974.2 1049.1 1076.6 1158.2 30709.5 30757.5 30840.5 31077.7 31336.8 953.9 1143.8 1167.4 1168.5 1241.7 15512.0 16150.4 16294.0 16358.3 16373.1 562754.0 569684.0 572110.0 574400.0 580508.0 60001.7 62178.4 62209.7 62225.4 62305.1 1435.2 1489.5 1525.3 1530.5 1563.8 24738.6 24751.4 28887.9 29395.9 30302.5 47082.8 47253.8 47501.5 47515.3 47540.8 300035.0 300696.0 302503.0 302762.0 303575.0 28795.7 34546.1 34612.3 34725.0 35019.1 42001.8 42240.0 42387.2 44201.8 44412.8 34744.0 36032.5 36074.6 36235.8 36834.6 34711.8 35905.6 35947.1 36288.8 36574.8 33490.0 36553.6 36979.8 37919.0 38054.8 31987.0 32147.7 32328.4 32688.0 32927.3 24395.4 24480.0 24562.8 24593.0 24838.4 12:01:59 INFO - PROCESS | 1667 | 12:01:59 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:37178.37 Median:21113.97 stddev:115093.62 (545.1%) stddev-sans-first:115383.28 12:01:59 INFO - PROCESS | 1667 | Values: 359.8 385.1 386.2 390.7 393.9 19531.8 21085.6 21357.9 21826.1 21847.0 12245.6 12629.4 21142.4 21423.5 21450.9 5398.4 5543.3 5599.4 5599.9 5600.1 4187.8 4366.2 5976.7 6204.1 6215.8 5956.8 6187.0 6198.8 6201.2 6203.3 5878.9 6174.4 6175.7 6182.7 6192.6 3226.0 5659.6 5888.2 5891.6 5892.9 13893.3 13927.4 13936.6 24544.0 25234.0 2101.1 2188.4 2209.4 2255.7 2266.9 10053.7 10078.0 10411.2 13456.7 14669.9 1774.9 1835.2 1859.6 1869.8 1890.0 96214.0 102890.5 114063.4 115939.0 117104.0 9888.8 12039.5 12126.0 12127.8 12230.7 14656.4 14721.3 14752.3 14762.3 14785.6 11545.5 11720.5 11739.7 11797.2 12010.9 8480.7 9656.5 9715.6 9874.1 10239.3 9107.1 9153.6 9204.0 9245.3 9257.0 3198.8 3737.1 3747.4 3754.9 3789.9 886.9 917.9 998.1 1093.7 1119.2 19001.5 20871.5 21321.4 21524.0 21769.2 1002.9 1025.6 1031.7 1034.5 1036.6 11087.8 11461.3 11485.9 11498.6 11504.9 668311.0 692868.0 709163.0 709368.0 710239.0 101034.5 102941.0 112163.4 118738.0 121362.0 1050.0 1053.0 1062.7 1065.2 1066.7 18319.3 18700.4 19068.6 19123.6 19185.1 51016.5 54067.7 54130.9 54252.5 55136.0 67143.7 73791.6 73823.3 73841.6 73873.9 8201.7 8311.2 8347.3 8440.3 8624.9 12172.7 13504.9 13619.0 13853.6 13893.5 10580.7 11792.6 11807.9 11875.3 11911.9 10178.7 11211.4 11673.0 11754.5 11928.1 11858.2 12025.3 12032.6 12150.3 12376.0 8444.7 8476.4 8629.0 8694.6 8910.4 10770.1 10862.7 11446.0 12076.5 12246.3 12:01:59 INFO - PROCESS | 1667 | 12:01:59 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6344.46 Median:4950.40 stddev:3348.03 (67.6%) stddev-sans-first:3337.73 12:01:59 INFO - PROCESS | 1667 | Values: 1513.9 1638.9 1661.9 1992.5 2063.7 8403.7 8979.8 9152.3 9167.8 9181.7 9002.3 9259.4 9259.9 9261.8 9328.5 2291.2 2531.7 2581.7 2591.7 2615.3 2238.9 2621.2 2625.7 2626.0 2627.2 2523.6 2611.8 2617.9 2619.9 2620.1 2578.2 2605.0 2614.3 2625.1 2625.1 2564.9 2586.3 2592.0 2606.4 2608.8 9288.4 9380.2 9381.5 9403.2 9455.9 4947.0 5641.2 5758.0 5806.2 5813.2 3696.3 3765.8 3824.5 3837.2 3845.7 1077.0 1130.7 1653.4 1688.7 1705.3 12489.9 12555.2 12603.6 12608.6 12613.0 4800.3 4845.1 4900.7 4917.9 4953.8 8288.6 9673.5 9696.5 9704.0 9717.9 5543.6 5576.7 5580.5 5598.5 5608.7 4610.1 4943.4 5051.4 5093.9 5103.2 3852.0 3919.1 3921.3 3958.2 3962.3 1171.1 1172.9 1184.7 1186.5 1230.3 1387.0 1398.2 1415.6 1421.9 1446.8 8624.3 8859.7 8863.8 8873.4 8877.7 1254.4 1264.2 1267.1 1268.6 1300.3 6398.3 6430.2 6502.5 6510.7 6520.0 11114.8 11452.8 11629.3 11648.7 11729.5 11366.4 11431.5 11554.5 11574.9 11634.4 8790.8 8826.9 8840.2 8880.8 8910.9 8199.0 8349.4 8422.9 8423.2 8430.6 10212.1 10246.3 10313.2 10433.7 10499.2 9080.5 10485.3 10699.4 10706.4 10909.3 6438.8 6647.6 6790.7 6993.8 7192.9 8650.7 8664.6 8729.2 8738.6 8748.7 7613.8 7685.3 7751.5 7836.7 7863.6 7516.1 7578.3 7589.2 7707.3 7715.2 8073.6 8147.7 8148.7 8155.8 8160.1 7223.1 7339.5 7349.6 7364.9 7370.2 7479.0 7489.7 7528.0 7530.5 7554.4 12:01:59 INFO - PROCESS | 1667 | 12:01:59 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5800.78 Median:6597.26 stddev:1859.39 (28.2%) stddev-sans-first:1818.80 12:01:59 INFO - PROCESS | 1667 | Values: 336.3 340.4 343.2 347.5 351.9 6634.3 6650.1 6727.9 6746.4 6868.0 6613.3 6624.1 6638.5 6645.3 6678.5 4352.4 4608.1 4766.5 4766.8 4941.9 4882.7 4883.5 4886.8 4887.7 4893.4 4820.9 4846.9 4909.8 4913.8 4914.8 4262.7 4474.0 4678.0 4917.2 4918.1 4200.7 4207.9 4225.6 4230.7 4233.9 5623.9 5983.4 6382.6 6384.5 6385.4 5834.3 5846.4 5853.4 5859.2 5876.2 6844.2 7094.4 7097.1 7110.6 7114.1 4774.5 4783.0 4791.7 4793.7 4794.5 7372.6 7441.7 7446.0 7464.6 7475.4 4011.9 4852.6 4863.9 4867.3 4871.4 4913.5 4913.6 4914.2 4926.9 4932.7 4761.9 5801.3 5840.8 5857.7 5860.9 6275.9 6833.9 6879.9 7164.8 7197.7 1638.0 1664.6 1666.9 1667.8 1668.5 1016.0 1056.5 1065.7 1069.3 1092.6 4621.7 4996.3 5475.8 6378.7 6518.1 7333.7 7336.5 7363.3 7444.8 7468.1 5419.5 6555.2 6557.7 6573.4 6581.2 3834.9 3875.1 3878.9 3885.6 3913.5 6814.8 7323.0 7412.9 7650.2 7665.5 7646.3 7672.7 7679.9 7698.8 7703.0 7683.9 7684.4 7687.4 7692.0 7701.0 7168.6 7418.7 7448.5 7450.6 7458.0 7305.5 7315.2 7332.3 7343.3 7350.2 7598.7 7662.5 7666.8 7670.3 7698.3 4697.7 4729.6 4730.1 4730.2 4737.8 7159.0 7375.4 7387.4 7413.7 7422.2 7073.8 7171.0 7175.2 7180.2 7200.4 7111.7 7174.0 7178.4 7184.7 7191.8 6974.9 7010.4 7020.3 7024.9 7040.0 6810.2 7117.9 7157.2 7169.2 7169.9 6706.4 6828.3 6859.3 6896.9 6968.4 12:01:59 INFO - PROCESS | 1667 | 12:01:59 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:19108.74 Median:4175.58 stddev:27220.51 (651.9%) stddev-sans-first:27261.88 12:01:59 INFO - PROCESS | 1667 | Values: 729.3 737.1 748.9 756.0 787.9 15357.8 15536.0 15565.9 15573.1 15577.8 14307.6 14461.1 14464.1 14478.1 14482.1 817.2 827.8 942.4 997.7 1040.3 1025.3 1028.0 1029.2 1029.3 1031.3 1075.3 1078.3 1082.9 1082.9 1084.1 849.7 1031.8 1051.7 1057.6 1060.8 792.4 793.8 794.6 795.2 798.2 15376.3 15447.4 15467.2 15469.5 15478.1 12371.2 12506.7 13091.9 13408.3 13676.2 10244.3 10260.4 10510.7 10543.0 10792.5 3498.0 3499.7 3565.9 3643.3 3657.0 86053.0 86662.3 86987.0 89402.0 91330.5 9643.7 9873.2 9998.9 10249.5 10624.0 23408.8 23412.5 23425.2 23444.0 23455.6 7460.1 7516.5 7572.5 7691.9 7760.8 3994.4 4049.4 4143.5 4207.7 4217.0 3752.4 3786.7 3800.3 3801.8 3812.1 680.2 701.2 713.7 727.1 741.3 534.5 547.4 547.8 558.5 576.1 7099.4 8452.4 8538.2 8559.7 8602.0 590.6 594.8 607.4 623.2 623.9 3860.9 3916.9 4067.3 4230.9 4265.2 73715.0 97834.5 100583.0 102378.0 102389.5 68611.3 81296.0 81479.6 82851.6 85098.0 71218.6 76562.0 76992.6 77303.8 78326.9 8474.4 8612.2 8621.3 8663.6 8841.8 44929.0 48398.5 49271.5 50759.7 52386.5 65572.3 72336.0 73663.0 76159.6 76674.6 8510.2 9673.1 9911.2 10045.2 10260.2 12031.9 12177.1 12273.7 12344.8 12872.2 11480.5 11525.5 11609.2 11903.9 11931.5 11789.4 12318.3 12349.7 12394.5 12404.8 10869.3 11467.2 11494.1 11500.4 11702.6 8328.3 9787.8 9870.4 10299.5 10332.7 8928.2 8956.6 9537.8 9887.7 10032.4 12:01:59 INFO - PROCESS | 1667 | -------- Summary: end -------- 12:01:59 INFO - PROCESS | 1667 | 12:02:00 INFO - TEST-INFO | 1667: exit 0 12:02:00 INFO - TEST-OK | dromaeo_css | took 1113422ms 12:02:00 INFO - TEST-START | kraken 12:02:00 INFO - operating with platform_type : mac_ 12:02:00 INFO - Initialising browser for kraken test... 12:02:00 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpMJXyo0/profile http://localhost:49273/getInfo.html) 12:02:02 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 12:02:02 INFO - PROCESS | 1678 | colorDepth:24 12:02:02 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 12:02:02 INFO - PROCESS | 1678 | __metrics 12:02:02 INFO - PROCESS | 1678 | 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" 12:02:02 INFO - PROCESS | 1678 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:02:03 INFO - TEST-INFO | 1678: exit 0 12:02:03 INFO - Browser initialized. 12:02:03 INFO - Running cycle 1/1 for kraken test... 12:02:03 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpMJXyo0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:02:14 INFO - PROCESS | 1680 | RSS: Main: 210640896 12:02:14 INFO - PROCESS | 1680 | 12:02:17 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 12:02:18 INFO - PROCESS | 1680 | RSS: Main: 263888896 12:02:18 INFO - PROCESS | 1680 | 12:02:20 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 12:02:21 INFO - PROCESS | 1680 | RSS: Main: 274563072 12:02:21 INFO - PROCESS | 1680 | 12:02:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 12:02:25 INFO - PROCESS | 1680 | RSS: Main: 264384512 12:02:25 INFO - PROCESS | 1680 | 12:02:26 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 12:02:27 INFO - PROCESS | 1680 | RSS: Main: 266137600 12:02:27 INFO - PROCESS | 1680 | 12:02:29 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:30 INFO - PROCESS | 1680 | RSS: Main: 264663040 12:02:30 INFO - PROCESS | 1680 | 12:02:32 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:33 INFO - PROCESS | 1680 | RSS: Main: 266244096 12:02:33 INFO - PROCESS | 1680 | 12:02:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:36 INFO - PROCESS | 1680 | RSS: Main: 265252864 12:02:36 INFO - PROCESS | 1680 | 12:02:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 12:02:40 INFO - PROCESS | 1680 | RSS: Main: 264982528 12:02:40 INFO - PROCESS | 1680 | 12:02:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:42 INFO - PROCESS | 1680 | RSS: Main: 299438080 12:02:42 INFO - PROCESS | 1680 | 12:02:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:44 INFO - PROCESS | 1680 | RSS: Main: 299671552 12:02:44 INFO - PROCESS | 1680 | 12:02:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:47 INFO - PROCESS | 1680 | RSS: Main: 306499584 12:02:47 INFO - PROCESS | 1680 | 12:02:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:50 INFO - PROCESS | 1680 | RSS: Main: 310296576 12:02:50 INFO - PROCESS | 1680 | 12:02:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:53 INFO - PROCESS | 1680 | RSS: Main: 310349824 12:02:53 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 12:02:55 INFO - PROCESS | 1680 | RSS: Main: 369438720 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | __start_tp_report 12:02:55 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 12:02:55 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 12:02:55 INFO - PROCESS | 1680 | |i|pagename|runs| 12:02:55 INFO - PROCESS | 1680 | |0;ai-astar;114;108;111;110;113;112;119;112;110;110 12:02:55 INFO - PROCESS | 1680 | |1;audio-beat-detection;155;119;153;148;117;138;115;147;145;117 12:02:55 INFO - PROCESS | 1680 | |2;audio-dft;184;185;187;186;184;185;184;184;187;183 12:02:55 INFO - PROCESS | 1680 | |3;audio-fft;74;76;74;118;57;57;57;59;116;57 12:02:55 INFO - PROCESS | 1680 | |4;audio-oscillator;90;96;128;80;79;82;113;76;78;112 12:02:55 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;86;83;87;84;87;85;90;84;87;83 12:02:55 INFO - PROCESS | 1680 | |6;imaging-darkroom;93;93;93;93;92;92;93;93;93;91 12:02:55 INFO - PROCESS | 1680 | |7;imaging-desaturate;86;86;87;84;86;84;100;133;86;85 12:02:55 INFO - PROCESS | 1680 | |8;json-parse-financial;58;58;58;58;58;61;58;68;54;52 12:02:55 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;62;62;72;79;73;69;68;66;66;68 12:02:55 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;78;80;89;88;102;78;80;78;82;83 12:02:55 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;125;131;115;121;117;116;126;119;117;118 12:02:55 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;131;164;166;164;132;131;132;131;129;133 12:02:55 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;65;65;66;66;65;65;64;66;64;64 12:02:55 INFO - PROCESS | 1680 | __end_tp_report 12:02:55 INFO - PROCESS | 1680 | __start_cc_report 12:02:55 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1184 12:02:55 INFO - PROCESS | 1680 | __end_cc_report 12:02:55 INFO - PROCESS | 1680 | __startTimestamp1457982175583__endTimestamp 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | ------- Summary: start ------- 12:02:55 INFO - PROCESS | 1680 | Number of tests: 14 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:3.03 (2.7%) stddev-sans-first:3.12 12:02:55 INFO - PROCESS | 1680 | Values: 114.0 108.0 111.0 110.0 113.0 112.0 119.0 112.0 110.0 110.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:146.00 stddev:16.49 (11.3%) stddev-sans-first:15.90 12:02:55 INFO - PROCESS | 1680 | Values: 155.0 119.0 153.0 148.0 117.0 138.0 115.0 147.0 145.0 117.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.37 (0.7%) stddev-sans-first:1.41 12:02:55 INFO - PROCESS | 1680 | Values: 184.0 185.0 187.0 186.0 184.0 185.0 184.0 184.0 187.0 183.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:74.50 Median:58.00 stddev:23.76 (41.0%) stddev-sans-first:25.20 12:02:55 INFO - PROCESS | 1680 | Values: 74.0 76.0 74.0 118.0 57.0 57.0 57.0 59.0 116.0 57.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:79.50 stddev:18.26 (23.0%) stddev-sans-first:19.33 12:02:55 INFO - PROCESS | 1680 | Values: 90.0 96.0 128.0 80.0 79.0 82.0 113.0 76.0 78.0 112.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:2.22 (2.6%) stddev-sans-first:2.35 12:02:55 INFO - PROCESS | 1680 | Values: 86.0 83.0 87.0 84.0 87.0 85.0 90.0 84.0 87.0 83.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 12:02:55 INFO - PROCESS | 1680 | Values: 93.0 93.0 93.0 93.0 92.0 92.0 93.0 93.0 93.0 91.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:86.00 stddev:15.24 (17.7%) stddev-sans-first:16.02 12:02:55 INFO - PROCESS | 1680 | Values: 86.0 86.0 87.0 84.0 86.0 84.0 100.0 133.0 86.0 85.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:4.22 (7.3%) stddev-sans-first:4.47 12:02:55 INFO - PROCESS | 1680 | Values: 58.0 58.0 58.0 58.0 58.0 61.0 58.0 68.0 54.0 52.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:5.17 (7.5%) stddev-sans-first:4.92 12:02:55 INFO - PROCESS | 1680 | Values: 62.0 62.0 72.0 79.0 73.0 69.0 68.0 66.0 66.0 68.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.00 stddev:7.52 (9.3%) stddev-sans-first:7.68 12:02:55 INFO - PROCESS | 1680 | Values: 78.0 80.0 89.0 88.0 102.0 78.0 80.0 78.0 82.0 83.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:120.00 stddev:5.21 (4.3%) stddev-sans-first:5.27 12:02:55 INFO - PROCESS | 1680 | Values: 125.0 131.0 115.0 121.0 117.0 116.0 126.0 119.0 117.0 118.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:132.50 stddev:16.17 (12.2%) stddev-sans-first:16.71 12:02:55 INFO - PROCESS | 1680 | Values: 131.0 164.0 166.0 164.0 132.0 131.0 132.0 131.0 129.0 133.0 12:02:55 INFO - PROCESS | 1680 | 12:02:55 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 12:02:55 INFO - PROCESS | 1680 | Values: 65.0 65.0 66.0 66.0 65.0 65.0 64.0 66.0 64.0 64.0 12:02:55 INFO - PROCESS | 1680 | -------- Summary: end -------- 12:02:55 INFO - PROCESS | 1680 | 12:02:56 INFO - TEST-INFO | 1680: exit 0 12:02:56 INFO - TEST-OK | kraken | took 56095ms 12:02:56 INFO - SUITE-END | took 1169s 12:02:56 INFO - Completed test suite (00:19:29) 12:02:56 INFO - javascript benchmark 12:02:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3493.021953852921, 3539.5929468111176, 3548.828886467466, 3563.7861728296302, 3614.1145419372256, 5879.7354119064585, 5885.11723241514, 5891.941080589193, 5926.170336152942, 5931.911021334683, 5870.88258234835, 5889.705514724257, 5906.940930590693, 5915.142304365875, 5928.940710592893, 5181.300524429192, 5239.580833533328, 5250.606204534656, 5287.365516138068, 5302.363716354023, 5349.983503134412, 5350.625456218067, 5366.9463305367035, 5368.0, 5370.973145134289, 5281.815136470224, 5331.253624492574, 5346.4118946915805, 5354.089804733185, 5354.812581559646, 5332.253484512172, 5363.973180134074, 5366.141417373202, 5368.677879327252, 5375.784968601251, 5049.34358533392, 5275.366955965271, 5295.443978382292, 5300.602454815866, 5310.522053015247, 5712.0, 5739.62692424991, 5756.913646295309, 5782.768689252425, 5786.421357864222, 6241.531885108635, 6335.04974253861, 6341.239051313826, 6352.587081839665, 6373.203349581302, 6266.216722909637, 6270.059491076329, 6332.968335158294, 6334.746610135589, 6346.428821406095, 6020.879582408371, 6030.155778191057, 6035.3059398169335, 6039.7282122304605, 6048.879022419615, 5354.196870469461, 6253.6873156342, 6379.234491861006, 6381.1066450696935, 6406.743730250831, 6319.778807741707, 6326.905096423558, 6327.335629758901, 6336.746530138743, 6351.650659213695, 6322.051692246107, 6326.272478665012, 6331.493480521547, 6334.398232167937, 6343.270523889812, 6235.469985051322, 6278.623282603058, 6279.309275979638, 6332.651704156224, 6351.587146835441, 6251.499880009588, 6277.058441233851, 6303.716332765037, 6310.368963103745, 6311.368863113744, 4908.656394052454, 4911.631627627942, 4920.21276595743, 4920.655554111249, 4944.851654450372, 4388.758618275961, 4434.33484977256, 4473.083017981306, 4514.255147900625, 4539.477960034572, 5850.385709500526, 5854.326752423526, 5864.765409383577, 5871.588988770745, 5878.147668588031, 6278.529110316745, 6305.621662700252, 6305.716242768995, 6307.24313082433, 6315.5894866833505, 5727.255456790591, 5810.389909059572, 5817.970910145506, 5855.238818953594, 5908.852278693067, 5443.8082676339, 5474.151506516497, 5494.0, 5495.038368285614, 5502.284702988666, 6369.522285828489, 6387.520935929824, 6396.648184349905, 6397.520185986163, 6399.840003999844, 6253.6560489173535, 6255.0, 6279.466245369012, 6319.083732858801, 6337.556371053982, 6376.171097757262, 6385.010323399881, 6407.551471396958, 6407.8398040047505, 6409.615423074444, 6241.500679945684, 6325.399087086719, 6334.4932405406535, 6334.556581039283, 6352.650604216812, 6251.0, 6274.843128921813, 6286.591371560834, 6304.085907543472, 6315.3053164152825, 6270.184875966278, 6308.306086330408, 6310.716017779119, 6314.62112273265, 6315.179026726496, 5641.576881733804, 6120.26428866606, 6192.504599632109, 6258.311585725658, 6309.337519560564, 5986.371430999682, 5989.820305390671, 6144.151240645752, 6152.538559608137, 6179.3202747698615, 6283.3088360281245, 6294.181756371826, 6300.71646775887, 6305.085762564494, 6316.05259211122, 6044.969775151096, 6049.274087109575, 6134.754609815736, 6172.043333283348, 6175.228096487939], "unit": "score", "name": "dojo.html", "value": 5814.701257368995}, {"lowerIsBetter": false, "replicates": [476.73541184642534, 551.2062629813066, 597.6832278892186, 672.0826072411157, 678.3758941773568, 31890.0, 40163.39754903679, 40626.59373406265, 40775.0, 40856.79571602138, 36797.0, 43815.56184438155, 44080.77959610205, 44197.8950526237, 44396.33405498912, 9768.804623907517, 10006.0, 10013.0, 10019.148372388356, 10020.599176032987, 8628.741137765877, 9724.270679699015, 9934.205263578897, 9951.004899510028, 9977.50112494376, 9869.161121304662, 10063.29556931015, 10066.144377727866, 10073.64742234022, 10084.848727269096, 9936.105750482455, 10003.74990625233, 10025.94727553611, 10043.296969212159, 10055.095041446304, 9799.510024498746, 9906.05892440217, 9916.851247231298, 9935.552900119512, 10049.145822605087, 42929.785351073355, 43488.0, 43655.90860228488, 43683.0, 43746.34380484295, 3146.181992681896, 3263.1515805890403, 3415.4023045967106, 3672.394054980925, 3730.403135498307, 29671.0, 29716.851415743, 29948.0, 30351.0, 30605.846970765226, 2792.5950737143203, 2811.5923191137376, 2850.2874281429645, 2873.1380585824377, 2880.6687230968496, 501894.0, 502071.4896425531, 503663.4816825892, 504383.0, 504509.0, 70539.64730176317, 70931.64534177296, 71029.28970710227, 71067.64466177636, 71174.0, 76549.0, 80639.06579618229, 80839.19160808434, 80882.0, 80997.59501202457, 15812.92093539548, 18524.536886577673, 18679.97260150705, 18702.81297187038, 18733.531661708294, 13993.580192594238, 14093.929530352487, 14119.294035298193, 14141.71716565663, 14166.504172353918, 23175.0, 23496.530069398857, 23539.764602353756, 23545.7645423547, 23687.881560592086, 7517.473776835678, 8482.363822713321, 9618.711438656712, 9645.202891161485, 9666.275029372826, 960.4381436859376, 974.2498276327188, 1049.0715716590719, 1076.6393258258415, 1158.154547180563, 30709.539356909663, 30757.538636920464, 30840.53739193914, 31077.689223107933, 31336.843315783277, 953.8616900549381, 1143.7598104398003, 1167.3637867362308, 1168.485866218861, 1241.6585439004166, 15512.0, 16150.434734784227, 16294.0, 16358.263878125514, 16373.099479528502, 562754.0, 569684.0, 572110.0, 574400.0, 580508.0, 60001.699991499765, 62178.445538860986, 62209.688951554956, 62225.37774622286, 62305.06542401868, 1435.224978511592, 1489.5233525271808, 1525.3212320517264, 1530.5178868656337, 1563.788888500038, 24738.628920565847, 24751.38121546904, 28887.855560722903, 29395.853020735616, 30302.545461817648, 47082.76458617685, 47253.76373118113, 47501.52498474971, 47515.28727069028, 47540.762296188295, 300035.0, 300696.0, 302503.0, 302762.0, 303575.0, 28795.712042879302, 34546.136346591535, 34612.307753845285, 34725.0, 35019.124521887155, 42001.78999104985, 42240.0, 42387.152256955305, 44201.77899110484, 44412.77793611011, 34744.0, 36032.4595131068, 36074.63925360713, 36235.818820905726, 36834.63165368312, 34711.82644086763, 35905.64094359023, 35947.10132246715, 36288.81855590811, 36574.817125915266, 33489.99530014103, 36553.63446365502, 36979.81510092432, 37919.0, 38054.80972595119, 31987.0, 32147.671782786158, 32328.35343293168, 32688.0, 32927.341453170324, 24395.39011524726, 24479.977642033577, 24562.754372456046, 24593.0, 24838.37904052413], "unit": "score", "name": "ext.html", "value": 20342.132217571412}, {"lowerIsBetter": false, "replicates": [359.83627449510476, 385.1238432565912, 386.21790873481194, 390.66988394806395, 393.87592908233887, 19531.804681953177, 21085.578288434222, 21357.893210533945, 21826.126954921805, 21847.0, 12245.63263102106, 12629.368531573407, 21142.365729028115, 21423.464413389673, 21450.89274553629, 5398.406175320712, 5543.251661025771, 5599.384067752544, 5599.888002239953, 5600.0759874620635, 4187.790610469479, 4366.19225443294, 5976.73104710289, 6204.069389591552, 6215.751369945219, 5956.791512297071, 6187.0, 6198.8450288742915, 6201.224846894138, 6203.348648391921, 5878.941210587882, 6174.444300012976, 6175.7220925058255, 6182.72177752, 6192.628442293454, 3226.0, 5659.5755318351285, 5888.175655408247, 5891.646501209942, 5892.852678683024, 13893.305334733222, 13927.373268202955, 13936.58190254294, 24544.01823927041, 25234.0, 2101.1385332013956, 2188.365374041526, 2209.436593668604, 2255.6954811100454, 2266.9206577769864, 10053.748656283578, 10078.042585954323, 10411.167106631452, 13456.730865382637, 14669.902431776492, 1774.9290028398848, 1835.1741716227618, 1859.6466671332403, 1869.813018698133, 1890.0455270088655, 96214.0, 102890.48554757253, 114063.42968285189, 115939.0, 117104.0, 9888.752781180385, 12039.518419263131, 12126.029917606571, 12127.818082728767, 12230.694232644077, 14656.413743450143, 14721.337539810735, 14752.336144873507, 14762.335694893756, 14785.630359241106, 11545.480453379618, 11720.531178752924, 11739.706507337214, 11797.17419780607, 12010.919017288312, 8480.727890816426, 9656.468894210886, 9715.562799674031, 9874.061964113398, 10239.334443261165, 9107.087511622634, 9153.588088536031, 9203.953980230055, 9245.260379169651, 9256.95371523138, 3198.8080715157166, 3737.1404576947452, 3747.3837746574686, 3754.9436758448646, 3789.905252368658, 886.8802711633847, 917.9036201198911, 998.1216529454034, 1093.6882988348282, 1119.1774046076127, 19001.524961876064, 20871.478213044797, 21321.36035918925, 21524.0, 21769.203493859826, 1002.8846682631445, 1025.5897640943533, 1031.7369070886875, 1034.462079718542, 1036.6164519127972, 11087.83368249477, 11461.312321260752, 11485.885141148648, 11498.597549085742, 11504.94247528757, 668311.0, 692868.0, 709163.0, 709368.0, 710239.0, 101034.49482752687, 102941.0, 112163.43918280356, 118738.0, 121362.0, 1049.9632512862013, 1052.9789404211872, 1062.7236918401272, 1065.2064212161833, 1066.7066556696816, 18319.287786811423, 18700.438986830417, 19068.618627627093, 19123.617527649647, 19185.136668849656, 51016.48983510117, 54067.72966135301, 54130.91738165294, 54252.45747542474, 55136.0, 67143.66428167828, 73791.63104184445, 73823.26176738164, 73841.6307918457, 73873.89189162059, 8201.671933122609, 8311.16888311164, 8347.332213423033, 8440.324774018187, 8624.913750862412, 12172.695682608006, 13504.86495135036, 13619.0, 13853.584392468241, 13893.513727019506, 10580.682579522627, 11792.646220613395, 11807.881921180679, 11875.346855922662, 11911.940440297743, 10178.694639160836, 11211.383373914514, 11673.0, 11754.529818807152, 11928.105392095455, 11858.16992810495, 12025.338606376383, 12032.578859739868, 12150.331731754839, 12376.0, 8444.746657600283, 8476.36427267945, 8629.0, 8694.610419755316, 8910.376273660782, 10770.138388929023, 10862.674119776419, 11446.0, 12076.45655945467, 12246.326452045223], "unit": "score", "name": "jquery.html", "value": 10096.975410467006}, {"lowerIsBetter": false, "replicates": [1513.8940274180811, 1638.9262483188256, 1661.8836681432301, 1992.521794769255, 2063.7007633893086, 8403.747887563368, 8979.775505612362, 9152.313576481758, 9167.816643667122, 9181.724548263546, 9002.32482563807, 9259.444433334005, 9259.861102083458, 9261.768455788608, 9328.48693321867, 2291.1522736587485, 2531.6708827852353, 2581.66438363013, 2591.6889973203147, 2615.3330900620317, 2238.876861772602, 2621.1743300860167, 2625.7111717711036, 2625.9868700656566, 2627.2249686342575, 2523.6466894634764, 2611.791056715458, 2617.947641047178, 2619.9083032093786, 2620.082970960158, 2578.1749840051193, 2605.0, 2614.3333449970137, 2625.0812215724536, 2625.146827281141, 2564.8717564121907, 2586.314626623946, 2591.961120583193, 2606.361441446839, 2608.765211131007, 9288.396254243453, 9380.155785979294, 9381.5309234538, 9403.247740180768, 9455.858162127573, 4946.975265123651, 5641.18202860587, 5758.049921762904, 5806.187133801272, 5813.215215945877, 3696.31618150643, 3765.755225910307, 3824.521934758155, 3837.1750073734, 3845.6731177849915, 1076.9892301077045, 1130.6890605083586, 1653.3634550697948, 1688.7213609754376, 1705.3434427745283, 12489.937550312281, 12555.246685198827, 12603.558875439316, 12608.621741347773, 12613.0, 4800.255960326155, 4845.1278769821065, 4900.681455705368, 4917.852464426073, 4953.826616068421, 8288.58557072144, 9673.516324183762, 9696.466694331739, 9704.0, 9717.9028209717, 5543.584231182596, 5576.749046292926, 5580.469855363734, 5598.524125449382, 5608.691521966331, 4610.05493873755, 4943.406791185081, 5051.444341122474, 5093.8726531837, 5103.157978933435, 3851.9807400963377, 3919.0790164311366, 3921.254961557295, 3958.2083583283456, 3962.286788378062, 1171.1158075652997, 1172.9061675065975, 1184.6979020349756, 1186.4779497021284, 1230.2556953043459, 1387.0360099730792, 1398.2100113435877, 1415.568251683226, 1421.85070567591, 1446.8263808342856, 8624.310055195569, 8859.689910853089, 8863.822723545492, 8873.378863479624, 8877.689280875138, 1254.3790823542404, 1264.2225031605496, 1267.0560432477862, 1268.5686866465446, 1300.3108352573151, 6398.2641996170105, 6430.228372595225, 6502.544821862519, 6510.707018184193, 6519.989401642753, 11114.777704445865, 11452.828207576893, 11629.302241865515, 11648.650540483799, 11729.530818767324, 11366.431678416046, 11431.542738290542, 11554.480048397842, 11574.88425115738, 11634.360110193851, 8790.824183516293, 8826.86759698605, 8840.204381605816, 8880.822383552422, 8910.910890891138, 8199.0, 8349.415540912078, 8422.915770842214, 8423.241908228289, 8430.578471076544, 10212.13196878244, 10246.333988290737, 10313.174946004452, 10433.739156521147, 10499.212559057949, 9080.500572468578, 10485.318454300446, 10699.358038517714, 10706.357618542912, 10909.34543927367, 6438.806835794933, 6647.634380109141, 6790.72837086511, 6993.755218567326, 7192.921061840766, 8650.697225597074, 8664.610092545976, 8729.170728780755, 8738.563071846509, 8748.737537873874, 7613.847723045619, 7685.269899359552, 7751.496152750054, 7836.725714600189, 7863.567503787347, 7516.098068231847, 7578.280063393969, 7589.241075892367, 7707.306342429209, 7715.151333353215, 8073.555954422563, 8147.714829980922, 8148.714794982147, 8155.79610509742, 8160.14318496573, 7223.133224013152, 7339.486235963432, 7349.632518373953, 7364.852702946018, 7370.189279179393, 7478.962605186939, 7489.66296516669, 7528.021357223526, 7530.548167109991, 7554.357879580297], "unit": "score", "name": "mootools.html", "value": 5202.672874376783}, {"lowerIsBetter": false, "replicates": [336.3290235979221, 340.36521886681345, 343.2037672599567, 347.45102737674466, 351.93489204497155, 6634.303398143192, 6650.06899034135, 6727.899081513781, 6746.426553742932, 6867.965660171692, 6613.338666133384, 6624.138861947952, 6638.535302528825, 6645.302243264448, 6678.465722742181, 4352.412424322723, 4608.147492713859, 4766.5471780181, 4766.7616619169075, 4941.925871111918, 4882.731449770261, 4883.511648835123, 4886.755662216893, 4887.657863949525, 4893.3638626978445, 4820.903581928359, 4846.878828029292, 4909.8036078557, 4913.82801601944, 4914.778834952418, 4262.680298977589, 4473.955260447403, 4677.976610116944, 4917.188663870457, 4918.139325618038, 4200.663946884242, 4207.852725154636, 4225.640820530259, 4230.682698797603, 4233.936490952638, 5623.9437605623825, 5983.431574000507, 6382.61704297739, 6384.52116091295, 6385.393387628168, 5834.27071616048, 5846.444587764156, 5853.443922827367, 5859.1797148399255, 5876.177335173036, 6844.247132815386, 7094.432445404407, 7097.112860892388, 7110.57336559808, 7114.110736157981, 4774.4509381420885, 4783.015048754763, 4791.712497250176, 4793.712377257376, 4794.49657785931, 7372.631368431611, 7441.66512506933, 7445.9627701861145, 7464.589447580381, 7475.401967842559, 4011.859584914572, 4852.56326930578, 4863.878403039952, 4867.342908707279, 4871.415430148334, 4913.484084171182, 4913.582345500601, 4914.238293064581, 4926.926096108561, 4932.728699921467, 4761.9047619048115, 5801.303843538718, 5840.8247752567495, 5857.70711464425, 5860.8534786629825, 6275.905861412082, 6833.897491537631, 6879.931200688029, 7164.785056448315, 7197.748078817321, 1638.0417455788497, 1664.5588918936492, 1666.908320042385, 1667.8415550522682, 1668.457751230855, 1016.0, 1056.4928834159646, 1065.733566608348, 1069.2996087562658, 1092.6012005617893, 4621.699589526737, 4996.300517927493, 5475.835724928259, 6378.712957916905, 6518.054882042172, 7333.74331898381, 7336.523125996793, 7363.337299643058, 7444.813879652944, 7468.10382754073, 5419.458054194549, 6555.2133743951035, 6557.672116394161, 6573.408393244631, 6581.177352830896, 3834.884953451401, 3875.147467557133, 3878.903027424337, 3885.630865067814, 3913.471681323042, 6814.773340798703, 7323.0480037595835, 7412.85174296511, 7650.19672934345, 7665.501742386727, 7646.273604007611, 7672.693092276358, 7679.923200768033, 7698.769036928901, 7702.961485192538, 7683.923160768432, 7684.4236682250175, 7687.385009199251, 7692.000039994765, 7700.9614951926005, 7168.641567921687, 7418.740344087931, 7448.47860649771, 7450.590217537871, 7457.993170921856, 7305.488615797056, 7315.195328513752, 7332.266773322625, 7343.3390994810725, 7350.228226036403, 7598.696052157852, 7662.463627546242, 7666.8083297918, 7670.309672129535, 7698.307152356315, 4697.694649847749, 4729.597984171384, 4730.148573256847, 4730.243161094346, 4737.8341758038305, 7159.0, 7375.409967202503, 7387.4459415545125, 7413.66638501258, 7422.220666830121, 7073.752418665322, 7171.0, 7175.174854891546, 7180.210176880434, 7200.423966082805, 7111.6799744010605, 7173.964130179315, 7178.425725941807, 7184.712611495482, 7191.820204494929, 6974.895376569254, 7010.404115650227, 7020.262872398529, 7024.929750702428, 7039.964800175966, 6810.182778066664, 7117.8576428470105, 7157.212706602374, 7169.247229041084, 7169.928300716926, 6706.429953454011, 6828.2830302819475, 6859.348361905611, 6896.93103068983, 6968.3728464438445], "unit": "score", "name": "prototype.html", "value": 5184.226994358997}, {"lowerIsBetter": false, "replicates": [729.2816575672964, 737.1301863800713, 748.8614606297836, 755.9924400755995, 787.9054513458384, 15357.846421535782, 15536.0, 15565.92217038916, 15573.065616063044, 15577.844221557782, 14307.642308942282, 14461.060031097972, 14464.059836110646, 14478.131312121253, 14482.058666186691, 817.2032268538187, 827.7889138269733, 942.4251206763869, 997.6657819630433, 1040.2874031288554, 1025.2669341420883, 1028.028513055163, 1029.1766586730585, 1029.3309348923221, 1031.3244824639835, 1075.3118004477142, 1078.250615822004, 1082.886296938822, 1082.9296095753791, 1084.1164450972472, 849.6771226933756, 1031.8142734307821, 1051.7265510967204, 1057.5505410200633, 1060.8355704865796, 792.4136139256966, 793.7737744742778, 794.5550491724595, 795.1730200591378, 798.2217338095369, 15376.308066136939, 15447.382104715798, 15467.226638668022, 15469.5359139226, 15478.148701821396, 12371.195872268363, 12506.687332816662, 13091.86908130916, 13408.329583520785, 13676.246909665628, 10244.28290019699, 10260.384376937407, 10510.737231569196, 10543.0, 10792.51433685486, 3498.0, 3499.6675315844955, 3565.893023209308, 3643.344198044351, 3656.981715091434, 86053.0, 86662.26675466455, 86987.0, 89402.0, 91330.5433472835, 9643.662471813454, 9873.210143188528, 9998.850017249748, 10249.538770755185, 10624.0, 23408.76591234066, 23412.531749364916, 23425.180118695764, 23444.0, 23455.648165277533, 7460.0674915635545, 7516.549007059594, 7572.507786993828, 7691.923080769233, 7760.805979850549, 3994.400839873984, 4049.392591111357, 4143.502779666399, 4207.663386929038, 4216.9789151054665, 3752.418375151856, 3786.6970642348547, 3800.3349413852466, 3801.752886062397, 3812.1041555234497, 680.2211467869262, 701.1866235167283, 713.6717110129399, 727.0911360799001, 741.2846603027996, 534.5353730777641, 547.3814589513823, 547.7606691991172, 558.5001423725743, 576.0725232375871, 7099.432045436456, 8452.408331416742, 8538.188872057144, 8559.657613695506, 8601.956990215009, 590.6042951222691, 594.8453402115481, 607.3774381259244, 623.233422889848, 623.9376062393725, 3860.864869729546, 3916.8629097981434, 4067.2678917795083, 4230.936535951963, 4265.210935976854, 73715.0, 97834.53248201283, 100583.0, 102378.0, 102389.48805255926, 68611.31388686149, 81296.0, 81479.59260203662, 82851.5857420709, 85098.0, 71218.64390678014, 76562.0, 76992.61503692446, 77303.84044239341, 78326.86692532348, 8474.449160804528, 8612.18184272493, 8621.310295176245, 8663.566821658766, 8841.823163536565, 44929.0, 48398.54804355875, 49271.507284926694, 50759.731006725124, 52386.47613523968, 65572.34427655854, 72336.0, 73663.0, 76159.61920190364, 76674.61662691651, 8510.191531804468, 9673.081057299545, 9911.157551608194, 10045.196384289386, 10260.230482713976, 12031.939840300742, 12177.086718496326, 12273.69315767113, 12344.75310493803, 12872.22766634005, 11480.483378247833, 11525.481353338952, 11609.245399049034, 11903.880961190624, 11931.463084161407, 11789.410529473664, 12318.322492263012, 12349.691257718629, 12394.504219831106, 12404.75190496167, 10869.293495923055, 11467.197296189186, 11494.080473561928, 11500.367479788358, 11702.648920532398, 8328.292095171979, 9787.825460944447, 9870.358426702242, 10299.536520856429, 10332.741681458023, 8928.15182557656, 8956.596953137256, 9537.761555961157, 9887.73170502202, 10032.394816829565], "unit": "score", "name": "yui.html", "value": 7184.324973248629}], "name": "dromaeo_css", "value": 7835.637040202109}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 111.0, 110.0, 113.0, 112.0, 119.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [155.0, 119.0, 153.0, 148.0, 117.0, 138.0, 115.0, 147.0, 145.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 135.4}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 187.0, 186.0, 184.0, 185.0, 184.0, 184.0, 187.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.9}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 74.0, 118.0, 57.0, 57.0, 57.0, 59.0, 116.0, 57.0], "unit": "score", "name": "audio-fft", "value": 74.5}, {"lowerIsBetter": true, "replicates": [90.0, 96.0, 128.0, 80.0, 79.0, 82.0, 113.0, 76.0, 78.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 87.0, 84.0, 87.0, 85.0, 90.0, 84.0, 87.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 92.0, 92.0, 93.0, 93.0, 93.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 92.6}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 87.0, 84.0, 86.0, 84.0, 100.0, 133.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 91.7}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 61.0, 58.0, 68.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 72.0, 79.0, 73.0, 69.0, 68.0, 66.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 89.0, 88.0, 102.0, 78.0, 80.0, 78.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [125.0, 131.0, 115.0, 121.0, 117.0, 116.0, 126.0, 119.0, 117.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [131.0, 164.0, 166.0, 164.0, 132.0, 131.0, 132.0, 131.0, 129.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 64.0, 66.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1407.4}]} 12:02:56 INFO - Return code: 0 12:02:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:02:56 INFO - # TBPL SUCCESS # 12:02:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:02:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:02:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:02:56 INFO - 2016-03-14 12:02:56.917 screenresolution[1684:9925] starting screenresolution argv=screenresolution get 12:02:56 INFO - 2016-03-14 12:02:56.919 screenresolution[1684:9925] Display 0: 1600x1200x32@60 12:02:56 INFO - 2016-03-14 12:02:56.925 screenresolution[1685:9928] starting screenresolution argv=screenresolution list 12:02:56 INFO - Available Modes on Display 0 12:02:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:02:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:02:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:02:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:02:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:02:57 INFO - Intel Iris: 12:02:57 INFO - Chipset Model: Intel Iris 12:02:57 INFO - Type: GPU 12:02:57 INFO - Bus: Built-In 12:02:57 INFO - VRAM (Dynamic, Max): 1536 MB 12:02:57 INFO - Vendor: Intel (0x8086) 12:02:57 INFO - Device ID: 0x0a2e 12:02:57 INFO - Revision ID: 0x0009 12:02:57 INFO - Displays: 12:02:57 INFO - Display: 12:02:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:02:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:02:57 INFO - Display Serial Number: 1600x1200 60 12:02:57 INFO - Main Display: Yes 12:02:57 INFO - Mirror: Off 12:02:57 INFO - Online: Yes 12:02:57 INFO - Rotation: Supported 12:02:57 INFO - Return code: 0 12:02:57 INFO - Running post-action listener: _resource_record_post_action 12:02:57 INFO - Running post-run listener: _resource_record_post_run 12:02:58 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 37438976; Write bytes: 666484736; Read time: 392; Write time: 2069 12:02:58 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358126080; Write bytes: 355788800; Read time: 28273; Write time: 797 12:02:58 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 35644928; Write bytes: 298390016; Read time: 374; Write time: 1232 12:02:58 INFO - Running post-run listener: _upload_blobber_files 12:02:58 INFO - Blob upload gear active. 12:02:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:02:58 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 12:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:02:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:59 INFO - (blobuploader) - INFO - Done attempting. 12:02:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:02:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:00 INFO - (blobuploader) - INFO - Done attempting. 12:03:00 INFO - (blobuploader) - INFO - Iteration through files over. 12:03:00 INFO - Return code: 0 12:03:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:03:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:03:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c517a28d44016edb497f2a9d7a54e58955c18d65a4fdd94bfc96a766a959379684e95f720d35579df35b075eb4118e7a83b3533558c4d25124bdea29dd8410d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0148cbd35c0301b50bb25ff22f03ae8780633e0d6ea09fc0bd9de1ba058ea55da81ccf773adbc234d0045b0215a9d2bacb476845429a507299d5902ec0531ff6"} 12:03:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:03:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:03:00 INFO - Contents: 12:03:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c517a28d44016edb497f2a9d7a54e58955c18d65a4fdd94bfc96a766a959379684e95f720d35579df35b075eb4118e7a83b3533558c4d25124bdea29dd8410d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0148cbd35c0301b50bb25ff22f03ae8780633e0d6ea09fc0bd9de1ba058ea55da81ccf773adbc234d0045b0215a9d2bacb476845429a507299d5902ec0531ff6"} 12:03:00 INFO - Running post-run listener: copy_logs_to_upload_dir 12:03:00 INFO - Copying logs to upload dir... 12:03:00 INFO - mkdir: /builds/slave/test/build/upload/logs 12:03:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.134888 ========= master_lag: 49.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-03-14 12:03:50.370565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-14 12:03:50.374514) ========= 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.yOTUKnCBY4/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.snRGlPGo46/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/Mozilla-Aurora/sha512/c517a28d44016edb497f2a9d7a54e58955c18d65a4fdd94bfc96a766a959379684e95f720d35579df35b075eb4118e7a83b3533558c4d25124bdea29dd8410d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0148cbd35c0301b50bb25ff22f03ae8780633e0d6ea09fc0bd9de1ba058ea55da81ccf773adbc234d0045b0215a9d2bacb476845429a507299d5902ec0531ff6"} build_url:https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011521 build_url: 'https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c517a28d44016edb497f2a9d7a54e58955c18d65a4fdd94bfc96a766a959379684e95f720d35579df35b075eb4118e7a83b3533558c4d25124bdea29dd8410d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0148cbd35c0301b50bb25ff22f03ae8780633e0d6ea09fc0bd9de1ba058ea55da81ccf773adbc234d0045b0215a9d2bacb476845429a507299d5902ec0531ff6"}' ========= master_lag: 4.44 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-14 12:03:54.826408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 12:03:54.826780) ========= 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.yOTUKnCBY4/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.snRGlPGo46/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.005319 ========= master_lag: 0.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 12:03:55.134408) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 12:03:55.134800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 12:03:55.173161) ========= ========= Total master_lag: 54.58 =========