builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0086 starttime: 1454070048.12 results: success (0) buildid: 20160129024825 builduid: 801e18aa107d4e8bbb05d2fb80123e7a revision: 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.122801) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.123178) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.123501) ========= 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.eGTzb594LS/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.5K0x0e4hQT/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005219 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.147055) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.147332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.164235) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.164508) ========= 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.eGTzb594LS/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.5K0x0e4hQT/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005632 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.230306) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.230560) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.230920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.231184) ========= 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.eGTzb594LS/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.5K0x0e4hQT/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-01-29 04:20:48-- 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% 16.2M=0.001s 2016-01-29 04:20:48 (16.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192881 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.476780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.477051) ========= 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.eGTzb594LS/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.5K0x0e4hQT/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.026499 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:48.552714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 04:20:48.553044) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eGTzb594LS/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.5K0x0e4hQT/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-01-29 04:20:48,636 truncating revision to first 12 chars 2016-01-29 04:20:48,636 Setting DEBUG logging. 2016-01-29 04:20:48,636 attempt 1/10 2016-01-29 04:20:48,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a3c5c9b1486?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-29 04:20:49,371 unpacking tar archive at: mozilla-central-8a3c5c9b1486/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982357 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 04:20:49.564564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:49.564921) ========= echo 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8a3c5c9b1486c3328bc4684d5ac5b3b849b09474'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eGTzb594LS/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.5K0x0e4hQT/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 program finished with exit code 0 elapsedTime=0.005755 script_repo_revision: '8a3c5c9b1486c3328bc4684d5ac5b3b849b09474' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:49.620602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:49.620967) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 04:20:49.641811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-29 04:20:49.642184) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eGTzb594LS/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.5K0x0e4hQT/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:20:49 INFO - MultiFileLogger online at 20160129 04:20:49 in /builds/slave/test 04:20:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:20:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:49 INFO - {'append_to_log': False, 04:20:49 INFO - 'base_work_dir': '/builds/slave/test', 04:20:49 INFO - 'blob_upload_branch': 'Firefox', 04:20:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:49 INFO - 'branch': 'Firefox', 04:20:49 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:49 INFO - 'config_files': ('talos/mac_config.py',), 04:20:49 INFO - 'default_actions': ('clobber', 04:20:49 INFO - 'read-buildbot-config', 04:20:49 INFO - 'download-and-extract', 04:20:49 INFO - 'populate-webroot', 04:20:49 INFO - 'create-virtualenv', 04:20:49 INFO - 'install', 04:20:49 INFO - 'run-tests'), 04:20:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:49 INFO - 'download_minidump_stackwalk': True, 04:20:49 INFO - 'download_symbols': 'ondemand', 04:20:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:49 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:49 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:49 INFO - 'installer_path': 'installer.exe', 04:20:49 INFO - 'log_level': 'info', 04:20:49 INFO - 'log_name': 'talos', 04:20:49 INFO - 'log_to_console': True, 04:20:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:20:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:20:49 INFO - 'opt_config_files': (), 04:20:49 INFO - 'pip_index': False, 04:20:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:20:49 INFO - 'cmd': ('bash', 04:20:49 INFO - '-c', 04:20:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:20:49 INFO - 'enabled': True, 04:20:49 INFO - 'halt_on_failure': False, 04:20:49 INFO - 'name': 'check_screen_resolution'},), 04:20:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:20:49 INFO - 'cmd': ('bash', 04:20:49 INFO - '-c', 04:20:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:20:49 INFO - 'enabled': True, 04:20:49 INFO - 'halt_on_failure': False, 04:20:49 INFO - 'name': 'check_screen_resolution'},), 04:20:49 INFO - 'run_cmd_checks_enabled': True, 04:20:49 INFO - 'sps_profile': False, 04:20:49 INFO - 'sps_profile_interval': 0, 04:20:49 INFO - 'suite': 'dromaeojs', 04:20:49 INFO - 'system_bits': '32', 04:20:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:49 INFO - 'title': 't-yosemite-r7-0086', 04:20:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:49 INFO - 'use_talos_json': True, 04:20:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:49 INFO - 'work_dir': 'build'} 04:20:49 INFO - ##### 04:20:49 INFO - ##### Running clobber step. 04:20:49 INFO - ##### 04:20:49 INFO - Running pre-action listener: _resource_record_pre_action 04:20:49 INFO - Running main action method: clobber 04:20:49 INFO - rmtree: /builds/slave/test/build 04:20:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:51 INFO - Running post-action listener: _resource_record_post_action 04:20:51 INFO - ##### 04:20:51 INFO - ##### Running read-buildbot-config step. 04:20:51 INFO - ##### 04:20:51 INFO - Running pre-action listener: _resource_record_pre_action 04:20:51 INFO - Running main action method: read_buildbot_config 04:20:51 INFO - Using buildbot properties: 04:20:51 INFO - { 04:20:51 INFO - "project": "", 04:20:51 INFO - "product": "firefox", 04:20:51 INFO - "script_repo_revision": "production", 04:20:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:20:51 INFO - "repository": "", 04:20:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:20:51 INFO - "buildid": "20160129024825", 04:20:51 INFO - "pgo_build": "False", 04:20:51 INFO - "basedir": "/builds/slave/test", 04:20:51 INFO - "buildnumber": 93, 04:20:51 INFO - "slavename": "t-yosemite-r7-0086", 04:20:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:20:51 INFO - "platform": "yosemite_r7", 04:20:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:20:51 INFO - "branch": "mozilla-central", 04:20:51 INFO - "repo_path": "mozilla-central", 04:20:51 INFO - "revision": "8a3c5c9b1486c3328bc4684d5ac5b3b849b09474", 04:20:51 INFO - "stage_platform": "macosx64", 04:20:51 INFO - "builduid": "801e18aa107d4e8bbb05d2fb80123e7a", 04:20:51 INFO - "slavebuilddir": "test" 04:20:51 INFO - } 04:20:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:20:51 INFO - Running post-action listener: _resource_record_post_action 04:20:51 INFO - ##### 04:20:51 INFO - ##### Running download-and-extract step. 04:20:51 INFO - ##### 04:20:51 INFO - Running pre-action listener: _resource_record_pre_action 04:20:51 INFO - Running main action method: download_and_extract 04:20:51 INFO - mkdir: /builds/slave/test/build/tests 04:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:51 INFO - https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:20:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/test_packages.json 04:20:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/test_packages.json 04:20:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:20:58 INFO - Downloaded 1277 bytes. 04:20:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:20:58 INFO - Using the following test package requirements: 04:20:58 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:20:58 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:20:58 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:20:58 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:20:58 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:20:58 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:20:58 INFO - u'jsshell-mac.zip'], 04:20:58 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:20:58 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:20:58 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:20:58 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:20:58 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:20:58 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:20:58 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:20:58 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:20:58 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:20:58 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:20:58 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:20:58 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:20:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:20:58 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')]} 04:20:58 INFO - https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:20:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:20:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:20:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:20:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:20:59 INFO - Downloaded 16722240 bytes. 04:20:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:20:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:21:02 INFO - Return code: 0 04:21:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:21: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')]} 04:21:02 INFO - https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:21:10 INFO - Downloaded 16722240 bytes. 04:21:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:21:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:21:14 INFO - Return code: 0 04:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:14 INFO - https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:21:15 INFO - Downloaded 10706582 bytes. 04:21:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:21:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:21:15 INFO - Return code: 0 04:21:15 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')]} 04:21:15 INFO - https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:21:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:21:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:21:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:21:22 INFO - Downloaded 111019439 bytes. 04:21:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:21:22 INFO - mkdir: /builds/slave/test/properties 04:21:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:22 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:22 INFO - Contents: 04:21:22 INFO - build_url:https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:21:22 INFO - Running post-action listener: _resource_record_post_action 04:21:22 INFO - Running post-action listener: set_extra_try_arguments 04:21:22 INFO - ##### 04:21:22 INFO - ##### Running populate-webroot step. 04:21:22 INFO - ##### 04:21:22 INFO - Running pre-action listener: _resource_record_pre_action 04:21:22 INFO - Running main action method: populate_webroot 04:21:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:22 INFO - '--tppagecycles', 04:21:22 INFO - '7'], 04:21:22 INFO - 'tests': ['tsvgm']}}, 04:21:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:21:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:21:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:21:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:21:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:21:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:22 INFO - 'talos_options': ['--e10s'], 04:21:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:22 INFO - 'tests': ['damp', 'tps']}, 04:21:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:22 INFO - 'talos_options': ['--e10s'], 04:21:22 INFO - 'tests': ['damp', 'tps']}, 04:21:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:21:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:22 INFO - 'other': {'tests': ['a11yr', 04:21:22 INFO - 'ts_paint', 04:21:22 INFO - 'tpaint', 04:21:22 INFO - 'sessionrestore', 04:21:22 INFO - 'sessionrestore_no_auto_restore']}, 04:21:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:21:22 INFO - 'tests': ['a11yr', 04:21:22 INFO - 'ts_paint', 04:21:22 INFO - 'tpaint', 04:21:22 INFO - 'sessionrestore', 04:21:22 INFO - 'sessionrestore_no_auto_restore']}, 04:21:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:21:22 INFO - 'tests': ['a11yr', 04:21:22 INFO - 'ts_paint', 04:21:22 INFO - 'tpaint', 04:21:22 INFO - 'sessionrestore', 04:21:22 INFO - 'sessionrestore_no_auto_restore']}, 04:21:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:21:22 INFO - 'tests': ['a11yr', 04:21:22 INFO - 'ts_paint', 04:21:22 INFO - 'tpaint', 04:21:22 INFO - 'sessionrestore', 04:21:22 INFO - 'sessionrestore_no_auto_restore']}, 04:21:22 INFO - 'other_l64': {'tests': ['a11yr', 04:21:22 INFO - 'ts_paint', 04:21:22 INFO - 'tpaint', 04:21:22 INFO - 'sessionrestore', 04:21:22 INFO - 'sessionrestore_no_auto_restore']}, 04:21:22 INFO - 'other_nol64': {'tests': ['a11yr', 04:21:22 INFO - 'ts_paint', 04:21:22 INFO - 'tpaint', 04:21:22 INFO - 'sessionrestore', 04:21:22 INFO - 'sessionrestore_no_auto_restore']}, 04:21:22 INFO - 'svgr': {'tests': ['tsvgx', 04:21:22 INFO - 'tsvgr_opacity', 04:21:22 INFO - 'tart', 04:21:22 INFO - 'tscrollx', 04:21:22 INFO - 'cart']}, 04:21:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:21:22 INFO - 'tests': ['tsvgx', 04:21:22 INFO - 'tsvgr_opacity', 04:21:22 INFO - 'tart', 04:21:22 INFO - 'tscrollx', 04:21:22 INFO - 'cart']}, 04:21:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:22 INFO - 'tests': ['tp5o']}, 04:21:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:22 INFO - 'talos_options': ['--e10s'], 04:21:22 INFO - 'tests': ['tp5o']}, 04:21:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:22 INFO - 'talos_options': ['--xperf_path', 04:21:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:22 INFO - 'tests': ['tp5n']}, 04:21:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:22 INFO - 'talos_options': ['--e10s', 04:21:22 INFO - '--xperf_path', 04:21:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:22 INFO - 'tests': ['tp5n']}}, 04:21:22 INFO - 'talos.zip': {'path': '', 04:21:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:22 INFO - Running post-action listener: _resource_record_post_action 04:21:22 INFO - ##### 04:21:22 INFO - ##### Running create-virtualenv step. 04:21:22 INFO - ##### 04:21:22 INFO - Running pre-action listener: _resource_record_pre_action 04:21:22 INFO - Running main action method: create_virtualenv 04:21:22 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21:22 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 04:21:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:22 INFO - Using real prefix '/tools/python27' 04:21:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:23 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:26 INFO - Installing pip.................done. 04:21:26 INFO - Return code: 0 04:21:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:26 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')]} 04:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:26 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')]} 04:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:26 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 0x10ccb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcdad77210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, '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.eGTzb594LS/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.5K0x0e4hQT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:21:26 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 04:21:26 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 04:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:26 INFO - 'HOME': '/Users/cltbld', 04:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:26 INFO - 'LOGNAME': 'cltbld', 04:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:26 INFO - 'MOZ_NO_REMOTE': '1', 04:21:26 INFO - 'NO_EM_RESTART': '1', 04:21:26 INFO - 'PAGER': '/bin/cat', 04:21:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:26 INFO - 'PWD': '/builds/slave/test', 04:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:26 INFO - 'SHELL': '/bin/bash', 04:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:21:26 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:26 INFO - 'USER': 'cltbld', 04:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:26 INFO - 'XPC_FLAGS': '0x0', 04:21:26 INFO - 'XPC_SERVICE_NAME': '0', 04:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:26 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 04:21:26 INFO - Cleaning up... 04:21:26 INFO - Return code: 0 04:21:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:21:26 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')]} 04:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:26 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')]} 04:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:26 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 0x10ccb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcdad77210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, '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.eGTzb594LS/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.5K0x0e4hQT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:21:26 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 04:21:26 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 04:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:26 INFO - 'HOME': '/Users/cltbld', 04:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:26 INFO - 'LOGNAME': 'cltbld', 04:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:26 INFO - 'MOZ_NO_REMOTE': '1', 04:21:26 INFO - 'NO_EM_RESTART': '1', 04:21:26 INFO - 'PAGER': '/bin/cat', 04:21:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:26 INFO - 'PWD': '/builds/slave/test', 04:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:26 INFO - 'SHELL': '/bin/bash', 04:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:21:26 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:26 INFO - 'USER': 'cltbld', 04:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:26 INFO - 'XPC_FLAGS': '0x0', 04:21:26 INFO - 'XPC_SERVICE_NAME': '0', 04:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:26 INFO - Downloading/unpacking psutil>=0.7.1 04:21:26 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 04:21:26 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 04:21:26 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 04:21:26 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 04:21:26 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 04:21:26 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 04:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:29 INFO - Installing collected packages: psutil 04:21:29 INFO - Running setup.py install for psutil 04:21:29 INFO - building 'psutil._psutil_osx' extension 04:21:29 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 04:21:30 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 04:21:30 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 04:21:30 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 04:21:30 INFO - building 'psutil._psutil_posix' extension 04:21:30 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 04:21:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:21:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:21:30 INFO - ^ 04:21:30 INFO - 1 warning generated. 04:21:30 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 04:21:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:30 INFO - Successfully installed psutil 04:21:30 INFO - Cleaning up... 04:21:30 INFO - Return code: 0 04:21:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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', '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 0x10ccb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcdad77210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, '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.eGTzb594LS/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.5K0x0e4hQT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:21: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:21: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 mozsystemmonitor==0.0.0 04:21:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:21:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:30 INFO - 'HOME': '/Users/cltbld', 04:21:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:30 INFO - 'LOGNAME': 'cltbld', 04:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:30 INFO - 'MOZ_NO_REMOTE': '1', 04:21:30 INFO - 'NO_EM_RESTART': '1', 04:21:30 INFO - 'PAGER': '/bin/cat', 04:21:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:30 INFO - 'PWD': '/builds/slave/test', 04:21:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:30 INFO - 'SHELL': '/bin/bash', 04:21:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:21:30 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:21:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:30 INFO - 'USER': 'cltbld', 04:21:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:30 INFO - 'XPC_FLAGS': '0x0', 04:21:30 INFO - 'XPC_SERVICE_NAME': '0', 04:21:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:21:33 INFO - Installing collected packages: mozsystemmonitor 04:21:33 INFO - Running setup.py install for mozsystemmonitor 04:21:33 INFO - Successfully installed mozsystemmonitor 04:21:33 INFO - Cleaning up... 04:21:33 INFO - Return code: 0 04:21:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:33 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')]} 04:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:33 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')]} 04:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:33 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 0x10ccb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcdad77210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, '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.eGTzb594LS/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.5K0x0e4hQT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:21:33 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 04:21:33 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 04:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:33 INFO - 'HOME': '/Users/cltbld', 04:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:33 INFO - 'LOGNAME': 'cltbld', 04:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:33 INFO - 'MOZ_NO_REMOTE': '1', 04:21:33 INFO - 'NO_EM_RESTART': '1', 04:21:33 INFO - 'PAGER': '/bin/cat', 04:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:33 INFO - 'PWD': '/builds/slave/test', 04:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:33 INFO - 'SHELL': '/bin/bash', 04:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:21:33 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:33 INFO - 'USER': 'cltbld', 04:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:33 INFO - 'XPC_FLAGS': '0x0', 04:21:33 INFO - 'XPC_SERVICE_NAME': '0', 04:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:33 INFO - Downloading/unpacking blobuploader==1.2.4 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:36 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:37 INFO - Downloading docopt-0.6.1.tar.gz 04:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:37 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:37 INFO - Running setup.py install for blobuploader 04:21:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:37 INFO - Running setup.py install for requests 04:21:38 INFO - Running setup.py install for docopt 04:21:38 INFO - Successfully installed blobuploader requests docopt 04:21:38 INFO - Cleaning up... 04:21:38 INFO - Return code: 0 04:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:38 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 0x10ccb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcdad77210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, '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.eGTzb594LS/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.5K0x0e4hQT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:21:38 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 04:21:38 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 04:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:38 INFO - 'HOME': '/Users/cltbld', 04:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:38 INFO - 'LOGNAME': 'cltbld', 04:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:38 INFO - 'MOZ_NO_REMOTE': '1', 04:21:38 INFO - 'NO_EM_RESTART': '1', 04:21:38 INFO - 'PAGER': '/bin/cat', 04:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:38 INFO - 'PWD': '/builds/slave/test', 04:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:38 INFO - 'SHELL': '/bin/bash', 04:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:21:38 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:38 INFO - 'USER': 'cltbld', 04:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:38 INFO - 'XPC_FLAGS': '0x0', 04:21:38 INFO - 'XPC_SERVICE_NAME': '0', 04:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-3jCZ4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-4byeaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-yx0E3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-QFDQT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ZTgw8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-TCqdXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-MbFUYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-jq__fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-yxtrAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-yu99Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-xXYTPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-LAcVe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2HvCae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-3AKbbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:40 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-4Sj4KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:40 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-GIZRgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:40 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ro7uOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:40 INFO - Running setup.py install for manifestparser 04:21:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Running setup.py install for mozcrash 04:21:40 INFO - Running setup.py install for mozdebug 04:21:40 INFO - Running setup.py install for mozdevice 04:21:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Running setup.py install for mozfile 04:21:41 INFO - Running setup.py install for mozhttpd 04:21:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Running setup.py install for mozinfo 04:21:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Running setup.py install for mozInstall 04:21:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Running setup.py install for mozleak 04:21:41 INFO - Running setup.py install for mozlog 04:21:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Running setup.py install for moznetwork 04:21:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Running setup.py install for mozprocess 04:21:42 INFO - Running setup.py install for mozprofile 04:21:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Running setup.py install for mozrunner 04:21:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Running setup.py install for mozscreenshot 04:21:42 INFO - Running setup.py install for moztest 04:21:42 INFO - Running setup.py install for mozversion 04:21:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:42 INFO - Cleaning up... 04:21:42 INFO - Return code: 0 04:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:42 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 0x10ccb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcdad77210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, '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.eGTzb594LS/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.5K0x0e4hQT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:21:42 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 04:21:42 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 04:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:42 INFO - 'HOME': '/Users/cltbld', 04:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:42 INFO - 'LOGNAME': 'cltbld', 04:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:42 INFO - 'MOZ_NO_REMOTE': '1', 04:21:42 INFO - 'NO_EM_RESTART': '1', 04:21:42 INFO - 'PAGER': '/bin/cat', 04:21:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:42 INFO - 'PWD': '/builds/slave/test', 04:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:42 INFO - 'SHELL': '/bin/bash', 04:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:21:42 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:42 INFO - 'USER': 'cltbld', 04:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:42 INFO - 'XPC_FLAGS': '0x0', 04:21:42 INFO - 'XPC_SERVICE_NAME': '0', 04:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-l4W35D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-6ZsLgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-bJduP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-guQs3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2QZit_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-3LfyjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-UU5x0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:43 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)) 04:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-20QSDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-uPIGuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-PYrbxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Oooi7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-06R4X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Zy0KpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ZUVic6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-faprMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-t_cem3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:44 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)) 04:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-DPjjcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:44 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)) 04:21:44 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:44 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:44 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)) 04:21:44 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)) 04:21:44 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)) 04:21:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:44 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 04:21:44 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 04:21:44 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 04:21:44 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 04:21:44 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 04:21:44 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 04:21:47 INFO - Downloading blessings-1.6.tar.gz 04:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:47 INFO - Installing collected packages: blessings 04:21:47 INFO - Running setup.py install for blessings 04:21:47 INFO - Successfully installed blessings 04:21:47 INFO - Cleaning up... 04:21:47 INFO - Return code: 0 04:21:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:47 INFO - Reading from file tmpfile_stdout 04:21:47 INFO - Current package versions: 04:21:47 INFO - blessings == 1.6 04:21:47 INFO - blobuploader == 1.2.4 04:21:47 INFO - docopt == 0.6.1 04:21:47 INFO - manifestparser == 1.1 04:21:47 INFO - mozInstall == 1.12 04:21:47 INFO - mozcrash == 0.16 04:21:47 INFO - mozdebug == 0.1 04:21:47 INFO - mozdevice == 0.48 04:21:47 INFO - mozfile == 1.2 04:21:47 INFO - mozhttpd == 0.7 04:21:47 INFO - mozinfo == 0.9 04:21:47 INFO - mozleak == 0.1 04:21:47 INFO - mozlog == 3.1 04:21:47 INFO - moznetwork == 0.27 04:21:47 INFO - mozprocess == 0.22 04:21:47 INFO - mozprofile == 0.28 04:21:47 INFO - mozrunner == 6.11 04:21:47 INFO - mozscreenshot == 0.1 04:21:47 INFO - mozsystemmonitor == 0.0 04:21:47 INFO - moztest == 0.7 04:21:47 INFO - mozversion == 1.4 04:21:47 INFO - psutil == 3.1.1 04:21:47 INFO - requests == 1.2.3 04:21:47 INFO - wsgiref == 0.1.2 04:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:47 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 0x10ccb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcdad77210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, '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.eGTzb594LS/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.5K0x0e4hQT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:21:47 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 04:21:47 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 04:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:47 INFO - 'HOME': '/Users/cltbld', 04:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:47 INFO - 'LOGNAME': 'cltbld', 04:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:47 INFO - 'MOZ_NO_REMOTE': '1', 04:21:47 INFO - 'NO_EM_RESTART': '1', 04:21:47 INFO - 'PAGER': '/bin/cat', 04:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:47 INFO - 'PWD': '/builds/slave/test', 04:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:47 INFO - 'SHELL': '/bin/bash', 04:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:21:47 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:47 INFO - 'USER': 'cltbld', 04:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:47 INFO - 'XPC_FLAGS': '0x0', 04:21:47 INFO - 'XPC_SERVICE_NAME': '0', 04:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:48 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)) 04:21:48 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)) 04:21:48 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)) 04:21:48 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)) 04:21:48 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)) 04:21:48 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)) 04:21:48 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)) 04:21:48 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)) 04:21:48 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)) 04:21:48 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)) 04:21:48 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)) 04:21:48 INFO - Cleaning up... 04:21:48 INFO - Return code: 0 04:21:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcdad77210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, '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.eGTzb594LS/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.5K0x0e4hQT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:21: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', 'jsonschema'] in /builds/slave/test/build 04:21: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 jsonschema 04:21:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:21:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:48 INFO - 'HOME': '/Users/cltbld', 04:21:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:48 INFO - 'LOGNAME': 'cltbld', 04:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:48 INFO - 'MOZ_NO_REMOTE': '1', 04:21:48 INFO - 'NO_EM_RESTART': '1', 04:21:48 INFO - 'PAGER': '/bin/cat', 04:21:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:48 INFO - 'PWD': '/builds/slave/test', 04:21:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:48 INFO - 'SHELL': '/bin/bash', 04:21:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:21:48 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:21:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:48 INFO - 'USER': 'cltbld', 04:21:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:48 INFO - 'XPC_FLAGS': '0x0', 04:21:48 INFO - 'XPC_SERVICE_NAME': '0', 04:21:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:48 INFO - Downloading/unpacking jsonschema 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:50 INFO - Downloading/unpacking functools32 (from jsonschema) 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:51 INFO - warning: no files found matching '*.txt' 04:21:51 INFO - no previously-included directories found matching 'build' 04:21:51 INFO - no previously-included directories found matching 'dist' 04:21:51 INFO - no previously-included directories found matching '.git*' 04:21:51 INFO - Installing collected packages: jsonschema, functools32 04:21:51 INFO - Running setup.py install for functools32 04:21:51 INFO - warning: no files found matching '*.txt' 04:21:51 INFO - no previously-included directories found matching 'build' 04:21:51 INFO - no previously-included directories found matching 'dist' 04:21:51 INFO - no previously-included directories found matching '.git*' 04:21:51 INFO - Successfully installed jsonschema functools32 04:21:51 INFO - Cleaning up... 04:21:51 INFO - Return code: 0 04:21:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcdad77210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, '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.eGTzb594LS/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.5K0x0e4hQT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 04:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:51 INFO - 'HOME': '/Users/cltbld', 04:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:51 INFO - 'LOGNAME': 'cltbld', 04:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:51 INFO - 'MOZ_NO_REMOTE': '1', 04:21:51 INFO - 'NO_EM_RESTART': '1', 04:21:51 INFO - 'PAGER': '/bin/cat', 04:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:51 INFO - 'PWD': '/builds/slave/test', 04:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:51 INFO - 'SHELL': '/bin/bash', 04:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:21:51 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:51 INFO - 'USER': 'cltbld', 04:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:51 INFO - 'XPC_FLAGS': '0x0', 04:21:51 INFO - 'XPC_SERVICE_NAME': '0', 04:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:51 INFO - Downloading/unpacking flake8 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:21:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:21:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:21:54 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 04:21:54 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 04:21:54 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 04:21:54 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 04:21:54 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 04:21:54 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 04:21:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:21:54 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 04:21:54 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 04:21:54 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 04:21:54 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 04:21:54 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 04:21:54 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 04:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:55 INFO - no previously-included directories found matching 'docs/_build' 04:21:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:21:55 INFO - Running setup.py install for pep8 04:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:55 INFO - no previously-included directories found matching 'docs/_build' 04:21:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:21:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:21:55 INFO - Cleaning up... 04:21:55 INFO - Return code: 0 04:21:55 INFO - Running post-action listener: _resource_record_post_action 04:21:55 INFO - Running post-action listener: _start_resource_monitoring 04:21:55 INFO - Starting resource monitoring. 04:21:55 INFO - ##### 04:21:55 INFO - ##### Running install step. 04:21:55 INFO - ##### 04:21:55 INFO - Running pre-action listener: _resource_record_pre_action 04:21:55 INFO - Running main action method: install 04:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:55 INFO - Reading from file tmpfile_stdout 04:21:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:55 INFO - Reading from file tmpfile_stdout 04:21:55 INFO - Output received: 04:21:55 INFO - Usage: mozinstall [options] installer 04:21:55 INFO - Options: 04:21:55 INFO - -h, --help show this help message and exit 04:21:55 INFO - -d DEST, --destination=DEST 04:21:55 INFO - Directory to install application into. [default: 04:21:55 INFO - "/builds/slave/test"] 04:21:55 INFO - --app=APP Application being installed. [default: firefox] 04:21:55 INFO - mkdir: /builds/slave/test/build/application 04:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:22:29 INFO - Reading from file tmpfile_stdout 04:22:29 INFO - Output received: 04:22:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:22:29 INFO - Running post-action listener: _resource_record_post_action 04:22:29 INFO - ##### 04:22:29 INFO - ##### Running run-tests step. 04:22:29 INFO - ##### 04:22:29 INFO - Running pre-action listener: _resource_record_pre_action 04:22:29 INFO - Running main action method: run_tests 04:22:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:22:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:22:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:22:29 INFO - 2016-01-29 04:22:29.866 screenresolution[1654:8014] starting screenresolution argv=screenresolution get 04:22:29 INFO - 2016-01-29 04:22:29.868 screenresolution[1654:8014] Display 0: 1600x1200x32@60 04:22:29 INFO - 2016-01-29 04:22:29.874 screenresolution[1655:8016] starting screenresolution argv=screenresolution list 04:22:29 INFO - Available Modes on Display 0 04:22:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:22:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:22:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:22:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:22:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:22:30 INFO - Intel Iris: 04:22:30 INFO - Chipset Model: Intel Iris 04:22:30 INFO - Type: GPU 04:22:30 INFO - Bus: Built-In 04:22:30 INFO - VRAM (Dynamic, Max): 1536 MB 04:22:30 INFO - Vendor: Intel (0x8086) 04:22:30 INFO - Device ID: 0x0a2e 04:22:30 INFO - Revision ID: 0x0009 04:22:30 INFO - Displays: 04:22:30 INFO - Display: 04:22:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:22:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:22:30 INFO - Display Serial Number: 1600x1200 60 04:22:30 INFO - Main Display: Yes 04:22:30 INFO - Mirror: Off 04:22:30 INFO - Online: Yes 04:22:30 INFO - Rotation: Supported 04:22:30 INFO - Return code: 0 04:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:22:30 INFO - Python 2.7.3 04:22:30 INFO - Return code: 0 04:22:30 INFO - grabbing minidump binary from tooltool 04:22: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')]} 04:22:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57d30>, '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 0x10c97adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb4db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:22:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:22:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:22:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:22:30 INFO - Return code: 0 04:22:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:22:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:22:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:22:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:22:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:22:31 INFO - Return code: 0 04:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 04:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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 04:22:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eGTzb594LS/Render', 04:22:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:31 INFO - 'HOME': '/Users/cltbld', 04:22:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:31 INFO - 'LOGNAME': 'cltbld', 04:22:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:31 INFO - 'MOZ_NO_REMOTE': '1', 04:22:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:31 INFO - 'NO_EM_RESTART': '1', 04:22:31 INFO - 'PAGER': '/bin/cat', 04:22:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:31 INFO - 'PWD': '/builds/slave/test', 04:22:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:31 INFO - 'SHELL': '/bin/bash', 04:22:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5K0x0e4hQT/Listeners', 04:22:31 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 04:22:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:31 INFO - 'USER': 'cltbld', 04:22:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:31 INFO - 'XPC_FLAGS': '0x0', 04:22:31 INFO - 'XPC_SERVICE_NAME': '0', 04:22:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 04:22:31 INFO - mozversion application_buildid: 20160129024825 04:22:31 INFO - mozversion application_changeset: 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 04:22:31 INFO - mozversion application_display_name: Nightly 04:22:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:22:31 INFO - mozversion application_name: Firefox 04:22:31 INFO - mozversion application_remotingname: firefox 04:22:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:22:31 INFO - mozversion application_vendor: Mozilla 04:22:31 INFO - mozversion application_version: 47.0a1 04:22:31 INFO - mozversion platform_buildid: 20160129024825 04:22:31 INFO - mozversion platform_changeset: 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 04:22:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:22:31 INFO - mozversion platform_version: 47.0a1 04:22:31 INFO - using testdate: 1454070151 04:22:31 INFO - actual date: 1454070151 04:22:32 INFO - starting webserver on 'localhost:49278' 04:22:32 INFO - SUITE-START | Running 2 tests 04:22:32 INFO - TEST-START | dromaeo_css 04:22:32 INFO - operating with platform_type : mac_ 04:22:32 INFO - Initialising browser for dromaeo_css test... 04:22:32 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpCdfmjM/profile http://localhost:49278/getInfo.html) 04:22:34 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 04:22:34 INFO - PROCESS | 1673 | colorDepth:24 04:22:34 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 04:22:34 INFO - PROCESS | 1673 | __metrics 04:22:34 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:22:34 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:22:34 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:22:35 INFO - TEST-INFO | 1673: exit 0 04:22:35 INFO - Browser initialized. 04:22:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:35 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpCdfmjM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:47 INFO - PROCESS | 1677 | RSS: Main: 241307648 04:22:47 INFO - PROCESS | 1677 | 04:23:38 INFO - PROCESS | 1677 | 1454070218512 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] 04:25:48 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 04:25:50 INFO - PROCESS | 1677 | RSS: Main: 388272128 04:25:50 INFO - PROCESS | 1677 | 04:28:53 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 04:28:53 INFO - PROCESS | 1677 | RSS: Main: 376143872 04:28:53 INFO - PROCESS | 1677 | 04:31:55 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 04:31:56 INFO - PROCESS | 1677 | RSS: Main: 377425920 04:31:56 INFO - PROCESS | 1677 | 04:34:58 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 04:34:59 INFO - PROCESS | 1677 | RSS: Main: 370491392 04:34:59 INFO - PROCESS | 1677 | 04:38:02 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 04:38:02 INFO - PROCESS | 1677 | RSS: Main: 338067456 04:38:02 INFO - PROCESS | 1677 | 04:41:05 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 04:41:05 INFO - PROCESS | 1677 | RSS: Main: 410959872 04:41:05 INFO - PROCESS | 1677 | 04:41:05 INFO - PROCESS | 1677 | __start_tp_report 04:41:05 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 04:41:05 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 04:41:05 INFO - PROCESS | 1677 | |i|pagename|runs| 04:41:05 INFO - PROCESS | 1677 | |0;dojo.html;3143.3084721361297;3524.400851855186;3542.875999340022;3560.483729859172;3605.8016809075507;5607.130894711316;5700.17347484615;5708.1152421374645;5722.54219662427;5731.799387021455;5642.943570564293;5720.713964301779;5736.053551164053;5841.941580584193;5854.590178687494;5137.101007323722;5140.588752899759;5171.146760784466;5182.533571978521;5217.034848553011;5235.58115350771;5288.762005709752;5297.947020529784;5302.655327403726;5327.440618735035;5115.386153661547;5146.0479811235045;5196.8960620787375;5237.397699264576;5252;5195.116830138848;5223.320968274138;5235.345581802275;5249.02892964799;5265.9994601026065;5133.974330128362;5187.325647665817;5192.870178245536;5205.063088644042;5211.895762084737;5497.147942068986;5632.267805185341;5642;5667.1782591524;5672.914906276409;5201.635885488017;6140.815775526741;6166.475849552793;6199.566030377875;6303.653299068549;4631.305304204363;6332.968335158341;6337.936620633781;6342.365763423667;6354.491640668782;5673.659580425187;5786.929418057631;5794.391588883149;5804.245448091721;5804.419558044204;6265.310815810257;6305.527085468608;6356.745730170834;6394.424501794861;6404.135441715309;6189.721462534197;6213.00591905302;6221.035739460391;6235.75056997715;6236.906446403307;6114.175715401326;6326.49388048955;6326.905096423558;6330.588511746721;6340.936590634127;5005.874853128701;6107.977837958671;6111.652512877656;6242.843928901813;6263.749450022039;4756.6432517561325;6230.563860529719;6255.593386429868;6260.686965651699;6277.937220627735;4874.293227481995;4883.8290659826735;4892.290617860462;4897.363342765418;4932.605391568666;3751.868684596026;4346.47842258931;4364.258076127066;4425.35832304314;4463;5579.832605021856;5635.633683810539;5666.34836993751;5668.858278543069;5697.487226149667;6333.778317758856;6343.175387199727;6356.45970092538;6359.268684101387;6368;5569.554435645138;5652;5655.4344565543115;5658.773649054074;5759.769609215668;5354.759035843318;5373.785048598091;5377.139657654835;5380.7309634518115;5396.541293990055;6296.685165741603;6333.936660633427;6334.683265836782;6343.429091381798;6361.777337793155;5215.530602245816;6171.84570385744;6237.656928868956;6277.30949595535;6279.466245369194;6231.22109736283;6333.050042493663;6374.936250637435;6394.584352017104;6400.263969643551;6204.72078756448;6234.189555357774;6234.501239900887;6237.4698150657705;6242.625442473466;6324.683765811783;6325.114483972339;6338.809835704937;6340.270868850142;6353.745850166127;4257.318828987471;5887.20522729426;5893.793717219876;6055.788047418319;6096.634201947897;6025.548083893813;6079.544034197541;6082.817515474543;6110.541709371726;6115.1438798569125;5867.735951882261;5898.941010590011;5928.318243402064;5929.436703513159;5939.584229103922;5934.821955341346;5990.191324171181;6035.185249991195;6051.485623721856;6060.484858787053;5951.434613711691;5953.791617293374;5970.373110823475;5990.011648078018;5990.550708696952 04:41:05 INFO - PROCESS | 1677 | |1;ext.html;458.0175523502088;516.7906997665945;540.9648372855767;544.2054600283586;559.7760895641744;29968.400631987348;30578.929737459195;30639.38721225577;30649.84675076627;30664.080077597653;39488.01279967995;40039.59960400395;40109.19781604366;40182.598174018254;40236.59763402365;9569.66506172284;9862.654807081753;9863.210943124568;9878.60485580576;9891.159251463634;9699.75750606237;9820.21438284939;9828.70513884581;9839.114479696826;9856.408615483058;8310.626021829003;9875.654352097677;9882.407055576652;9884.654037108703;9901.158401535879;9776.560054797552;9828.11546960777;9845.409275443497;9853.802923941517;9856.704298871045;9686.031396860328;9808.117269445713;9825.4104753715;9829.950850245774;9841.55712992917;39899.813024306655;40436.59563404358;40443.988900277436;40500;40502.784916452256;3137.1216059503377;3293.061477478907;3548.8935331940083;3559.2169722660974;3996.8201430935387;28747;29597;29636;29874.85062574673;30206.54690179649;2752.628395166647;2785.3036740814796;2801.4117035422382;2878.8111759775;2979.8510074496407;481877;482565;482895;483185;483675;55305.446945530835;56393.59016024632;64404;65285;66486.34325112165;61819;62452.75094498085;62601;62644;62874;15374.692506150039;16549.91725041367;16742.4140155094;16758.832411675972;16773.91613041927;11566.016888564398;11601.419929003516;12823.871761282267;12981.545645902537;12983;16466.42367517155;20149.798502014793;20246.49383765388;20553.58892822135;20561.29896618623;8612.354073444516;8740;8755.723511886956;8776.824463510695;8829.69096081634;860.2857983063445;911.521451238092;919.6965001549472;958.9664361747306;979.7060881735451;28100.01649942242;29022.709772902424;29127.708722912925;29263.828093911743;29685.109446716633;1056.7199692081604;1076.9515371808131;1079.282277285612;1086.8261078227445;1163.4182908545727;10960.780784384267;14684.3392047356;14849;15198.696026079417;15258.618534536503;534834.3258283683;540848.2957585265;542406;542860;543323;58416;58652;58741.41258587445;58875.70562147247;59015.40984590185;1443.4154167562153;1448.2613866927732;1469.8971072025283;1484.2875419798556;1484.9777253341208;24106.517869642157;28626.42747145004;29193.270168245963;29289.974850880968;29325;50172.749136255545;50634.74682626563;50684.493155067976;50688.98622027465;51049.447527622724;508894;517732;645899;650344;651101;25244.86398112126;31363.686363136076;31603;31625.20936976594;31837.044888653378;44944.10111797811;45248.32127518156;45469;45981.540184599064;46744;37340.626593733716;37698.81150594229;38155;38574.035649109;38606.80696596499;36690;37023.261394483896;38048.80975595104;38069;38138.23723525569;36807.81596092109;37559.81220093882;37699.81150094232;37736.86789396322;38001.61998379981;29996.70003299939;33048.50427243545;33085.67657293681;33087.338253235284;33114.50328245127;24448.388790280384;24622.876885615457;24705.50588988174;25177.49645007053;25243.990240390915 04:41:05 INFO - PROCESS | 1677 | |2;jquery.html;362.1688225522426;364.2478282346954;365.5631520333203;370.405499173826;372.3093661258364;15185.54443366698;15673.451429199951;18929.05354732263;19512.609747805036;20215.898920505377;15672.84327156728;16121;18944.431667049976;19215;21230.36308910731;5198.350206224222;5229.712365819888;5296.09966305727;5343.599230057742;5351.063563876325;3909.4135879618143;4063.79681015948;4077.938830917539;5270.209468579706;5683.97688416087;5882.588218824684;5912.704364781744;5923.378045305224;5927.555433342495;6280.497560195174;6273.153124328226;6420.903686444707;6435.452986496153;6439.678016099199;6441.774537891175;5438.8912221755345;5536.114221724505;5611.0741727614895;5611.186377975171;5618.8314350569135;12810.935945320214;12947.5468358607;13041.347932603427;13091.47634094635;13093.803592946113;2262.3552287597954;2271.5570463759573;2283.4633861042644;2469.6172093325563;2499.662545556345;9270.814583708288;9544.04559544047;9597.760055998657;9892.95053524735;9976.700698979042;1717.9656406871793;1728.9913550432293;1739.808621051696;1742.033171589767;1752.5180575341883;96870;98411;98711.51932721015;99310;99918.00081999159;8849.292056635453;10627.84058239127;10963.397013164193;10977.83533247002;10987.450627468754;13109.41007654658;13118.147320424332;13195.60413187606;13216.281883355294;13229.73540529184;6841.281665425158;8419.663213471393;8434.493930364199;8506.872396914052;8520.531370774666;8558.229759321692;8654.524001179869;8701.651933922572;8733.03936566977;8829.558522074;4106.691998100095;4396.868093957187;4488.349189367589;4506.459224893034;4520.864374068783;1532.1190315568592;1743.3462451580658;1795.533161378025;1795.8832675876026;1801.3792277522014;823.5882058970515;944.0606596436452;961.3462845265286;1009.6769033909226;1059.4543809937888;20397.796022039885;21075;21123.471913201985;21185.68221476679;21213.89393053025;856.208007592974;962.1244667352676;969.3311614985637;989.9059589339001;1012.5291739341094;10153.136983356497;10234.692959211236;10419.791604168026;10435.739106522245;10436.112930401001;591709;724374;731482;747008;747098;113697.29454058196;114275.285870712;114372.42813785878;117211.41394292974;118490;1150.5915400033034;1192.3680449361852;1207.2454715802623;1208.0275378320537;1223.8470191226097;14086.577402677936;14530.854691453373;17950.820491794915;18022.2791088355;18038.368657097464;51893;51961.48038519567;52000.73999629977;52037.47962520326;52519.21221181609;65363.346366537626;66587.66706166438;72768.63615681887;73874.89187662082;74598.79413264428;7461;7754.728584499516;7762.8447431049935;7792.2986931176465;7798.376129909707;10739.248252622241;11005.889941100486;11643.184977051864;11866.762664746484;11897.583584574499;6602.075709400784;9373.578188981648;9767.21862251004;10126.696199114038;10685;9012.369134160546;10073.345232559861;10408.47957602132;10522.21083418762;10604.045635892806;9858.556364963737;10611.151107911503;10924.2899211551;10963.177761667748;10976.957189067025;6473.417392434703;7608.2011388805595;7668;7855.135935047255;7870.5671188082915;8876.20114189726;10231.897681023094;10621.840672389766;10781.407022613832;10856.402897840695 04:41:05 INFO - PROCESS | 1677 | |3;mootools.html;1339.3437215764275;1386.0159286906296;1416.1856932263952;1654.4871089962112;1896.573271014022;7874.842503149934;8060.073091594469;8583.699570515026;8736.781580460492;8759.211670949613;7115.252898445667;8567.78580535487;8719.651213951434;8740.038595754462;8741.519216443108;2176.619091658961;2230.654248591471;2462.9876850615765;2480.553500369933;2486.676732024843;2152.7524334701475;2156.02978659603;2164.7402311722535;2164.8159906407973;2467.259822053386;2449.5468338357373;2473.109680515013;2475.7276699563035;2478.479519300949;2482.962755558668;2126.3514628038442;2462.938426539342;2493.364192131013;2493.7880280176028;2495.70051593809;2430.744771798971;2450.889709963038;2477.578811602032;2478.962815557768;2480.677511923456;8611.440256383315;8698;8707.172818582225;8712.085231050713;8857.645694172226;5385.353757549119;5511.779528818843;5517.393086760453;5555.833325000256;5557.305336832896;3621.149029977953;3630.3465376232266;3664.1022949377575;3723.069232691827;3735.1409175889426;1061.3313612424201;1061.814182518064;1072.2869291920863;1075.231209685071;1081.351189286422;10724.249302548824;10893.67318980424;12053.276803391824;12081.879181208076;12084.274943503418;4455.68557275598;4653.6509761768;4936.950630493649;5003.174476211384;5021.096202683479;10056.949715251378;10144.391336519833;10165;10166.694999150037;10178.694639160836;5513.7794488220825;5522.061249587579;5548.91676624851;5551.72241387929;5554.1391084381985;4917.459079501252;5005.099082165172;5009.348784657971;5055.115354812893;5063.088644044107;3984.4620976168426;3984.6812255019527;3989.261986532501;4028.71798974069;4031.9596804031585;1221.3893053473264;1256.1144393202953;1257.9559715409916;1284.2166278570064;1314.6844757258189;1323.6426164935413;1340.7720687483152;1361.7957306404119;1367.4188469900253;1369.88355989742;7844.176361482077;7989.840203195903;7994.880076798852;7996.960015199887;8007.07918589358;1160.5763896177834;1172.6423440850622;1175.2302242031483;1176.6411244570318;1194.3610168559778;6240.875182496325;6262.373762623702;6329.936700632935;6337.144485494491;6340.682965851689;10252.026057524523;10647.041766241075;10750.516226769814;10766.838497422545;10786.946065269623;10097.24270679702;10613.363198208132;10622.628208012682;10631.096356809603;10643.095336896451;8179.509229446252;8403.991521017517;8405.411621186458;8414.032386275656;8418.326533877153;8036;8084.353251739964;8110.472819266729;8158.8776168356335;8170.877436838571;9487.95256023743;9655.855162172713;9695.806083878142;9763.853542197015;9845.556949937127;9780.902190977999;9950.651727189514;10111.241656875616;10128.594856205964;10130.594776208869;7505.474616776992;7507.519510757287;7541.962290188514;7621.009268795021;7632.236776322546;8083.474574152661;8146.633401497065;8149.714759983609;8155.306798922158;8162.347012239125;7020.5787652741;7235.782926512213;7622.123455802654;7752.573608451589;7909.288164065261;7202.819929501804;7506.3244308012545;7554.055743032121;7632.618369081635;7653.6938522460705;6892.724291028503;7593.506422082547;7669.233076692286;7681.6543255552515;7735.18780528059;6977.7208911642965;7008.649567521706;7033.542819716907;7037.437005039687;7038.788836334918;7116.679749411185;7190.7483238086415;7265.818354541178;7268.454865884974;7282.4902256841515 04:41:05 INFO - PROCESS | 1677 | |4;prototype.html;319.81770390877205;327.65596124069737;330.86269198282713;330.9139623697838;337.61006038026073;6450.7742229022;6606.504512161595;6644.435223006044;6707.195136583605;6756.972908127561;6460.903086453707;6593.736250549972;6602.801915942518;6614.603123812574;6622.73509059637;4843.055604157191;4865.513448655132;4867.707937523742;4880.658353915227;4885.82740142365;4080.8367665293354;4653.6044436222965;4860.708357498562;4875.9756201219125;4883.047805677894;4575.954240457603;4611.769411529427;4665.276882083265;4696.600788932945;4729.85810425686;4765.666403351749;4769.189237829577;4802.06359759847;4827.227643577046;4842.83050093245;4112.136451345221;4120.381942708587;4127.504699436087;4127.958720412787;4129.091599848029;6449.580777249511;6536.901946470807;6560.8359791005605;6582.111414959015;6591.4397276231575;5437.8368648940595;5686.289213848269;5696.17722328855;5787.681677507735;5788.594798364116;7010.158780946268;7017.929820701779;7022.754203602849;7028.2620324866175;7043.894341584881;4592.816287348502;4600.9769951150365;4604.309353596954;4604.424446944132;4606.60843828275;5951.345352011232;7144.3570078693165;7316.231795661432;7372.631368431611;7380.77857664271;4653.441587009513;4657.184992626277;4659.881628409157;4667.043256132485;4672.649551283667;4306.138772245564;4735.668503204743;4740.786664600101;4752.1921273383605;4760.071786001697;5628.099504079328;5643.858903527444;5650.576206784508;5656.8020119295625;5660.830175094754;6663.435062241774;6969.686364113627;6997.755078572225;7001.719931202797;7007.334303241184;1637.2305016642158;1660.7508873669046;1662.8087769906615;1664.0514906503176;1666.30015393535;1055.8680164979378;1065.0840277361463;1077.2620754783;1084.322298563398;1084.5878566144972;6546.279909209983;6572.572782769104;6573.769918052845;6574.276829548746;6579.157835805982;7247.9637601811655;7329.74345897891;7334.816629584197;7348.5958272294465;7351.41188704913;6385.744570217233;6499.805005849832;6524.249711283168;6560.86878262432;6613.735450582019;3894.084890050836;3896.980515097463;3936;3937.350337194388;3954.7824869632445;6153.292371377349;7429.925700742923;7738.148803631596;7742.8838567421535;7744.535327880345;7650.234976502416;7650.96174519135;7653.081630204411;7656.234376562299;7658.846823063507;6161.44546990773;7675.731349402744;7676.692932282646;7681;7689.88465173034;7190.712371505081;7375.668094935633;7402.703891844266;7413.406927445683;7426.14599321085;7268.89096663561;7270.7097264361555;7286.963565182352;7290.56256624583;7291.4166866649475;5700.543956483554;7654;7655.808604784702;7681.807954800951;7685.692572297269;3898.6881049515405;4595.080983803319;4710.340552322609;4737.952620473889;4745.240761478147;7390.445716571171;7392;7394.926050739424;7401.666924988496;7404.407647388089;7082.504224704221;7084.504084714021;7087.893681594677;7088.397486213729;7090.716371345088;6866.34769696878;7087.433005359662;7106.289371062852;7128.215896251512;7141.285871412817;6939.930600694131;6948.374646281859;6953.443724502129;6953.548019378724;6968.059311993019;6194;6317.957537006342;7114.715411383487;7144.1784194818265;7167.996480492631;6987.9301206987275;6991.2309645937885;6992.265812089658;6999.09011828459;6999.370056694922 04:41:05 INFO - PROCESS | 1677 | |5;yui.html;589.6462122726364;636.9108324834524;722.3246264742467;758.5865703191756;764.632976171438;13784.966127540449;14810.55568332949;14972.625684357896;15004.549863504086;15013.174275414862;12312.753744925096;13854.445822167101;13855.030147889653;13872.722545549082;13888.027838051341;682.8497730499282;692.9341712537301;694.0352909455835;694.2294053600499;834.5535138700797;804.7263930263709;839.9874001889976;849.5794581682076;852.8018134521008;854.3037424499045;882.9823403531925;893.2184338703635;894.025512191711;894.2488309819751;906.0214967834722;710.5452510393327;719.7660760252938;724.080417869303;893.6738090596917;896.3187977137358;604.6432604763211;632.5414074795782;650.7266947881901;660.3231687520282;665.963372014539;14449.988500804948;14852.777208341884;14861.331240094221;14862.628434289121;14868.925655371762;12608;12616;12784.61646150617;12901;12903.935480322632;9982.600695972153;10106.646267380607;10187.185025198041;10230.846537301946;10234.539445724886;3518.542589463379;3541.6281290464644;3548.361294966905;3550.786952782841;3554.48459973305;76888;79179.20820791776;81141.59429202875;81560;81856;9387.436753794795;9454.716358509255;9566.378185418065;9755.414675119515;9778.902210977942;21268.468288292916;21282.680759788615;21304;21311.46721331948;21335.359939201848;7255.129384473897;7421.666025028887;7443.9627801861725;7537.472376933562;7615.809604759926;4123.814428350732;4165.062860856344;4171.270027745132;4171.8957026074595;4178.979105104455;3476.217850983559;3514.841832117561;3520.383932811748;3526.717862570988;3530.2586456843837;628.6385328436077;629.3580547841176;634.5082561015158;639.667372966055;657.6744511466759;604.9304330002018;614.4163045107166;631.1605564599164;637.6333608175318;643.707113263464;8422.915770842335;8627.95686021566;8674.522901240367;8849.380543361904;8917.910820891837;500.5170010939461;597.474222684044;601.8525461262019;619.2414292491661;647.139304724715;3891.9610803892165;4112.424260603518;4165.66674666026;4170.812313445902;4254.659627229814;86726.56636716776;94168;96156.51921740346;96297;96335.51832240933;73643;74110.6294468535;74740.50518989698;74838.25161748422;75677.62161189268;69128;70177.92953810275;70479;71134.28865711381;71873.92189117167;9043;9072.682456114004;9080.909190908007;9098.135677110664;9138.497382644018;42041.78979105085;47976.80057998578;49720.592897907474;50797.23804142867;52206.738966306446;51365;67640.98538521827;68018.65990670015;72836;73693;10736.830567333205;10860.67417977462;11039.72400689957;11548.480318385526;12030.338331391857;12109.51561937548;12295.323757193082;12419.813702794285;12439.502419903465;12617.684557886127;11594.652160434864;11651.650450486499;11689.064874810165;11771.058315334923;11782.11634127461;11331.206815523165;11358;11365.60604184722;11759.882401175879;11790;11293.71765705831;11657.242279251821;11708.12189085839;11871.881281187423;11887.76224475523;9265.258779297505;9416.764580885532;9570.56932438028;9584.089511496397;9656.75858103553;9868.753281167741;10006.249531285037;10006.749831253986;10010.399376037461;10014.849777253492 04:41:05 INFO - PROCESS | 1677 | __end_tp_report 04:41:05 INFO - PROCESS | 1677 | __start_cc_report 04:41:05 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1329 04:41:05 INFO - PROCESS | 1677 | __end_cc_report 04:41:05 INFO - PROCESS | 1677 | __startTimestamp1454071265738__endTimestamp 04:41:05 INFO - PROCESS | 1677 | 04:41:05 INFO - PROCESS | 1677 | ------- Summary: start ------- 04:41:05 INFO - PROCESS | 1677 | Number of tests: 6 04:41:05 INFO - PROCESS | 1677 | 04:41:05 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5704.79 Median:5887.21 stddev:669.92 (11.4%) stddev-sans-first:641.13 04:41:05 INFO - PROCESS | 1677 | Values: 3143.3 3524.4 3542.9 3560.5 3605.8 5607.1 5700.2 5708.1 5722.5 5731.8 5642.9 5720.7 5736.1 5841.9 5854.6 5137.1 5140.6 5171.1 5182.5 5217.0 5235.6 5288.8 5297.9 5302.7 5327.4 5115.4 5146.0 5196.9 5237.4 5252.0 5195.1 5223.3 5235.3 5249.0 5266.0 5134.0 5187.3 5192.9 5205.1 5211.9 5497.1 5632.3 5642.0 5667.2 5672.9 5201.6 6140.8 6166.5 6199.6 6303.7 4631.3 6333.0 6337.9 6342.4 6354.5 5673.7 5786.9 5794.4 5804.2 5804.4 6265.3 6305.5 6356.7 6394.4 6404.1 6189.7 6213.0 6221.0 6235.8 6236.9 6114.2 6326.5 6326.9 6330.6 6340.9 5005.9 6108.0 6111.7 6242.8 6263.7 4756.6 6230.6 6255.6 6260.7 6277.9 4874.3 4883.8 4892.3 4897.4 4932.6 3751.9 4346.5 4364.3 4425.4 4463.0 5579.8 5635.6 5666.3 5668.9 5697.5 6333.8 6343.2 6356.5 6359.3 6368.0 5569.6 5652.0 5655.4 5658.8 5759.8 5354.8 5373.8 5377.1 5380.7 5396.5 6296.7 6333.9 6334.7 6343.4 6361.8 5215.5 6171.8 6237.7 6277.3 6279.5 6231.2 6333.1 6374.9 6394.6 6400.3 6204.7 6234.2 6234.5 6237.5 6242.6 6324.7 6325.1 6338.8 6340.3 6353.7 4257.3 5887.2 5893.8 6055.8 6096.6 6025.5 6079.5 6082.8 6110.5 6115.1 5867.7 5898.9 5928.3 5929.4 5939.6 5934.8 5990.2 6035.2 6051.5 6060.5 5951.4 5953.8 5970.4 5990.0 5990.6 04:41:05 INFO - PROCESS | 1677 | 04:41:05 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:67406.73 Median:21948.32 stddev:144863.14 (660.0%) stddev-sans-first:145182.31 04:41:05 INFO - PROCESS | 1677 | Values: 458.0 516.8 541.0 544.2 559.8 29968.4 30578.9 30639.4 30649.8 30664.1 39488.0 40039.6 40109.2 40182.6 40236.6 9569.7 9862.7 9863.2 9878.6 9891.2 9699.8 9820.2 9828.7 9839.1 9856.4 8310.6 9875.7 9882.4 9884.7 9901.2 9776.6 9828.1 9845.4 9853.8 9856.7 9686.0 9808.1 9825.4 9830.0 9841.6 39899.8 40436.6 40444.0 40500.0 40502.8 3137.1 3293.1 3548.9 3559.2 3996.8 28747.0 29597.0 29636.0 29874.9 30206.5 2752.6 2785.3 2801.4 2878.8 2979.9 481877.0 482565.0 482895.0 483185.0 483675.0 55305.4 56393.6 64404.0 65285.0 66486.3 61819.0 62452.8 62601.0 62644.0 62874.0 15374.7 16549.9 16742.4 16758.8 16773.9 11566.0 11601.4 12823.9 12981.5 12983.0 16466.4 20149.8 20246.5 20553.6 20561.3 8612.4 8740.0 8755.7 8776.8 8829.7 860.3 911.5 919.7 959.0 979.7 28100.0 29022.7 29127.7 29263.8 29685.1 1056.7 1077.0 1079.3 1086.8 1163.4 10960.8 14684.3 14849.0 15198.7 15258.6 534834.3 540848.3 542406.0 542860.0 543323.0 58416.0 58652.0 58741.4 58875.7 59015.4 1443.4 1448.3 1469.9 1484.3 1485.0 24106.5 28626.4 29193.3 29290.0 29325.0 50172.7 50634.7 50684.5 50689.0 51049.4 508894.0 517732.0 645899.0 650344.0 651101.0 25244.9 31363.7 31603.0 31625.2 31837.0 44944.1 45248.3 45469.0 45981.5 46744.0 37340.6 37698.8 38155.0 38574.0 38606.8 36690.0 37023.3 38048.8 38069.0 38138.2 36807.8 37559.8 37699.8 37736.9 38001.6 29996.7 33048.5 33085.7 33087.3 33114.5 24448.4 24622.9 24705.5 25177.5 25244.0 04:41:05 INFO - PROCESS | 1677 | 04:41:05 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:36139.46 Median:2140.86 stddev:117235.49 (5476.1%) stddev-sans-first:117533.58 04:41:05 INFO - PROCESS | 1677 | Values: 362.2 364.2 365.6 370.4 372.3 15185.5 15673.5 18929.1 19512.6 20215.9 15672.8 16121.0 18944.4 19215.0 21230.4 5198.4 5229.7 5296.1 5343.6 5351.1 3909.4 4063.8 4077.9 5270.2 5684.0 5882.6 5912.7 5923.4 5927.6 6280.5 6273.2 6420.9 6435.5 6439.7 6441.8 5438.9 5536.1 5611.1 5611.2 5618.8 12810.9 12947.5 13041.3 13091.5 13093.8 2262.4 2271.6 2283.5 2469.6 2499.7 9270.8 9544.0 9597.8 9893.0 9976.7 1718.0 1729.0 1739.8 1742.0 1752.5 96870.0 98411.0 98711.5 99310.0 99918.0 8849.3 10627.8 10963.4 10977.8 10987.5 13109.4 13118.1 13195.6 13216.3 13229.7 6841.3 8419.7 8434.5 8506.9 8520.5 8558.2 8654.5 8701.7 8733.0 8829.6 4106.7 4396.9 4488.3 4506.5 4520.9 1532.1 1743.3 1795.5 1795.9 1801.4 823.6 944.1 961.3 1009.7 1059.5 20397.8 21075.0 21123.5 21185.7 21213.9 856.2 962.1 969.3 989.9 1012.5 10153.1 10234.7 10419.8 10435.7 10436.1 591709.0 724374.0 731482.0 747008.0 747098.0 113697.3 114275.3 114372.4 117211.4 118490.0 1150.6 1192.4 1207.2 1208.0 1223.8 14086.6 14530.9 17950.8 18022.3 18038.4 51893.0 51961.5 52000.7 52037.5 52519.2 65363.3 66587.7 72768.6 73874.9 74598.8 7461.0 7754.7 7762.8 7792.3 7798.4 10739.2 11005.9 11643.2 11866.8 11897.6 6602.1 9373.6 9767.2 10126.7 10685.0 9012.4 10073.3 10408.5 10522.2 10604.0 9858.6 10611.2 10924.3 10963.2 10977.0 6473.4 7608.2 7668.0 7855.1 7870.6 8876.2 10231.9 10621.8 10781.4 10856.4 04:41:05 INFO - PROCESS | 1677 | 04:41:05 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:6060.88 Median:5038.11 stddev:3168.73 (62.9%) stddev-sans-first:3157.74 04:41:05 INFO - PROCESS | 1677 | Values: 1339.3 1386.0 1416.2 1654.5 1896.6 7874.8 8060.1 8583.7 8736.8 8759.2 7115.3 8567.8 8719.7 8740.0 8741.5 2176.6 2230.7 2463.0 2480.6 2486.7 2152.8 2156.0 2164.7 2164.8 2467.3 2449.5 2473.1 2475.7 2478.5 2483.0 2126.4 2462.9 2493.4 2493.8 2495.7 2430.7 2450.9 2477.6 2479.0 2480.7 8611.4 8698.0 8707.2 8712.1 8857.6 5385.4 5511.8 5517.4 5555.8 5557.3 3621.1 3630.3 3664.1 3723.1 3735.1 1061.3 1061.8 1072.3 1075.2 1081.4 10724.2 10893.7 12053.3 12081.9 12084.3 4455.7 4653.7 4937.0 5003.2 5021.1 10056.9 10144.4 10165.0 10166.7 10178.7 5513.8 5522.1 5548.9 5551.7 5554.1 4917.5 5005.1 5009.3 5055.1 5063.1 3984.5 3984.7 3989.3 4028.7 4032.0 1221.4 1256.1 1258.0 1284.2 1314.7 1323.6 1340.8 1361.8 1367.4 1369.9 7844.2 7989.8 7994.9 7997.0 8007.1 1160.6 1172.6 1175.2 1176.6 1194.4 6240.9 6262.4 6329.9 6337.1 6340.7 10252.0 10647.0 10750.5 10766.8 10786.9 10097.2 10613.4 10622.6 10631.1 10643.1 8179.5 8404.0 8405.4 8414.0 8418.3 8036.0 8084.4 8110.5 8158.9 8170.9 9488.0 9655.9 9695.8 9763.9 9845.6 9780.9 9950.7 10111.2 10128.6 10130.6 7505.5 7507.5 7542.0 7621.0 7632.2 8083.5 8146.6 8149.7 8155.3 8162.3 7020.6 7235.8 7622.1 7752.6 7909.3 7202.8 7506.3 7554.1 7632.6 7653.7 6892.7 7593.5 7669.2 7681.7 7735.2 6977.7 7008.6 7033.5 7037.4 7038.8 7116.7 7190.7 7265.8 7268.5 7282.5 04:41:05 INFO - PROCESS | 1677 | 04:41:05 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5767.74 Median:6566.72 stddev:1848.18 (28.1%) stddev-sans-first:1807.56 04:41:05 INFO - PROCESS | 1677 | Values: 319.8 327.7 330.9 330.9 337.6 6450.8 6606.5 6644.4 6707.2 6757.0 6460.9 6593.7 6602.8 6614.6 6622.7 4843.1 4865.5 4867.7 4880.7 4885.8 4080.8 4653.6 4860.7 4876.0 4883.0 4576.0 4611.8 4665.3 4696.6 4729.9 4765.7 4769.2 4802.1 4827.2 4842.8 4112.1 4120.4 4127.5 4128.0 4129.1 6449.6 6536.9 6560.8 6582.1 6591.4 5437.8 5686.3 5696.2 5787.7 5788.6 7010.2 7017.9 7022.8 7028.3 7043.9 4592.8 4601.0 4604.3 4604.4 4606.6 5951.3 7144.4 7316.2 7372.6 7380.8 4653.4 4657.2 4659.9 4667.0 4672.6 4306.1 4735.7 4740.8 4752.2 4760.1 5628.1 5643.9 5650.6 5656.8 5660.8 6663.4 6969.7 6997.8 7001.7 7007.3 1637.2 1660.8 1662.8 1664.1 1666.3 1055.9 1065.1 1077.3 1084.3 1084.6 6546.3 6572.6 6573.8 6574.3 6579.2 7248.0 7329.7 7334.8 7348.6 7351.4 6385.7 6499.8 6524.2 6560.9 6613.7 3894.1 3897.0 3936.0 3937.4 3954.8 6153.3 7429.9 7738.1 7742.9 7744.5 7650.2 7651.0 7653.1 7656.2 7658.8 6161.4 7675.7 7676.7 7681.0 7689.9 7190.7 7375.7 7402.7 7413.4 7426.1 7268.9 7270.7 7287.0 7290.6 7291.4 5700.5 7654.0 7655.8 7681.8 7685.7 3898.7 4595.1 4710.3 4738.0 4745.2 7390.4 7392.0 7394.9 7401.7 7404.4 7082.5 7084.5 7087.9 7088.4 7090.7 6866.3 7087.4 7106.3 7128.2 7141.3 6939.9 6948.4 6953.4 6953.5 6968.1 6194.0 6318.0 7114.7 7144.2 7168.0 6987.9 6991.2 6992.3 6999.1 6999.4 04:41:05 INFO - PROCESS | 1677 | 04:41:05 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:18232.01 Median:616.83 stddev:25516.61 (4136.7%) stddev-sans-first:25553.80 04:41:05 INFO - PROCESS | 1677 | Values: 589.6 636.9 722.3 758.6 764.6 13785.0 14810.6 14972.6 15004.5 15013.2 12312.8 13854.4 13855.0 13872.7 13888.0 682.8 692.9 694.0 694.2 834.6 804.7 840.0 849.6 852.8 854.3 883.0 893.2 894.0 894.2 906.0 710.5 719.8 724.1 893.7 896.3 604.6 632.5 650.7 660.3 666.0 14450.0 14852.8 14861.3 14862.6 14868.9 12608.0 12616.0 12784.6 12901.0 12903.9 9982.6 10106.6 10187.2 10230.8 10234.5 3518.5 3541.6 3548.4 3550.8 3554.5 76888.0 79179.2 81141.6 81560.0 81856.0 9387.4 9454.7 9566.4 9755.4 9778.9 21268.5 21282.7 21304.0 21311.5 21335.4 7255.1 7421.7 7444.0 7537.5 7615.8 4123.8 4165.1 4171.3 4171.9 4179.0 3476.2 3514.8 3520.4 3526.7 3530.3 628.6 629.4 634.5 639.7 657.7 604.9 614.4 631.2 637.6 643.7 8422.9 8628.0 8674.5 8849.4 8917.9 500.5 597.5 601.9 619.2 647.1 3892.0 4112.4 4165.7 4170.8 4254.7 86726.6 94168.0 96156.5 96297.0 96335.5 73643.0 74110.6 74740.5 74838.3 75677.6 69128.0 70177.9 70479.0 71134.3 71873.9 9043.0 9072.7 9080.9 9098.1 9138.5 42041.8 47976.8 49720.6 50797.2 52206.7 51365.0 67641.0 68018.7 72836.0 73693.0 10736.8 10860.7 11039.7 11548.5 12030.3 12109.5 12295.3 12419.8 12439.5 12617.7 11594.7 11651.7 11689.1 11771.1 11782.1 11331.2 11358.0 11365.6 11759.9 11790.0 11293.7 11657.2 11708.1 11871.9 11887.8 9265.3 9416.8 9570.6 9584.1 9656.8 9868.8 10006.2 10006.7 10010.4 10014.8 04:41:05 INFO - PROCESS | 1677 | -------- Summary: end -------- 04:41:05 INFO - PROCESS | 1677 | 04:41:06 INFO - TEST-INFO | 1677: exit 0 04:41:06 INFO - TEST-OK | dromaeo_css | took 1114166ms 04:41:06 INFO - TEST-START | kraken 04:41:06 INFO - operating with platform_type : mac_ 04:41:06 INFO - Initialising browser for kraken test... 04:41:06 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpRVLiP9/profile http://localhost:49278/getInfo.html) 04:41:08 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 04:41:08 INFO - PROCESS | 1684 | colorDepth:24 04:41:08 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 04:41:08 INFO - PROCESS | 1684 | __metrics 04:41:08 INFO - PROCESS | 1684 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:41:08 INFO - PROCESS | 1684 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:41:08 INFO - PROCESS | 1684 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:41:09 INFO - TEST-INFO | 1684: exit 0 04:41:09 INFO - Browser initialized. 04:41:09 INFO - Running cycle 1/1 for kraken test... 04:41:09 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpRVLiP9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:21 INFO - PROCESS | 1686 | RSS: Main: 243671040 04:41:21 INFO - PROCESS | 1686 | 04:41:23 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 04:41:24 INFO - PROCESS | 1686 | RSS: Main: 289370112 04:41:24 INFO - PROCESS | 1686 | 04:41:27 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 04:41:27 INFO - PROCESS | 1686 | RSS: Main: 300830720 04:41:27 INFO - PROCESS | 1686 | 04:41:30 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 04:41:31 INFO - PROCESS | 1686 | RSS: Main: 285921280 04:41:31 INFO - PROCESS | 1686 | 04:41:33 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 04:41:34 INFO - PROCESS | 1686 | RSS: Main: 287985664 04:41:34 INFO - PROCESS | 1686 | 04:41:36 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:36 INFO - PROCESS | 1686 | RSS: Main: 291475456 04:41:36 INFO - PROCESS | 1686 | 04:41:39 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:40 INFO - PROCESS | 1686 | RSS: Main: 289738752 04:41:40 INFO - PROCESS | 1686 | 04:41:43 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:43 INFO - PROCESS | 1686 | RSS: Main: 290017280 04:41:43 INFO - PROCESS | 1686 | 04:41:46 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 04:41:46 INFO - PROCESS | 1686 | RSS: Main: 290213888 04:41:46 INFO - PROCESS | 1686 | 04:41:48 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:49 INFO - PROCESS | 1686 | RSS: Main: 325419008 04:41:49 INFO - PROCESS | 1686 | 04:41:50 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:51 INFO - PROCESS | 1686 | RSS: Main: 325681152 04:41:51 INFO - PROCESS | 1686 | 04:41:53 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:54 INFO - PROCESS | 1686 | RSS: Main: 332455936 04:41:54 INFO - PROCESS | 1686 | 04:41:56 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:57 INFO - PROCESS | 1686 | RSS: Main: 333737984 04:41:57 INFO - PROCESS | 1686 | 04:41:59 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:00 INFO - PROCESS | 1686 | RSS: Main: 334471168 04:42:00 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 04:42:02 INFO - PROCESS | 1686 | RSS: Main: 395010048 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | __start_tp_report 04:42:02 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 04:42:02 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 04:42:02 INFO - PROCESS | 1686 | |i|pagename|runs| 04:42:02 INFO - PROCESS | 1686 | |0;ai-astar;110;107;110;109;110;110;114;110;120;166 04:42:02 INFO - PROCESS | 1686 | |1;audio-beat-detection;186;124;144;155;117;142;137;132;177;145 04:42:02 INFO - PROCESS | 1686 | |2;audio-dft;183;186;183;181;184;184;186;182;180;183 04:42:02 INFO - PROCESS | 1686 | |3;audio-fft;78;73;88;82;73;81;86;101;77;55 04:42:02 INFO - PROCESS | 1686 | |4;audio-oscillator;92;129;160;105;78;82;117;97;115;113 04:42:02 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;87;92;86;92;85;91;86;91;88;92 04:42:02 INFO - PROCESS | 1686 | |6;imaging-darkroom;95;95;96;95;96;95;95;95;95;95 04:42:02 INFO - PROCESS | 1686 | |7;imaging-desaturate;84;86;87;83;83;85;85;85;85;85 04:42:02 INFO - PROCESS | 1686 | |8;json-parse-financial;54;55;56;52;51;43;47;64;80;42 04:42:02 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;63;62;72;75;69;67;65;66;66;67 04:42:02 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;84;83;83;81;82;83;83;82;82;84 04:42:02 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;123;123;119;123;118;125;123;120;125;135 04:42:02 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;140;126;139;133;135;106;148;172;150;137 04:42:02 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;67;67;65;66;66;66;65;65;65;66 04:42:02 INFO - PROCESS | 1686 | __end_tp_report 04:42:02 INFO - PROCESS | 1686 | __start_cc_report 04:42:02 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,1168 04:42:02 INFO - PROCESS | 1686 | __end_cc_report 04:42:02 INFO - PROCESS | 1686 | __startTimestamp1454071322284__endTimestamp 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | ------- Summary: start ------- 04:42:02 INFO - PROCESS | 1686 | Number of tests: 14 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:116.60 Median:110.00 stddev:17.72 (16.1%) stddev-sans-first:18.63 04:42:02 INFO - PROCESS | 1686 | Values: 110.0 107.0 110.0 109.0 110.0 110.0 114.0 110.0 120.0 166.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:144.50 stddev:21.77 (15.1%) stddev-sans-first:17.60 04:42:02 INFO - PROCESS | 1686 | Values: 186.0 124.0 144.0 155.0 117.0 142.0 137.0 132.0 177.0 145.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.93 (1.1%) stddev-sans-first:2.05 04:42:02 INFO - PROCESS | 1686 | Values: 183.0 186.0 183.0 181.0 184.0 184.0 186.0 182.0 180.0 183.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:79.40 Median:79.50 stddev:11.92 (15.0%) stddev-sans-first:12.63 04:42:02 INFO - PROCESS | 1686 | Values: 78.0 73.0 88.0 82.0 73.0 81.0 86.0 101.0 77.0 55.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:119.00 stddev:24.17 (20.3%) stddev-sans-first:24.85 04:42:02 INFO - PROCESS | 1686 | Values: 92.0 129.0 160.0 105.0 78.0 82.0 117.0 97.0 115.0 113.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:91.00 stddev:2.87 (3.2%) stddev-sans-first:2.95 04:42:02 INFO - PROCESS | 1686 | Values: 87.0 92.0 86.0 92.0 85.0 91.0 86.0 91.0 88.0 92.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:42:02 INFO - PROCESS | 1686 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.23 (1.4%) stddev-sans-first:1.27 04:42:02 INFO - PROCESS | 1686 | Values: 84.0 86.0 87.0 83.0 83.0 85.0 85.0 85.0 85.0 85.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:11.09 (20.3%) stddev-sans-first:11.76 04:42:02 INFO - PROCESS | 1686 | Values: 54.0 55.0 56.0 52.0 51.0 43.0 47.0 64.0 80.0 42.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:3.94 (5.9%) stddev-sans-first:3.87 04:42:02 INFO - PROCESS | 1686 | Values: 63.0 62.0 72.0 75.0 69.0 67.0 65.0 66.0 66.0 67.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:0.95 (1.1%) stddev-sans-first:0.88 04:42:02 INFO - PROCESS | 1686 | Values: 84.0 83.0 83.0 81.0 82.0 83.0 83.0 82.0 82.0 84.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:123.00 stddev:4.72 (3.8%) stddev-sans-first:5.00 04:42:02 INFO - PROCESS | 1686 | Values: 123.0 123.0 119.0 123.0 118.0 125.0 123.0 120.0 125.0 135.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.60 Median:139.50 stddev:17.01 (12.2%) stddev-sans-first:18.04 04:42:02 INFO - PROCESS | 1686 | Values: 140.0 126.0 139.0 133.0 135.0 106.0 148.0 172.0 150.0 137.0 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 04:42:02 INFO - PROCESS | 1686 | Values: 67.0 67.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 66.0 04:42:02 INFO - PROCESS | 1686 | -------- Summary: end -------- 04:42:02 INFO - PROCESS | 1686 | 04:42:02 INFO - TEST-INFO | 1686: exit 0 04:42:02 INFO - TEST-OK | kraken | took 56746ms 04:42:02 INFO - SUITE-END | took 1170s 04:42:03 INFO - Completed test suite (00:19:31) 04:42:03 INFO - Working with test: dromaeo_css 04:42:03 INFO - Generating results file: dromaeo_css 04:42:03 INFO - Working with test: kraken 04:42:03 INFO - Generating results file: kraken 04:42:03 INFO - javascript benchmark 04:42:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:42:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 04:42:03 INFO - process_Request line: dromaeo_css 7477.96 graph.html#tests=[[72,1,59]] 04:42:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:42:03 INFO - process_Request line: kraken 1435.00 graph.html#tests=[[232,1,59]] 04:42:03 INFO - RETURN: dromaeo_css: 7477.96 04:42:03 INFO - RETURN: kraken: 1435.00 04:42:03 INFO - javascript benchmark 04:42:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3143.3084721361297, 3524.400851855186, 3542.875999340022, 3560.483729859172, 3605.8016809075507, 5607.130894711316, 5700.17347484615, 5708.1152421374645, 5722.54219662427, 5731.799387021455, 5642.943570564293, 5720.713964301779, 5736.053551164053, 5841.941580584193, 5854.590178687494, 5137.101007323722, 5140.588752899759, 5171.146760784466, 5182.533571978521, 5217.034848553011, 5235.58115350771, 5288.762005709752, 5297.947020529784, 5302.655327403726, 5327.440618735035, 5115.386153661547, 5146.0479811235045, 5196.8960620787375, 5237.397699264576, 5252.0, 5195.116830138848, 5223.320968274138, 5235.345581802275, 5249.02892964799, 5265.9994601026065, 5133.974330128362, 5187.325647665817, 5192.870178245536, 5205.063088644042, 5211.895762084737, 5497.147942068986, 5632.267805185341, 5642.0, 5667.1782591524, 5672.914906276409, 5201.635885488017, 6140.815775526741, 6166.475849552793, 6199.566030377875, 6303.653299068549, 4631.305304204363, 6332.968335158341, 6337.936620633781, 6342.365763423667, 6354.491640668782, 5673.659580425187, 5786.929418057631, 5794.391588883149, 5804.245448091721, 5804.419558044204, 6265.310815810257, 6305.527085468608, 6356.745730170834, 6394.424501794861, 6404.135441715309, 6189.721462534197, 6213.00591905302, 6221.035739460391, 6235.75056997715, 6236.906446403307, 6114.175715401326, 6326.49388048955, 6326.905096423558, 6330.588511746721, 6340.936590634127, 5005.874853128701, 6107.977837958671, 6111.652512877656, 6242.843928901813, 6263.749450022039, 4756.6432517561325, 6230.563860529719, 6255.593386429868, 6260.686965651699, 6277.937220627735, 4874.293227481995, 4883.8290659826735, 4892.290617860462, 4897.363342765418, 4932.605391568666, 3751.868684596026, 4346.47842258931, 4364.258076127066, 4425.35832304314, 4463.0, 5579.832605021856, 5635.633683810539, 5666.34836993751, 5668.858278543069, 5697.487226149667, 6333.778317758856, 6343.175387199727, 6356.45970092538, 6359.268684101387, 6368.0, 5569.554435645138, 5652.0, 5655.4344565543115, 5658.773649054074, 5759.769609215668, 5354.759035843318, 5373.785048598091, 5377.139657654835, 5380.7309634518115, 5396.541293990055, 6296.685165741603, 6333.936660633427, 6334.683265836782, 6343.429091381798, 6361.777337793155, 5215.530602245816, 6171.84570385744, 6237.656928868956, 6277.30949595535, 6279.466245369194, 6231.22109736283, 6333.050042493663, 6374.936250637435, 6394.584352017104, 6400.263969643551, 6204.72078756448, 6234.189555357774, 6234.501239900887, 6237.4698150657705, 6242.625442473466, 6324.683765811783, 6325.114483972339, 6338.809835704937, 6340.270868850142, 6353.745850166127, 4257.318828987471, 5887.20522729426, 5893.793717219876, 6055.788047418319, 6096.634201947897, 6025.548083893813, 6079.544034197541, 6082.817515474543, 6110.541709371726, 6115.1438798569125, 5867.735951882261, 5898.941010590011, 5928.318243402064, 5929.436703513159, 5939.584229103922, 5934.821955341346, 5990.191324171181, 6035.185249991195, 6051.485623721856, 6060.484858787053, 5951.434613711691, 5953.791617293374, 5970.373110823475, 5990.011648078018, 5990.550708696952], "unit": "score", "name": "dojo.html", "value": 5665.323459298147}, {"lowerIsBetter": false, "replicates": [458.0175523502088, 516.7906997665945, 540.9648372855767, 544.2054600283586, 559.7760895641744, 29968.400631987348, 30578.929737459195, 30639.38721225577, 30649.84675076627, 30664.080077597653, 39488.01279967995, 40039.59960400395, 40109.19781604366, 40182.598174018254, 40236.59763402365, 9569.66506172284, 9862.654807081753, 9863.210943124568, 9878.60485580576, 9891.159251463634, 9699.75750606237, 9820.21438284939, 9828.70513884581, 9839.114479696826, 9856.408615483058, 8310.626021829003, 9875.654352097677, 9882.407055576652, 9884.654037108703, 9901.158401535879, 9776.560054797552, 9828.11546960777, 9845.409275443497, 9853.802923941517, 9856.704298871045, 9686.031396860328, 9808.117269445713, 9825.4104753715, 9829.950850245774, 9841.55712992917, 39899.813024306655, 40436.59563404358, 40443.988900277436, 40500.0, 40502.784916452256, 3137.1216059503377, 3293.061477478907, 3548.8935331940083, 3559.2169722660974, 3996.8201430935387, 28747.0, 29597.0, 29636.0, 29874.85062574673, 30206.54690179649, 2752.628395166647, 2785.3036740814796, 2801.4117035422382, 2878.8111759775, 2979.8510074496407, 481877.0, 482565.0, 482895.0, 483185.0, 483675.0, 55305.446945530835, 56393.59016024632, 64404.0, 65285.0, 66486.34325112165, 61819.0, 62452.75094498085, 62601.0, 62644.0, 62874.0, 15374.692506150039, 16549.91725041367, 16742.4140155094, 16758.832411675972, 16773.91613041927, 11566.016888564398, 11601.419929003516, 12823.871761282267, 12981.545645902537, 12983.0, 16466.42367517155, 20149.798502014793, 20246.49383765388, 20553.58892822135, 20561.29896618623, 8612.354073444516, 8740.0, 8755.723511886956, 8776.824463510695, 8829.69096081634, 860.2857983063445, 911.521451238092, 919.6965001549472, 958.9664361747306, 979.7060881735451, 28100.01649942242, 29022.709772902424, 29127.708722912925, 29263.828093911743, 29685.109446716633, 1056.7199692081604, 1076.9515371808131, 1079.282277285612, 1086.8261078227445, 1163.4182908545727, 10960.780784384267, 14684.3392047356, 14849.0, 15198.696026079417, 15258.618534536503, 534834.3258283683, 540848.2957585265, 542406.0, 542860.0, 543323.0, 58416.0, 58652.0, 58741.41258587445, 58875.70562147247, 59015.40984590185, 1443.4154167562153, 1448.2613866927732, 1469.8971072025283, 1484.2875419798556, 1484.9777253341208, 24106.517869642157, 28626.42747145004, 29193.270168245963, 29289.974850880968, 29325.0, 50172.749136255545, 50634.74682626563, 50684.493155067976, 50688.98622027465, 51049.447527622724, 508894.0, 517732.0, 645899.0, 650344.0, 651101.0, 25244.86398112126, 31363.686363136076, 31603.0, 31625.20936976594, 31837.044888653378, 44944.10111797811, 45248.32127518156, 45469.0, 45981.540184599064, 46744.0, 37340.626593733716, 37698.81150594229, 38155.0, 38574.035649109, 38606.80696596499, 36690.0, 37023.261394483896, 38048.80975595104, 38069.0, 38138.23723525569, 36807.81596092109, 37559.81220093882, 37699.81150094232, 37736.86789396322, 38001.61998379981, 29996.70003299939, 33048.50427243545, 33085.67657293681, 33087.338253235284, 33114.50328245127, 24448.388790280384, 24622.876885615457, 24705.50588988174, 25177.49645007053, 25243.990240390915], "unit": "score", "name": "ext.html", "value": 19747.082085072747}, {"lowerIsBetter": false, "replicates": [362.1688225522426, 364.2478282346954, 365.5631520333203, 370.405499173826, 372.3093661258364, 15185.54443366698, 15673.451429199951, 18929.05354732263, 19512.609747805036, 20215.898920505377, 15672.84327156728, 16121.0, 18944.431667049976, 19215.0, 21230.36308910731, 5198.350206224222, 5229.712365819888, 5296.09966305727, 5343.599230057742, 5351.063563876325, 3909.4135879618143, 4063.79681015948, 4077.938830917539, 5270.209468579706, 5683.97688416087, 5882.588218824684, 5912.704364781744, 5923.378045305224, 5927.555433342495, 6280.497560195174, 6273.153124328226, 6420.903686444707, 6435.452986496153, 6439.678016099199, 6441.774537891175, 5438.8912221755345, 5536.114221724505, 5611.0741727614895, 5611.186377975171, 5618.8314350569135, 12810.935945320214, 12947.5468358607, 13041.347932603427, 13091.47634094635, 13093.803592946113, 2262.3552287597954, 2271.5570463759573, 2283.4633861042644, 2469.6172093325563, 2499.662545556345, 9270.814583708288, 9544.04559544047, 9597.760055998657, 9892.95053524735, 9976.700698979042, 1717.9656406871793, 1728.9913550432293, 1739.808621051696, 1742.033171589767, 1752.5180575341883, 96870.0, 98411.0, 98711.51932721015, 99310.0, 99918.00081999159, 8849.292056635453, 10627.84058239127, 10963.397013164193, 10977.83533247002, 10987.450627468754, 13109.41007654658, 13118.147320424332, 13195.60413187606, 13216.281883355294, 13229.73540529184, 6841.281665425158, 8419.663213471393, 8434.493930364199, 8506.872396914052, 8520.531370774666, 8558.229759321692, 8654.524001179869, 8701.651933922572, 8733.03936566977, 8829.558522074, 4106.691998100095, 4396.868093957187, 4488.349189367589, 4506.459224893034, 4520.864374068783, 1532.1190315568592, 1743.3462451580658, 1795.533161378025, 1795.8832675876026, 1801.3792277522014, 823.5882058970515, 944.0606596436452, 961.3462845265286, 1009.6769033909226, 1059.4543809937888, 20397.796022039885, 21075.0, 21123.471913201985, 21185.68221476679, 21213.89393053025, 856.208007592974, 962.1244667352676, 969.3311614985637, 989.9059589339001, 1012.5291739341094, 10153.136983356497, 10234.692959211236, 10419.791604168026, 10435.739106522245, 10436.112930401001, 591709.0, 724374.0, 731482.0, 747008.0, 747098.0, 113697.29454058196, 114275.285870712, 114372.42813785878, 117211.41394292974, 118490.0, 1150.5915400033034, 1192.3680449361852, 1207.2454715802623, 1208.0275378320537, 1223.8470191226097, 14086.577402677936, 14530.854691453373, 17950.820491794915, 18022.2791088355, 18038.368657097464, 51893.0, 51961.48038519567, 52000.73999629977, 52037.47962520326, 52519.21221181609, 65363.346366537626, 66587.66706166438, 72768.63615681887, 73874.89187662082, 74598.79413264428, 7461.0, 7754.728584499516, 7762.8447431049935, 7792.2986931176465, 7798.376129909707, 10739.248252622241, 11005.889941100486, 11643.184977051864, 11866.762664746484, 11897.583584574499, 6602.075709400784, 9373.578188981648, 9767.21862251004, 10126.696199114038, 10685.0, 9012.369134160546, 10073.345232559861, 10408.47957602132, 10522.21083418762, 10604.045635892806, 9858.556364963737, 10611.151107911503, 10924.2899211551, 10963.177761667748, 10976.957189067025, 6473.417392434703, 7608.2011388805595, 7668.0, 7855.135935047255, 7870.5671188082915, 8876.20114189726, 10231.897681023094, 10621.840672389766, 10781.407022613832, 10856.402897840695], "unit": "score", "name": "jquery.html", "value": 8959.79994372118}, {"lowerIsBetter": false, "replicates": [1339.3437215764275, 1386.0159286906296, 1416.1856932263952, 1654.4871089962112, 1896.573271014022, 7874.842503149934, 8060.073091594469, 8583.699570515026, 8736.781580460492, 8759.211670949613, 7115.252898445667, 8567.78580535487, 8719.651213951434, 8740.038595754462, 8741.519216443108, 2176.619091658961, 2230.654248591471, 2462.9876850615765, 2480.553500369933, 2486.676732024843, 2152.7524334701475, 2156.02978659603, 2164.7402311722535, 2164.8159906407973, 2467.259822053386, 2449.5468338357373, 2473.109680515013, 2475.7276699563035, 2478.479519300949, 2482.962755558668, 2126.3514628038442, 2462.938426539342, 2493.364192131013, 2493.7880280176028, 2495.70051593809, 2430.744771798971, 2450.889709963038, 2477.578811602032, 2478.962815557768, 2480.677511923456, 8611.440256383315, 8698.0, 8707.172818582225, 8712.085231050713, 8857.645694172226, 5385.353757549119, 5511.779528818843, 5517.393086760453, 5555.833325000256, 5557.305336832896, 3621.149029977953, 3630.3465376232266, 3664.1022949377575, 3723.069232691827, 3735.1409175889426, 1061.3313612424201, 1061.814182518064, 1072.2869291920863, 1075.231209685071, 1081.351189286422, 10724.249302548824, 10893.67318980424, 12053.276803391824, 12081.879181208076, 12084.274943503418, 4455.68557275598, 4653.6509761768, 4936.950630493649, 5003.174476211384, 5021.096202683479, 10056.949715251378, 10144.391336519833, 10165.0, 10166.694999150037, 10178.694639160836, 5513.7794488220825, 5522.061249587579, 5548.91676624851, 5551.72241387929, 5554.1391084381985, 4917.459079501252, 5005.099082165172, 5009.348784657971, 5055.115354812893, 5063.088644044107, 3984.4620976168426, 3984.6812255019527, 3989.261986532501, 4028.71798974069, 4031.9596804031585, 1221.3893053473264, 1256.1144393202953, 1257.9559715409916, 1284.2166278570064, 1314.6844757258189, 1323.6426164935413, 1340.7720687483152, 1361.7957306404119, 1367.4188469900253, 1369.88355989742, 7844.176361482077, 7989.840203195903, 7994.880076798852, 7996.960015199887, 8007.07918589358, 1160.5763896177834, 1172.6423440850622, 1175.2302242031483, 1176.6411244570318, 1194.3610168559778, 6240.875182496325, 6262.373762623702, 6329.936700632935, 6337.144485494491, 6340.682965851689, 10252.026057524523, 10647.041766241075, 10750.516226769814, 10766.838497422545, 10786.946065269623, 10097.24270679702, 10613.363198208132, 10622.628208012682, 10631.096356809603, 10643.095336896451, 8179.509229446252, 8403.991521017517, 8405.411621186458, 8414.032386275656, 8418.326533877153, 8036.0, 8084.353251739964, 8110.472819266729, 8158.8776168356335, 8170.877436838571, 9487.95256023743, 9655.855162172713, 9695.806083878142, 9763.853542197015, 9845.556949937127, 9780.902190977999, 9950.651727189514, 10111.241656875616, 10128.594856205964, 10130.594776208869, 7505.474616776992, 7507.519510757287, 7541.962290188514, 7621.009268795021, 7632.236776322546, 8083.474574152661, 8146.633401497065, 8149.714759983609, 8155.306798922158, 8162.347012239125, 7020.5787652741, 7235.782926512213, 7622.123455802654, 7752.573608451589, 7909.288164065261, 7202.819929501804, 7506.3244308012545, 7554.055743032121, 7632.618369081635, 7653.6938522460705, 6892.724291028503, 7593.506422082547, 7669.233076692286, 7681.6543255552515, 7735.18780528059, 6977.7208911642965, 7008.649567521706, 7033.542819716907, 7037.437005039687, 7038.788836334918, 7116.679749411185, 7190.7483238086415, 7265.818354541178, 7268.454865884974, 7282.4902256841515], "unit": "score", "name": "mootools.html", "value": 4945.571767099298}, {"lowerIsBetter": false, "replicates": [319.81770390877205, 327.65596124069737, 330.86269198282713, 330.9139623697838, 337.61006038026073, 6450.7742229022, 6606.504512161595, 6644.435223006044, 6707.195136583605, 6756.972908127561, 6460.903086453707, 6593.736250549972, 6602.801915942518, 6614.603123812574, 6622.73509059637, 4843.055604157191, 4865.513448655132, 4867.707937523742, 4880.658353915227, 4885.82740142365, 4080.8367665293354, 4653.6044436222965, 4860.708357498562, 4875.9756201219125, 4883.047805677894, 4575.954240457603, 4611.769411529427, 4665.276882083265, 4696.600788932945, 4729.85810425686, 4765.666403351749, 4769.189237829577, 4802.06359759847, 4827.227643577046, 4842.83050093245, 4112.136451345221, 4120.381942708587, 4127.504699436087, 4127.958720412787, 4129.091599848029, 6449.580777249511, 6536.901946470807, 6560.8359791005605, 6582.111414959015, 6591.4397276231575, 5437.8368648940595, 5686.289213848269, 5696.17722328855, 5787.681677507735, 5788.594798364116, 7010.158780946268, 7017.929820701779, 7022.754203602849, 7028.2620324866175, 7043.894341584881, 4592.816287348502, 4600.9769951150365, 4604.309353596954, 4604.424446944132, 4606.60843828275, 5951.345352011232, 7144.3570078693165, 7316.231795661432, 7372.631368431611, 7380.77857664271, 4653.441587009513, 4657.184992626277, 4659.881628409157, 4667.043256132485, 4672.649551283667, 4306.138772245564, 4735.668503204743, 4740.786664600101, 4752.1921273383605, 4760.071786001697, 5628.099504079328, 5643.858903527444, 5650.576206784508, 5656.8020119295625, 5660.830175094754, 6663.435062241774, 6969.686364113627, 6997.755078572225, 7001.719931202797, 7007.334303241184, 1637.2305016642158, 1660.7508873669046, 1662.8087769906615, 1664.0514906503176, 1666.30015393535, 1055.8680164979378, 1065.0840277361463, 1077.2620754783, 1084.322298563398, 1084.5878566144972, 6546.279909209983, 6572.572782769104, 6573.769918052845, 6574.276829548746, 6579.157835805982, 7247.9637601811655, 7329.74345897891, 7334.816629584197, 7348.5958272294465, 7351.41188704913, 6385.744570217233, 6499.805005849832, 6524.249711283168, 6560.86878262432, 6613.735450582019, 3894.084890050836, 3896.980515097463, 3936.0, 3937.350337194388, 3954.7824869632445, 6153.292371377349, 7429.925700742923, 7738.148803631596, 7742.8838567421535, 7744.535327880345, 7650.234976502416, 7650.96174519135, 7653.081630204411, 7656.234376562299, 7658.846823063507, 6161.44546990773, 7675.731349402744, 7676.692932282646, 7681.0, 7689.88465173034, 7190.712371505081, 7375.668094935633, 7402.703891844266, 7413.406927445683, 7426.14599321085, 7268.89096663561, 7270.7097264361555, 7286.963565182352, 7290.56256624583, 7291.4166866649475, 5700.543956483554, 7654.0, 7655.808604784702, 7681.807954800951, 7685.692572297269, 3898.6881049515405, 4595.080983803319, 4710.340552322609, 4737.952620473889, 4745.240761478147, 7390.445716571171, 7392.0, 7394.926050739424, 7401.666924988496, 7404.407647388089, 7082.504224704221, 7084.504084714021, 7087.893681594677, 7088.397486213729, 7090.716371345088, 6866.34769696878, 7087.433005359662, 7106.289371062852, 7128.215896251512, 7141.285871412817, 6939.930600694131, 6948.374646281859, 6953.443724502129, 6953.548019378724, 6968.059311993019, 6194.0, 6317.957537006342, 7114.715411383487, 7144.1784194818265, 7167.996480492631, 6987.9301206987275, 6991.2309645937885, 6992.265812089658, 6999.09011828459, 6999.370056694922], "unit": "score", "name": "prototype.html", "value": 5151.889569894923}, {"lowerIsBetter": false, "replicates": [589.6462122726364, 636.9108324834524, 722.3246264742467, 758.5865703191756, 764.632976171438, 13784.966127540449, 14810.55568332949, 14972.625684357896, 15004.549863504086, 15013.174275414862, 12312.753744925096, 13854.445822167101, 13855.030147889653, 13872.722545549082, 13888.027838051341, 682.8497730499282, 692.9341712537301, 694.0352909455835, 694.2294053600499, 834.5535138700797, 804.7263930263709, 839.9874001889976, 849.5794581682076, 852.8018134521008, 854.3037424499045, 882.9823403531925, 893.2184338703635, 894.025512191711, 894.2488309819751, 906.0214967834722, 710.5452510393327, 719.7660760252938, 724.080417869303, 893.6738090596917, 896.3187977137358, 604.6432604763211, 632.5414074795782, 650.7266947881901, 660.3231687520282, 665.963372014539, 14449.988500804948, 14852.777208341884, 14861.331240094221, 14862.628434289121, 14868.925655371762, 12608.0, 12616.0, 12784.61646150617, 12901.0, 12903.935480322632, 9982.600695972153, 10106.646267380607, 10187.185025198041, 10230.846537301946, 10234.539445724886, 3518.542589463379, 3541.6281290464644, 3548.361294966905, 3550.786952782841, 3554.48459973305, 76888.0, 79179.20820791776, 81141.59429202875, 81560.0, 81856.0, 9387.436753794795, 9454.716358509255, 9566.378185418065, 9755.414675119515, 9778.902210977942, 21268.468288292916, 21282.680759788615, 21304.0, 21311.46721331948, 21335.359939201848, 7255.129384473897, 7421.666025028887, 7443.9627801861725, 7537.472376933562, 7615.809604759926, 4123.814428350732, 4165.062860856344, 4171.270027745132, 4171.8957026074595, 4178.979105104455, 3476.217850983559, 3514.841832117561, 3520.383932811748, 3526.717862570988, 3530.2586456843837, 628.6385328436077, 629.3580547841176, 634.5082561015158, 639.667372966055, 657.6744511466759, 604.9304330002018, 614.4163045107166, 631.1605564599164, 637.6333608175318, 643.707113263464, 8422.915770842335, 8627.95686021566, 8674.522901240367, 8849.380543361904, 8917.910820891837, 500.5170010939461, 597.474222684044, 601.8525461262019, 619.2414292491661, 647.139304724715, 3891.9610803892165, 4112.424260603518, 4165.66674666026, 4170.812313445902, 4254.659627229814, 86726.56636716776, 94168.0, 96156.51921740346, 96297.0, 96335.51832240933, 73643.0, 74110.6294468535, 74740.50518989698, 74838.25161748422, 75677.62161189268, 69128.0, 70177.92953810275, 70479.0, 71134.28865711381, 71873.92189117167, 9043.0, 9072.682456114004, 9080.909190908007, 9098.135677110664, 9138.497382644018, 42041.78979105085, 47976.80057998578, 49720.592897907474, 50797.23804142867, 52206.738966306446, 51365.0, 67640.98538521827, 68018.65990670015, 72836.0, 73693.0, 10736.830567333205, 10860.67417977462, 11039.72400689957, 11548.480318385526, 12030.338331391857, 12109.51561937548, 12295.323757193082, 12419.813702794285, 12439.502419903465, 12617.684557886127, 11594.652160434864, 11651.650450486499, 11689.064874810165, 11771.058315334923, 11782.11634127461, 11331.206815523165, 11358.0, 11365.60604184722, 11759.882401175879, 11790.0, 11293.71765705831, 11657.242279251821, 11708.12189085839, 11871.881281187423, 11887.76224475523, 9265.258779297505, 9416.764580885532, 9570.56932438028, 9584.089511496397, 9656.75858103553, 9868.753281167741, 10006.249531285037, 10006.749831253986, 10010.399376037461, 10014.849777253492], "unit": "score", "name": "yui.html", "value": 6846.300002718091}], "name": "dromaeo_css", "value": 7477.960891570619}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 110.0, 109.0, 110.0, 110.0, 114.0, 110.0, 120.0, 166.0], "unit": "score", "name": "ai-astar", "value": 116.6}, {"lowerIsBetter": true, "replicates": [186.0, 124.0, 144.0, 155.0, 117.0, 142.0, 137.0, 132.0, 177.0, 145.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [183.0, 186.0, 183.0, 181.0, 184.0, 184.0, 186.0, 182.0, 180.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 88.0, 82.0, 73.0, 81.0, 86.0, 101.0, 77.0, 55.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [92.0, 129.0, 160.0, 105.0, 78.0, 82.0, 117.0, 97.0, 115.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [87.0, 92.0, 86.0, 92.0, 85.0, 91.0, 86.0, 91.0, 88.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.2}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 87.0, 83.0, 83.0, 85.0, 85.0, 85.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 84.8}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 56.0, 52.0, 51.0, 43.0, 47.0, 64.0, 80.0, 42.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 72.0, 75.0, 69.0, 67.0, 65.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 81.0, 82.0, 83.0, 83.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 119.0, 123.0, 118.0, 125.0, 123.0, 120.0, 125.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [140.0, 126.0, 139.0, 133.0, 135.0, 106.0, 148.0, 172.0, 150.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1435.0}]} 04:42:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1435.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7477.96"}}} 04:42:03 INFO - Return code: 0 04:42:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:42:03 INFO - # TBPL SUCCESS # 04:42:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:42:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:42:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:42:03 INFO - 2016-01-29 04:42:03.693 screenresolution[1690:10265] starting screenresolution argv=screenresolution get 04:42:03 INFO - 2016-01-29 04:42:03.695 screenresolution[1690:10265] Display 0: 1600x1200x32@60 04:42:03 INFO - 2016-01-29 04:42:03.701 screenresolution[1691:10268] starting screenresolution argv=screenresolution list 04:42:03 INFO - Available Modes on Display 0 04:42:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:42:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:42:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:42:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:42:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:42:03 INFO - Intel Iris: 04:42:03 INFO - Chipset Model: Intel Iris 04:42:03 INFO - Type: GPU 04:42:03 INFO - Bus: Built-In 04:42:03 INFO - VRAM (Dynamic, Max): 1536 MB 04:42:03 INFO - Vendor: Intel (0x8086) 04:42:03 INFO - Device ID: 0x0a2e 04:42:03 INFO - Revision ID: 0x0009 04:42:03 INFO - Displays: 04:42:03 INFO - Display: 04:42:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:42:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:42:03 INFO - Display Serial Number: 1600x1200 60 04:42:03 INFO - Main Display: Yes 04:42:03 INFO - Mirror: Off 04:42:03 INFO - Online: Yes 04:42:03 INFO - Rotation: Supported 04:42:03 INFO - Return code: 0 04:42:03 INFO - Running post-action listener: _resource_record_post_action 04:42:03 INFO - Running post-run listener: _resource_record_post_run 04:42:05 INFO - Total resource usage - Wall time: 1207s; CPU: 52.0%; Read bytes: 33926656; Write bytes: 711721984; Read time: 352; Write time: 1900 04:42:05 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399475200; Write bytes: 394319872; Read time: 30046; Write time: 721 04:42:05 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32144896; Write bytes: 304053248; Read time: 334; Write time: 1142 04:42:05 INFO - Running post-run listener: _upload_blobber_files 04:42:05 INFO - Blob upload gear active. 04:42:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:05 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 04:42:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:42:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:42:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:42:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:06 INFO - (blobuploader) - INFO - Done attempting. 04:42:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:42:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:42:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:07 INFO - (blobuploader) - INFO - Done attempting. 04:42:07 INFO - (blobuploader) - INFO - Iteration through files over. 04:42:07 INFO - Return code: 0 04:42:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:42:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:42:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c91e6275d77eca737614a39d00380140a9a8e826b47f0a6483e93b6152b95e65fd2b05af3fe83b5e0339dd329d5d9005430071aa1d54ce90ab01cfee2fb96d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c584b85694fd5e8f5112301b183c85b53d4f2de949ee833358ad1a03e0a0178566822e55321c608a5b1788c4a4d00f66a011fcd3a3ed7dd1d9f7b103d1955ca0"} 04:42:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:42:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:42:07 INFO - Contents: 04:42:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c91e6275d77eca737614a39d00380140a9a8e826b47f0a6483e93b6152b95e65fd2b05af3fe83b5e0339dd329d5d9005430071aa1d54ce90ab01cfee2fb96d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c584b85694fd5e8f5112301b183c85b53d4f2de949ee833358ad1a03e0a0178566822e55321c608a5b1788c4a4d00f66a011fcd3a3ed7dd1d9f7b103d1955ca0"} 04:42:07 INFO - Running post-run listener: copy_logs_to_upload_dir 04:42:07 INFO - Copying logs to upload dir... 04:42:07 INFO - mkdir: /builds/slave/test/build/upload/logs 04:42:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.773284 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-29 04:42:07.453938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 04:42:07.457258) ========= 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.eGTzb594LS/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.5K0x0e4hQT/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c91e6275d77eca737614a39d00380140a9a8e826b47f0a6483e93b6152b95e65fd2b05af3fe83b5e0339dd329d5d9005430071aa1d54ce90ab01cfee2fb96d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c584b85694fd5e8f5112301b183c85b53d4f2de949ee833358ad1a03e0a0178566822e55321c608a5b1788c4a4d00f66a011fcd3a3ed7dd1d9f7b103d1955ca0"} build_url:https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/TLcytMEeQAK5gA0ixuapSw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c91e6275d77eca737614a39d00380140a9a8e826b47f0a6483e93b6152b95e65fd2b05af3fe83b5e0339dd329d5d9005430071aa1d54ce90ab01cfee2fb96d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c584b85694fd5e8f5112301b183c85b53d4f2de949ee833358ad1a03e0a0178566822e55321c608a5b1788c4a4d00f66a011fcd3a3ed7dd1d9f7b103d1955ca0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 04:42:07.488855) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:42:07.489356) ========= 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.eGTzb594LS/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.5K0x0e4hQT/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005096 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:42:07.539529) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 04:42:07.540037) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 04:42:07.540689) ========= ========= Total master_lag: 0.36 =========