builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0137 starttime: 1456249849.38 results: success (0) buildid: 20160223075609 builduid: 163a276575c649e4b9e570a3c877a354 revision: a9e33d8c48b5ca93ca1937eba4220f681a0f05ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 09:50:49.379145) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 09:50:49.379558) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-02-23 09:50:49.379852) ========= 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.6kTRroNrzT/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.HWB2WKxiAI/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005744 basedir: '/builds/slave/test' ========= master_lag: 1.79 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-02-23 09:50:51.172808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-02-23 09:50:51.173108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-02-23 09:50:54.828829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:50:54.829086) ========= 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.6kTRroNrzT/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.HWB2WKxiAI/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005159 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:50:54.945030) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 09:50:54.945289) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 09:50:54.945624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:50:54.945900) ========= 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.6kTRroNrzT/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.HWB2WKxiAI/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-02-23 09:50:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.3M=0.001s 2016-02-23 09:50:55 (19.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150601 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:50:55.158756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 09:50:55.159080) ========= 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.6kTRroNrzT/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.HWB2WKxiAI/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.025886 ========= master_lag: 1.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 09:50:56.391978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-23 09:50:56.392280) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a9e33d8c48b5ca93ca1937eba4220f681a0f05ec --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 a9e33d8c48b5ca93ca1937eba4220f681a0f05ec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6kTRroNrzT/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.HWB2WKxiAI/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-02-23 09:50:57,217 truncating revision to first 12 chars 2016-02-23 09:50:57,217 Setting DEBUG logging. 2016-02-23 09:50:57,217 attempt 1/10 2016-02-23 09:50:57,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a9e33d8c48b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 09:50:57,863 unpacking tar archive at: mozilla-central-a9e33d8c48b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.898041 ========= master_lag: 4.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-23 09:51:01.430200) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 09:51:01.430517) ========= echo a9e33d8c48b5ca93ca1937eba4220f681a0f05ec in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a9e33d8c48b5ca93ca1937eba4220f681a0f05ec'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6kTRroNrzT/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.HWB2WKxiAI/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 a9e33d8c48b5ca93ca1937eba4220f681a0f05ec program finished with exit code 0 elapsedTime=0.005943 script_repo_revision: 'a9e33d8c48b5ca93ca1937eba4220f681a0f05ec' ========= master_lag: 0.21 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 09:51:01.642055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 09:51:01.642320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 09:51:02.132992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-23 09:51:02.133241) ========= /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.6kTRroNrzT/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.HWB2WKxiAI/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:51:02 INFO - MultiFileLogger online at 20160223 09:51:02 in /builds/slave/test 09:51:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:51:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:51:02 INFO - {'append_to_log': False, 09:51:02 INFO - 'base_work_dir': '/builds/slave/test', 09:51:02 INFO - 'blob_upload_branch': 'Firefox', 09:51:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:51:02 INFO - 'branch': 'Firefox', 09:51:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:51:02 INFO - 'config_files': ('talos/mac_config.py',), 09:51:02 INFO - 'default_actions': ('clobber', 09:51:02 INFO - 'read-buildbot-config', 09:51:02 INFO - 'download-and-extract', 09:51:02 INFO - 'populate-webroot', 09:51:02 INFO - 'create-virtualenv', 09:51:02 INFO - 'install', 09:51:02 INFO - 'run-tests'), 09:51:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:51:02 INFO - 'download_minidump_stackwalk': True, 09:51:02 INFO - 'download_symbols': 'ondemand', 09:51:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:51:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:51:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:51:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:51:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:51:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:51:02 INFO - 'installer_path': 'installer.exe', 09:51:02 INFO - 'log_level': 'info', 09:51:02 INFO - 'log_name': 'talos', 09:51:02 INFO - 'log_to_console': True, 09:51:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:51:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:51:02 INFO - 'opt_config_files': (), 09:51:02 INFO - 'pip_index': False, 09:51:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:51:02 INFO - 'cmd': ('bash', 09:51:02 INFO - '-c', 09:51:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:51:02 INFO - 'enabled': True, 09:51:02 INFO - 'halt_on_failure': False, 09:51:02 INFO - 'name': 'check_screen_resolution'},), 09:51:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:51:02 INFO - 'cmd': ('bash', 09:51:02 INFO - '-c', 09:51:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:51:02 INFO - 'enabled': True, 09:51:02 INFO - 'halt_on_failure': False, 09:51:02 INFO - 'name': 'check_screen_resolution'},), 09:51:02 INFO - 'run_cmd_checks_enabled': True, 09:51:02 INFO - 'sps_profile': False, 09:51:02 INFO - 'sps_profile_interval': 0, 09:51:02 INFO - 'suite': 'dromaeojs', 09:51:02 INFO - 'system_bits': '32', 09:51:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:51:02 INFO - 'title': 't-yosemite-r7-0137', 09:51:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:51:02 INFO - 'use_talos_json': True, 09:51:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:51:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:51:02 INFO - 'work_dir': 'build'} 09:51:02 INFO - ##### 09:51:02 INFO - ##### Running clobber step. 09:51:02 INFO - ##### 09:51:02 INFO - Running pre-action listener: _resource_record_pre_action 09:51:02 INFO - Running main action method: clobber 09:51:02 INFO - rmtree: /builds/slave/test/build 09:51:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:51:04 INFO - Running post-action listener: _resource_record_post_action 09:51:04 INFO - ##### 09:51:04 INFO - ##### Running read-buildbot-config step. 09:51:04 INFO - ##### 09:51:04 INFO - Running pre-action listener: _resource_record_pre_action 09:51:04 INFO - Running main action method: read_buildbot_config 09:51:04 INFO - Using buildbot properties: 09:51:04 INFO - { 09:51:04 INFO - "project": "", 09:51:04 INFO - "product": "firefox", 09:51:04 INFO - "script_repo_revision": "production", 09:51:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:51:04 INFO - "repository": "", 09:51:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:51:04 INFO - "buildid": "20160223075609", 09:51:04 INFO - "pgo_build": "False", 09:51:04 INFO - "basedir": "/builds/slave/test", 09:51:04 INFO - "buildnumber": 132, 09:51:04 INFO - "slavename": "t-yosemite-r7-0137", 09:51:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:51:04 INFO - "platform": "yosemite_r7", 09:51:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:51:04 INFO - "branch": "mozilla-central", 09:51:04 INFO - "repo_path": "mozilla-central", 09:51:04 INFO - "revision": "a9e33d8c48b5ca93ca1937eba4220f681a0f05ec", 09:51:04 INFO - "stage_platform": "macosx64", 09:51:04 INFO - "builduid": "163a276575c649e4b9e570a3c877a354", 09:51:04 INFO - "slavebuilddir": "test" 09:51:04 INFO - } 09:51:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 09:51:04 INFO - Running post-action listener: _resource_record_post_action 09:51:04 INFO - ##### 09:51:04 INFO - ##### Running download-and-extract step. 09:51:04 INFO - ##### 09:51:04 INFO - Running pre-action listener: _resource_record_pre_action 09:51:04 INFO - Running main action method: download_and_extract 09:51:04 INFO - mkdir: /builds/slave/test/build/tests 09:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:04 INFO - https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:51:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/test_packages.json 09:51:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/test_packages.json 09:51:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:51:13 INFO - Downloaded 1277 bytes. 09:51:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:51:13 INFO - Using the following test package requirements: 09:51:13 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:51:13 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:51:13 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 09:51:13 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:51:13 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 09:51:13 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:51:13 INFO - u'jsshell-mac.zip'], 09:51:13 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:51:13 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 09:51:13 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:51:13 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:51:13 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 09:51:13 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:51:13 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 09:51:13 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:51:13 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 09:51:13 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:51:13 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:51:13 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 09:51:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:13 INFO - https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:51:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:51:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:51:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/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 09:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/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 09:51:21 INFO - Downloaded 17825712 bytes. 09:51:21 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'] 09:51:21 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 09:51:24 INFO - Return code: 0 09:51:24 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 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:24 INFO - https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/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 09:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/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 09:51:26 INFO - Downloaded 17825712 bytes. 09:51:26 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'] 09:51:26 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 09:51:29 INFO - Return code: 0 09:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:29 INFO - https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:51:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:51:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:51:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/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 09:51:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/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 09:51:30 INFO - Downloaded 10707015 bytes. 09:51:30 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'] 09:51:30 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 09:51:31 INFO - Return code: 0 09:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:31 INFO - https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:51:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:51:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:51:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 09:51:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxqKje3KTfCSW8UqCf9p_g/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 09:51:35 INFO - Downloaded 111444769 bytes. 09:51:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:51:35 INFO - mkdir: /builds/slave/test/properties 09:51:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:51:35 INFO - Writing to file /builds/slave/test/properties/build_url 09:51:35 INFO - Contents: 09:51:35 INFO - build_url:https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:51:36 INFO - Running post-action listener: _resource_record_post_action 09:51:36 INFO - Running post-action listener: set_extra_try_arguments 09:51:36 INFO - ##### 09:51:36 INFO - ##### Running populate-webroot step. 09:51:36 INFO - ##### 09:51:36 INFO - Running pre-action listener: _resource_record_pre_action 09:51:36 INFO - Running main action method: populate_webroot 09:51:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:36 INFO - '--tppagecycles', 09:51:36 INFO - '7'], 09:51:36 INFO - 'tests': ['tsvgm']}}, 09:51:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:51:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:51:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:51:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:51:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:36 INFO - 'talos_options': ['--e10s'], 09:51:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:36 INFO - 'tests': ['damp', 'tps']}, 09:51:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:36 INFO - 'talos_options': ['--e10s'], 09:51:36 INFO - 'tests': ['damp', 'tps']}, 09:51:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:51:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:36 INFO - 'other': {'tests': ['a11yr', 09:51:36 INFO - 'ts_paint', 09:51:36 INFO - 'tpaint', 09:51:36 INFO - 'sessionrestore', 09:51:36 INFO - 'sessionrestore_no_auto_restore']}, 09:51:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:51:36 INFO - 'tests': ['a11yr', 09:51:36 INFO - 'ts_paint', 09:51:36 INFO - 'tpaint', 09:51:36 INFO - 'sessionrestore', 09:51:36 INFO - 'sessionrestore_no_auto_restore']}, 09:51:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:51:36 INFO - 'tests': ['a11yr', 09:51:36 INFO - 'ts_paint', 09:51:36 INFO - 'tpaint', 09:51:36 INFO - 'sessionrestore', 09:51:36 INFO - 'sessionrestore_no_auto_restore']}, 09:51:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:51:36 INFO - 'tests': ['a11yr', 09:51:36 INFO - 'ts_paint', 09:51:36 INFO - 'tpaint', 09:51:36 INFO - 'sessionrestore', 09:51:36 INFO - 'sessionrestore_no_auto_restore']}, 09:51:36 INFO - 'other_l64': {'tests': ['a11yr', 09:51:36 INFO - 'ts_paint', 09:51:36 INFO - 'tpaint', 09:51:36 INFO - 'sessionrestore', 09:51:36 INFO - 'sessionrestore_no_auto_restore']}, 09:51:36 INFO - 'other_nol64': {'tests': ['a11yr', 09:51:36 INFO - 'ts_paint', 09:51:36 INFO - 'tpaint', 09:51:36 INFO - 'sessionrestore', 09:51:36 INFO - 'sessionrestore_no_auto_restore']}, 09:51:36 INFO - 'svgr': {'tests': ['tsvgx', 09:51:36 INFO - 'tsvgr_opacity', 09:51:36 INFO - 'tart', 09:51:36 INFO - 'tscrollx', 09:51:36 INFO - 'cart']}, 09:51:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:51:36 INFO - 'tests': ['tsvgx', 09:51:36 INFO - 'tsvgr_opacity', 09:51:36 INFO - 'tart', 09:51:36 INFO - 'tscrollx', 09:51:36 INFO - 'cart']}, 09:51:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:36 INFO - 'tests': ['tp5o']}, 09:51:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:36 INFO - 'talos_options': ['--e10s'], 09:51:36 INFO - 'tests': ['tp5o']}, 09:51:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:36 INFO - 'talos_options': ['--xperf_path', 09:51:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:36 INFO - 'tests': ['tp5n']}, 09:51:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:36 INFO - 'talos_options': ['--e10s', 09:51:36 INFO - '--xperf_path', 09:51:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:36 INFO - 'tests': ['tp5n']}}, 09:51:36 INFO - 'talos.zip': {'path': '', 09:51:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:36 INFO - Running post-action listener: _resource_record_post_action 09:51:36 INFO - ##### 09:51:36 INFO - ##### Running create-virtualenv step. 09:51:36 INFO - ##### 09:51:36 INFO - Running pre-action listener: _resource_record_pre_action 09:51:36 INFO - Running main action method: create_virtualenv 09:51:36 INFO - Creating virtualenv /builds/slave/test/build/venv 09:51:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:51:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:51:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:36 INFO - Using real prefix '/tools/python27' 09:51:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:51:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:40 INFO - Installing pip.................done. 09:51:40 INFO - Return code: 0 09:51:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 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 0x10202ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020334c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112cc0a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, '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.6kTRroNrzT/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.HWB2WKxiAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:40 INFO - 'HOME': '/Users/cltbld', 09:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:40 INFO - 'LOGNAME': 'cltbld', 09:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:40 INFO - 'MOZ_NO_REMOTE': '1', 09:51:40 INFO - 'NO_EM_RESTART': '1', 09:51:40 INFO - 'PAGER': '/bin/cat', 09:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:40 INFO - 'PWD': '/builds/slave/test', 09:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:40 INFO - 'SHELL': '/bin/bash', 09:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:51:40 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:40 INFO - 'USER': 'cltbld', 09:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:40 INFO - 'XPC_FLAGS': '0x0', 09:51:40 INFO - 'XPC_SERVICE_NAME': '0', 09:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:51:40 INFO - Cleaning up... 09:51:40 INFO - Return code: 0 09:51:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 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 0x10202ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020334c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112cc0a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, '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.6kTRroNrzT/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.HWB2WKxiAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:40 INFO - 'HOME': '/Users/cltbld', 09:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:40 INFO - 'LOGNAME': 'cltbld', 09:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:40 INFO - 'MOZ_NO_REMOTE': '1', 09:51:40 INFO - 'NO_EM_RESTART': '1', 09:51:40 INFO - 'PAGER': '/bin/cat', 09:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:40 INFO - 'PWD': '/builds/slave/test', 09:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:40 INFO - 'SHELL': '/bin/bash', 09:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:51:40 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:40 INFO - 'USER': 'cltbld', 09:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:40 INFO - 'XPC_FLAGS': '0x0', 09:51:40 INFO - 'XPC_SERVICE_NAME': '0', 09:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:40 INFO - Downloading/unpacking psutil>=0.7.1 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:43 INFO - Installing collected packages: psutil 09:51:43 INFO - Running setup.py install for psutil 09:51:43 INFO - building 'psutil._psutil_osx' extension 09:51:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:51:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:51:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:51:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:51:44 INFO - building 'psutil._psutil_posix' extension 09:51:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:51:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:51:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:51:44 INFO - ^ 09:51:44 INFO - 1 warning generated. 09:51:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:51:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:44 INFO - Successfully installed psutil 09:51:44 INFO - Cleaning up... 09:51:44 INFO - Return code: 0 09:51:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:44 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 0x10202ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020334c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112cc0a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, '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.6kTRroNrzT/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.HWB2WKxiAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:44 INFO - 'HOME': '/Users/cltbld', 09:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:44 INFO - 'LOGNAME': 'cltbld', 09:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:44 INFO - 'MOZ_NO_REMOTE': '1', 09:51:44 INFO - 'NO_EM_RESTART': '1', 09:51:44 INFO - 'PAGER': '/bin/cat', 09:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:44 INFO - 'PWD': '/builds/slave/test', 09:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:44 INFO - 'SHELL': '/bin/bash', 09:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:51:44 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:44 INFO - 'USER': 'cltbld', 09:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:44 INFO - 'XPC_FLAGS': '0x0', 09:51:44 INFO - 'XPC_SERVICE_NAME': '0', 09:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:51:47 INFO - Installing collected packages: mozsystemmonitor 09:51:47 INFO - Running setup.py install for mozsystemmonitor 09:51:47 INFO - Successfully installed mozsystemmonitor 09:51:47 INFO - Cleaning up... 09:51:47 INFO - Return code: 0 09:51:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:47 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 0x10202ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020334c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112cc0a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, '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.6kTRroNrzT/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.HWB2WKxiAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:47 INFO - 'HOME': '/Users/cltbld', 09:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:47 INFO - 'LOGNAME': 'cltbld', 09:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:47 INFO - 'MOZ_NO_REMOTE': '1', 09:51:47 INFO - 'NO_EM_RESTART': '1', 09:51:47 INFO - 'PAGER': '/bin/cat', 09:51:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:47 INFO - 'PWD': '/builds/slave/test', 09:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:47 INFO - 'SHELL': '/bin/bash', 09:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:51:47 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:47 INFO - 'USER': 'cltbld', 09:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:47 INFO - 'XPC_FLAGS': '0x0', 09:51:47 INFO - 'XPC_SERVICE_NAME': '0', 09:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:51 INFO - Downloading docopt-0.6.1.tar.gz 09:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:51 INFO - Running setup.py install for blobuploader 09:51:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:51 INFO - Running setup.py install for requests 09:51:52 INFO - Running setup.py install for docopt 09:51:52 INFO - Successfully installed blobuploader requests docopt 09:51:52 INFO - Cleaning up... 09:51:52 INFO - Return code: 0 09:51:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:52 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 0x10202ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020334c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112cc0a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, '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.6kTRroNrzT/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.HWB2WKxiAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:51:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:51:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:52 INFO - 'HOME': '/Users/cltbld', 09:51:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:52 INFO - 'LOGNAME': 'cltbld', 09:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:52 INFO - 'MOZ_NO_REMOTE': '1', 09:51:52 INFO - 'NO_EM_RESTART': '1', 09:51:52 INFO - 'PAGER': '/bin/cat', 09:51:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:52 INFO - 'PWD': '/builds/slave/test', 09:51:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:52 INFO - 'SHELL': '/bin/bash', 09:51:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:51:52 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:51:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:52 INFO - 'USER': 'cltbld', 09:51:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:52 INFO - 'XPC_FLAGS': '0x0', 09:51:52 INFO - 'XPC_SERVICE_NAME': '0', 09:51:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-h1OSpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-9MJ4EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-18jAO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-09Z1e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hcavlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-gs8Tq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hzyek2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-iusN1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-748O70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-uj4opY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-kYb58M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-f5QcPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-eV5t_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:54 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-7YaKBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:54 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-0gJdrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:54 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-7Zra2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:54 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-CibXAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:54 INFO - Running setup.py install for manifestparser 09:51:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Running setup.py install for mozcrash 09:51:54 INFO - Running setup.py install for mozdebug 09:51:54 INFO - Running setup.py install for mozdevice 09:51:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Running setup.py install for mozfile 09:51:55 INFO - Running setup.py install for mozhttpd 09:51:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Running setup.py install for mozinfo 09:51:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Running setup.py install for mozInstall 09:51:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Running setup.py install for mozleak 09:51:55 INFO - Running setup.py install for mozlog 09:51:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Running setup.py install for moznetwork 09:51:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:56 INFO - Running setup.py install for mozprocess 09:51:56 INFO - Running setup.py install for mozprofile 09:51:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:56 INFO - Running setup.py install for mozrunner 09:51:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:56 INFO - Running setup.py install for mozscreenshot 09:51:56 INFO - Running setup.py install for moztest 09:51:56 INFO - Running setup.py install for mozversion 09:51:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:57 INFO - Cleaning up... 09:51:57 INFO - Return code: 0 09:51:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:57 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 0x10202ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020334c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112cc0a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, '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.6kTRroNrzT/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.HWB2WKxiAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:51:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:57 INFO - 'HOME': '/Users/cltbld', 09:51:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:57 INFO - 'LOGNAME': 'cltbld', 09:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:57 INFO - 'MOZ_NO_REMOTE': '1', 09:51:57 INFO - 'NO_EM_RESTART': '1', 09:51:57 INFO - 'PAGER': '/bin/cat', 09:51:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:57 INFO - 'PWD': '/builds/slave/test', 09:51:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:57 INFO - 'SHELL': '/bin/bash', 09:51:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:51:57 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:51:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:57 INFO - 'USER': 'cltbld', 09:51:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:57 INFO - 'XPC_FLAGS': '0x0', 09:51:57 INFO - 'XPC_SERVICE_NAME': '0', 09:51:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-YAeagA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ZDskiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:57 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)) 09:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-0KvGfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-soK4Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-0kLJfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-8d9N1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-m6cdRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-JIIQNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-gELzOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-xRciAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-oyiT2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ZJOOlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-d63QGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-CA1GIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-DWjBcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-RAHFxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-eLdujH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:51:59 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)) 09:51:59 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)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:01 INFO - Downloading blessings-1.6.tar.gz 09:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:52:01 INFO - Installing collected packages: blessings 09:52:01 INFO - Running setup.py install for blessings 09:52:01 INFO - Successfully installed blessings 09:52:01 INFO - Cleaning up... 09:52:01 INFO - Return code: 0 09:52:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:52:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:52:02 INFO - Reading from file tmpfile_stdout 09:52:02 INFO - Current package versions: 09:52:02 INFO - blessings == 1.6 09:52:02 INFO - blobuploader == 1.2.4 09:52:02 INFO - docopt == 0.6.1 09:52:02 INFO - manifestparser == 1.1 09:52:02 INFO - mozInstall == 1.12 09:52:02 INFO - mozcrash == 0.16 09:52:02 INFO - mozdebug == 0.1 09:52:02 INFO - mozdevice == 0.48 09:52:02 INFO - mozfile == 1.2 09:52:02 INFO - mozhttpd == 0.7 09:52:02 INFO - mozinfo == 0.9 09:52:02 INFO - mozleak == 0.1 09:52:02 INFO - mozlog == 3.1 09:52:02 INFO - moznetwork == 0.27 09:52:02 INFO - mozprocess == 0.22 09:52:02 INFO - mozprofile == 0.28 09:52:02 INFO - mozrunner == 6.11 09:52:02 INFO - mozscreenshot == 0.1 09:52:02 INFO - mozsystemmonitor == 0.0 09:52:02 INFO - moztest == 0.7 09:52:02 INFO - mozversion == 1.4 09:52:02 INFO - psutil == 3.1.1 09:52:02 INFO - requests == 1.2.3 09:52:02 INFO - wsgiref == 0.1.2 09:52:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:02 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 0x10202ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020334c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112cc0a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, '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.6kTRroNrzT/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.HWB2WKxiAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:52:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:52:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:02 INFO - 'HOME': '/Users/cltbld', 09:52:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:02 INFO - 'LOGNAME': 'cltbld', 09:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:02 INFO - 'MOZ_NO_REMOTE': '1', 09:52:02 INFO - 'NO_EM_RESTART': '1', 09:52:02 INFO - 'PAGER': '/bin/cat', 09:52:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:02 INFO - 'PWD': '/builds/slave/test', 09:52:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:02 INFO - 'SHELL': '/bin/bash', 09:52:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:52:02 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:52:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:02 INFO - 'USER': 'cltbld', 09:52:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:02 INFO - 'XPC_FLAGS': '0x0', 09:52:02 INFO - 'XPC_SERVICE_NAME': '0', 09:52:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:52:02 INFO - Cleaning up... 09:52:02 INFO - Return code: 0 09:52:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:02 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 0x10202ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020334c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112cc0a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, '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.6kTRroNrzT/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.HWB2WKxiAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:52:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:52:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:02 INFO - 'HOME': '/Users/cltbld', 09:52:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:02 INFO - 'LOGNAME': 'cltbld', 09:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:02 INFO - 'MOZ_NO_REMOTE': '1', 09:52:02 INFO - 'NO_EM_RESTART': '1', 09:52:02 INFO - 'PAGER': '/bin/cat', 09:52:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:02 INFO - 'PWD': '/builds/slave/test', 09:52:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:02 INFO - 'SHELL': '/bin/bash', 09:52:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:52:02 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:52:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:02 INFO - 'USER': 'cltbld', 09:52:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:02 INFO - 'XPC_FLAGS': '0x0', 09:52:02 INFO - 'XPC_SERVICE_NAME': '0', 09:52:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:02 INFO - Downloading/unpacking jsonschema 09:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:52:04 INFO - Downloading/unpacking functools32 (from jsonschema) 09:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:05 INFO - Downloading functools32-3.2.3-2.tar.gz 09:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:52:05 INFO - warning: no files found matching '*.txt' 09:52:05 INFO - no previously-included directories found matching 'build' 09:52:05 INFO - no previously-included directories found matching 'dist' 09:52:05 INFO - no previously-included directories found matching '.git*' 09:52:05 INFO - Installing collected packages: jsonschema, functools32 09:52:05 INFO - Running setup.py install for functools32 09:52:05 INFO - warning: no files found matching '*.txt' 09:52:05 INFO - no previously-included directories found matching 'build' 09:52:05 INFO - no previously-included directories found matching 'dist' 09:52:05 INFO - no previously-included directories found matching '.git*' 09:52:05 INFO - Successfully installed jsonschema functools32 09:52:05 INFO - Cleaning up... 09:52:05 INFO - Return code: 0 09:52:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:06 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 0x10202ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020334c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112cc0a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, '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.6kTRroNrzT/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.HWB2WKxiAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:52:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:52:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:06 INFO - 'HOME': '/Users/cltbld', 09:52:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:06 INFO - 'LOGNAME': 'cltbld', 09:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:06 INFO - 'MOZ_NO_REMOTE': '1', 09:52:06 INFO - 'NO_EM_RESTART': '1', 09:52:06 INFO - 'PAGER': '/bin/cat', 09:52:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:06 INFO - 'PWD': '/builds/slave/test', 09:52:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:06 INFO - 'SHELL': '/bin/bash', 09:52:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:52:06 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:52:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:06 INFO - 'USER': 'cltbld', 09:52:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:06 INFO - 'XPC_FLAGS': '0x0', 09:52:06 INFO - 'XPC_SERVICE_NAME': '0', 09:52:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:06 INFO - Downloading/unpacking flake8 09:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:52:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:52:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:52:09 INFO - no previously-included directories found matching 'docs/_build' 09:52:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:52:10 INFO - Running setup.py install for pep8 09:52:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:52:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:52:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:52:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:52:10 INFO - no previously-included directories found matching 'docs/_build' 09:52:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:52:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:52:10 INFO - Cleaning up... 09:52:10 INFO - Return code: 0 09:52:10 INFO - Running post-action listener: _resource_record_post_action 09:52:10 INFO - Running post-action listener: _start_resource_monitoring 09:52:10 INFO - Starting resource monitoring. 09:52:10 INFO - ##### 09:52:10 INFO - ##### Running install step. 09:52:10 INFO - ##### 09:52:10 INFO - Running pre-action listener: _resource_record_pre_action 09:52:10 INFO - Running main action method: install 09:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:52:10 INFO - Reading from file tmpfile_stdout 09:52:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:52:10 INFO - Reading from file tmpfile_stdout 09:52:10 INFO - Output received: 09:52:10 INFO - Usage: mozinstall [options] installer 09:52:10 INFO - Options: 09:52:10 INFO - -h, --help show this help message and exit 09:52:10 INFO - -d DEST, --destination=DEST 09:52:10 INFO - Directory to install application into. [default: 09:52:10 INFO - "/builds/slave/test"] 09:52:10 INFO - --app=APP Application being installed. [default: firefox] 09:52:10 INFO - mkdir: /builds/slave/test/build/application 09:52:10 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'] 09:52:10 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 09:52:44 INFO - Reading from file tmpfile_stdout 09:52:44 INFO - Output received: 09:52:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:52:44 INFO - Running post-action listener: _resource_record_post_action 09:52:44 INFO - ##### 09:52:44 INFO - ##### Running run-tests step. 09:52:44 INFO - ##### 09:52:44 INFO - Running pre-action listener: _resource_record_pre_action 09:52:44 INFO - Running main action method: run_tests 09:52:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:44 INFO - 2016-02-23 09:52:44.565 screenresolution[1651:7980] starting screenresolution argv=screenresolution get 09:52:44 INFO - 2016-02-23 09:52:44.568 screenresolution[1651:7980] Display 0: 1600x1200x32@60 09:52:44 INFO - 2016-02-23 09:52:44.574 screenresolution[1652:7982] starting screenresolution argv=screenresolution list 09:52:44 INFO - Available Modes on Display 0 09:52:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:44 INFO - Intel Iris: 09:52:44 INFO - Chipset Model: Intel Iris 09:52:44 INFO - Type: GPU 09:52:44 INFO - Bus: Built-In 09:52:44 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:44 INFO - Vendor: Intel (0x8086) 09:52:44 INFO - Device ID: 0x0a2e 09:52:44 INFO - Revision ID: 0x0009 09:52:44 INFO - Displays: 09:52:44 INFO - Display: 09:52:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:44 INFO - Display Serial Number: 1600x1200 60 09:52:44 INFO - Main Display: Yes 09:52:44 INFO - Mirror: Off 09:52:44 INFO - Online: Yes 09:52:44 INFO - Rotation: Supported 09:52:44 INFO - Return code: 0 09:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:44 INFO - Python 2.7.3 09:52:44 INFO - Return code: 0 09:52:44 INFO - grabbing minidump binary from tooltool 09:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:44 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 0x101ecfd30>, '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 0x101cf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ec6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:52:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:52:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:44 INFO - Return code: 0 09:52:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:52:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:52:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:52:46 INFO - Return code: 0 09:52:46 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/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:52:46 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/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:52:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6kTRroNrzT/Render', 09:52:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:46 INFO - 'HOME': '/Users/cltbld', 09:52:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:46 INFO - 'LOGNAME': 'cltbld', 09:52:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:46 INFO - 'MOZ_NO_REMOTE': '1', 09:52:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:46 INFO - 'NO_EM_RESTART': '1', 09:52:46 INFO - 'PAGER': '/bin/cat', 09:52:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:46 INFO - 'PWD': '/builds/slave/test', 09:52:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:46 INFO - 'SHELL': '/bin/bash', 09:52:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWB2WKxiAI/Listeners', 09:52:46 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:52:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:46 INFO - 'USER': 'cltbld', 09:52:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:46 INFO - 'XPC_FLAGS': '0x0', 09:52:46 INFO - 'XPC_SERVICE_NAME': '0', 09:52:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:46 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/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:52:46 INFO - mozversion application_buildid: 20160223075609 09:52:46 INFO - mozversion application_changeset: a9e33d8c48b5ca93ca1937eba4220f681a0f05ec 09:52:46 INFO - mozversion application_display_name: Nightly 09:52:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:46 INFO - mozversion application_name: Firefox 09:52:46 INFO - mozversion application_remotingname: firefox 09:52:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:52:46 INFO - mozversion application_vendor: Mozilla 09:52:46 INFO - mozversion application_version: 47.0a1 09:52:46 INFO - mozversion platform_buildid: 20160223075609 09:52:46 INFO - mozversion platform_changeset: a9e33d8c48b5ca93ca1937eba4220f681a0f05ec 09:52:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:52:46 INFO - mozversion platform_version: 47.0a1 09:52:46 INFO - using testdate: 1456249966 09:52:46 INFO - actual date: 1456249966 09:52:46 INFO - starting webserver on 'localhost:49278' 09:52:46 INFO - SUITE-START | Running 2 tests 09:52:46 INFO - TEST-START | dromaeo_css 09:52:46 INFO - operating with platform_type : mac_ 09:52:46 INFO - Initialising browser for dromaeo_css test... 09:52:46 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpwaCHQR/profile http://localhost:49278/getInfo.html) 09:52:48 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 09:52:48 INFO - PROCESS | 1670 | colorDepth:24 09:52:48 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 09:52:48 INFO - PROCESS | 1670 | __metrics 09:52:48 INFO - PROCESS | 1670 | 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" 09:52:48 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:49 INFO - TEST-INFO | 1670: exit 0 09:52:49 INFO - Browser initialized. 09:52:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:49 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpwaCHQR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:01 INFO - PROCESS | 1674 | RSS: Main: 242528256 09:53:01 INFO - PROCESS | 1674 | 09:53:52 INFO - PROCESS | 1674 | 1456250032120 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:56:02 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 09:56:03 INFO - PROCESS | 1674 | RSS: Main: 333729792 09:56:03 INFO - PROCESS | 1674 | 09:59:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 09:59:06 INFO - PROCESS | 1674 | RSS: Main: 379785216 09:59:06 INFO - PROCESS | 1674 | 10:02:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 10:02:09 INFO - PROCESS | 1674 | RSS: Main: 375468032 10:02:09 INFO - PROCESS | 1674 | 10:05:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 10:05:12 INFO - PROCESS | 1674 | RSS: Main: 337805312 10:05:12 INFO - PROCESS | 1674 | 10:08:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 10:08:15 INFO - PROCESS | 1674 | RSS: Main: 336896000 10:08:15 INFO - PROCESS | 1674 | 10:11:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 10:11:18 INFO - PROCESS | 1674 | RSS: Main: 397135872 10:11:18 INFO - PROCESS | 1674 | 10:11:18 INFO - PROCESS | 1674 | __start_tp_report 10:11:18 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 10:11:18 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 10:11:18 INFO - PROCESS | 1674 | |i|pagename|runs| 10:11:18 INFO - PROCESS | 1674 | |0;dojo.html;3219.1952011996996;3514.8594056237735;3535.876244331449;3551.857925682973;3593.371160046991;5588.720563971795;5636.408177141403;5640.915386269204;5651.7739290428435;5668.404817494161;5600.915986260199;5662.122371032487;5683.119116536933;5745.540356771458;5748.080307150857;5062.114130027249;5111.258867464216;5131.923021154686;5153.613478989072;5188.325517682696;5152.458991805863;5163.483651634825;5181.663191892534;5190.584753219733;5254.81608143715;5096.4648711885275;5103.923441148386;5190.117679994391;5214.8174813881715;5245.554127899133;5156.046131465653;5173.327467429248;5181.093308670967;5181.222816577506;5237.659552129099;5062.2406639004075;5102.591792656615;5131.4098878629065;5146.614003949681;5210.531052205281;5528.419515950807;5568.136938774456;5623.297087864017;5664.49019588239;5665.263515742927;6204.379562043805;6209.87580248397;6209.968950155266;6218.81343559694;6223.346548612421;6101.51187904971;6218.68906554675;6284.528660350492;6285.622862628257;6309.022101574264;5754.654720716812;5770.278715160605;5776.133579962997;5800.8259752207505;5818.389069147678;6254.6247225166635;6264.686765661699;6265.404786545271;6267.623942563369;6281.780137695158;5961.105834124916;5985.491233245136;6053.606515576474;6083.908741368883;6103.35914728956;6111.266648002268;6135.7839197735275;6136.182108626252;6138.633639632459;6145.893739127;6095.710389288371;6107.664078475637;6133.662648554283;6137.447629713258;6138.7237574309265;6103.943827031755;6140.289530736458;6216.409441103088;6216.471599913967;6272.3100458949475;4849.830255941025;4857.344258525054;4860.465348811628;4892.0705066037335;4896.559309662148;4167.895802604899;4327.1345730853955;4377.124575084996;4377.190219809346;4377.584129507692;5477.643953143033;5725.198472213893;5754.338251101093;5763.740631671585;5769.8557536061935;6155.784547540815;6160.907586386208;6163.291221509494;6172.135900973867;6179.134921111048;5794.246747922827;5798.246227990334;5808.593398462067;5826.679532625746;5833.620814647034;5309.601779866525;5312.5218730314455;5314.016906872241;5326.174442961347;5334.973325133427;6184.134221209034;6295.150154729053;6343.429091381706;6368.554201205964;6373.3945275198785;6206.875862482815;6221.688915554114;6242.968785156045;6244.250689917239;6252.5935814171935;6274.341194174546;6295.748170073329;6316.05259211122;6323.936760632335;6344.016677415008;6000.249968753906;6107.480864126422;6130.111133885651;6179.073139029002;6193.969030154821;6235.064740288993;6255.18682571281;6268.43584077417;6270.686465676789;6278.843028924313;5908.911366329595;6080.604760690541;6083.270007599116;6094.421030002142;6097.054956481752;6040.244969378828;6084.969575152273;6095.603785753912;6107.755689772359;6128.693565321805;5868.823935281948;5903.586748927534;5918.408159184047;5921.851953701192;5927.288725352985;5842.649441033382;5925.703714814156;6063.302720187235;6081.996470582304;6111.591738512148;4956.529129732669;5905.852353691193;5917.437843404869;5933.347331793413;5955.523558115254 10:11:18 INFO - PROCESS | 1674 | |1;ext.html;476.1310608140145;509.6687153350322;572.0446853754232;574.7269797398761;576.2796504369538;28736.281592960186;29698.406031879378;36995.44506832396;37249;37398.62601373986;39587.812365629004;39999.20001599973;40002.7999860001;40128.39807402891;40273.79178624639;9351.01814309498;9544.188743956738;9548.236141108695;9555.474448905308;9566.186874115709;9486.098820612031;9679.177269932065;9680;9682.661106861262;9704.029597040275;9629.27780416468;9723.90276097237;9724.465154416504;9737.977512361207;9757.024297570257;9625.71122866315;9695.884973228098;9713.660021899235;9720.95139524305;9722.222222222204;9429.15137637616;9597.568109435093;9603.807923841485;9613.134817866356;9631.181349585293;38892.02769930746;39218.60781392178;39238.80380598107;39301.41047884284;39332.80333598314;3169.4453470642547;3192.154079169022;3207.983960080208;3464.4630082337276;3787.810609469543;27499;27983.72016279852;28294.15117546477;28459.67962930665;29225.41549169026;2757.2555410039377;2788.9581656275172;2863.3271181272385;2901.956470652942;2983.8806447742063;362813.18593406864;363157;364468.17765911267;364937;365363;36943.81528092342;44248.55751442509;61059.38940610626;61921;62030;43182;43220.56779432228;43459.34810977838;43554;43571.12857742827;14992.175430351217;15147;15157.772633410508;15167.696646067017;15204.315805788767;12068.456919438646;12140.575079872162;12154.939225303817;12165.635030949086;12178.75642487163;14048.08687435334;14258.287085645676;14322.785158222636;14323.427062917366;14427.639309017148;5311.973440132774;5947.672877991752;6064.66644334557;6065.090236464477;6080;956.8134213828375;993.9403635781877;1031.9484025798681;1104.4422566603814;1104.6630777612745;30575.541366879068;30632.693673062982;30899.536506952412;31227.843860781006;32403.675963240064;920.1902325953118;1044;1073.1146803886825;1090.9727256818485;1136.72718547548;13788.655283617989;14077.85922140786;14090.71818563623;14156.150630962175;14163.433462661584;653481;664063;664737;666509;676281;46027.30959035617;55103;55816.720916395156;56199.438005620235;56211;1393;1400.103933482572;1412.6750847305177;1413.1168019987508;1550.9686058771017;23655.29034128979;28156.577651335658;28276.85861570679;28828.279293017844;29780.255493612833;48284;48803;49199.01601968012;49264;49488.752556238425;497062;497308;497349;497515.27331994177;498199;30792.53811192879;31356.529652055695;31669.683303166672;31870.840645796623;31979.88070417524;41519.96200095022;41914;42227;42643.36034959416;43118.35322470228;33986;34901.12747181341;35674;35700.821495892356;35777.64222357743;34714.30571388508;35472.11319717028;35610.82194589011;35674;35700.821495892356;28224.43551129007;29956.95150669716;34811.65188348084;34864.47703284402;35214;29032.98384556615;30873.8456307726;30943.226419339695;31129.688703113585;31678.524822127227;22959.60366994431;23665.171718989754;23794;23814.555213277985;23827.880860595586 10:11:18 INFO - PROCESS | 1674 | |2;jquery.html;330.71558459724633;342.10539439366056;360.11950780342073;361.6004315231669;367.3736279643205;16050.27773750181;16585.83414165858;19563;19587.902060489712;20803.895980520116;16542.007479551234;16933.06868122253;20355.084021219045;20413.48966275844;20424.59150816983;4977.502249775021;5153.149730294515;5234.398044224906;5235.11003129467;5241.8951620967555;3946.842126314944;5181.870453238662;5240.554552862992;5268.710220937847;5338.46615338465;5028.723420211887;5989.730462129193;6037.184980027706;6040.909386359208;6041.577089603729;5672.829815105532;5802.419758024206;6003.459688628022;6023.337432882379;6501.414872661436;5676.829695109153;5708.143778433268;5709.62887412321;5717;5729.570282228808;13162.893936970135;13586.320683965761;13806.033577649468;13831.308434578332;13835.723285534334;1925.9903700481548;2016.405160477648;2098.748150221968;2104.515961328903;2145.324222869807;9572.856407153899;9713;9984.750381240527;10031.699049028468;10213.2850700451;1711.6319991201826;1721.9913900430417;1728.7061199596099;1732.5322163015915;1736.2794440307384;76947.61526192333;103487.48256258745;105036.42445363326;105559;110812.4459377698;10925.726856828484;11339.546418143182;11352.716182095348;11355.318680879174;11460.598879039193;13557.322133893265;13561.660958476117;13616.114952528054;13623.910087193199;13689.110207836458;8400.915990840012;8502.489850608983;8527.488350698977;8588.52763098023;8608.655653773903;8669.479831210021;8674.262687671619;8703.43427677199;8741.956290218635;8750.737477875675;3706.3328600851564;4366.868993930188;4443.600075993176;4489.9551004490195;4510.684252102321;1598.3207136966744;1797.6494583556082;1846.18767742193;1867.9252829886925;1868.560888191274;911.2391153386997;940.7177846645978;1044.2324891204958;1071.919606029551;1089.7493576477455;18035;18756.24975001012;18808.623827523374;19748.11133498996;20476;859.5616235719828;996.8056229035268;1009.1371877045168;1019.9031092046243;1026.8716410448694;10962.287451315799;11095.44522773858;11123.777524449466;11139.944300278608;11144.05275551571;356372;510767;514565;573356;596702;74997.25002750012;98124.52813207808;101224.98775012155;114752;119028.40485797689;959.4051687953513;982.3418309732497;995.4176806568094;999.2954966748571;1002.4837208837455;14958.326875290855;18200;18322.083895804888;18408.35570755017;18447.815521844608;51256.23115653193;51930.48069519408;51983.70040749011;52775;53303;68043;70002.64998674973;70017.33102253024;71452.28547714664;71741.6412917932;8066.1127275998415;8220.83558328842;8224.876626850482;8274.917250827415;8336.416450848383;10615.363078215332;13104.279264640536;13542.187468751907;13796.379162937492;14097.647558810702;11349.602763903224;11835.644930652094;12031.4585843639;12033.217840840318;12053.75892482163;11518.308901465938;11585;11810.586629467927;12017.63947081589;12101.81847272274;11427.200095993534;11972.401379931143;12003.159778815749;12047.457864395948;12073.879261207276;7987.92012079895;8036.959815200887;8174.754757357289;8184.959075204586;8245.422820402515;8482.703105391529;10707.464626768786;11863.288202707865;11888.940555297168;12050.09624278165 10:11:18 INFO - PROCESS | 1674 | |3;mootools.html;1403.6631208509948;1523.6190952261934;1531.594127556197;1543.3672194400292;1895.431370588823;7811.570363629998;8420.494770313779;8585.313174946004;8594.871076933836;8614.009388920269;8303.95848020759;8557.957210213955;8562.400631955765;8566.700165494209;8569.785755356119;2139.5399989002362;2384.29663249341;2434.0507202191116;2436.8903399347073;2455.0057226823164;2433.963490547634;2451.044092803808;2473.468204336067;2479.2810085075307;2479.913203037894;2404.110479122727;2434.318390850565;2434.987825060872;2437.0373702387546;2437.695288088989;2359.6578496118054;2372.9762702372927;2395.8083353331867;2400.423898264413;2404.8797560121925;2372.5966585680476;2405.0740464920955;2405.867677277749;2406.7713567211263;2419.2379400488967;8366.790830229233;8461.95769021151;8467.237948584596;8474.898263225803;8478.321734261244;5272.103742363807;5359.651622644516;5396.946030539683;5418.4039755626845;5422.105352616813;3566.5363502744735;3600.6939410150167;3687.704983601332;3689.3728066228537;3703.6296370363016;1021.2340744441668;1038.7247379444452;1042.4318746283293;1067.7330667333167;1068.385678235018;11436.428178591037;11457.828132577935;11583.18917675763;11603.477843496978;11621.012213961823;4789.473157952622;4822.373091498153;4869.610431165498;4916.754162291871;4925.926111108336;10086.24353173515;10111.7472063199;10113.64602238918;10127.088562029452;10127.64553240633;4832.95167048332;5447.536959358499;5459.071957767189;5480.534154596824;5488.890222195534;4437.267850804646;4497.662675299365;4516.593506584358;4738.218193997952;4889.413270407503;3871.5741268460447;3892.1826416452295;3908.511436070491;3948.881533553998;3952.1898010907694;1081.324172392255;1293.780057390246;1298.1821452485062;1299.7725398055302;1309.8952083833271;1269.6889262130837;1298.0199949038604;1299.7010687541917;1345.838499380061;1365.4401695304878;7922.801929951682;7977.7207797726805;7988.320992715568;7991.0810256821205;8000.039995200613;414.42188147534023;467.21274652211133;471.14957501709057;475.15185394071415;478.19662966216396;6032.819015429544;6105.32841387447;6106.908396374058;6123.510119190454;6128.417800308964;9920.851187232198;10593.993570610779;10665.573377064831;10668.839967400496;10676.359418434919;8919.777005574913;8951.462912225288;10314.27800054004;10515.894841051491;10580.576776928836;8001.519908805491;8121.309688676529;8142.4300298978505;8192.54940978252;8209.220124088202;7644.885326719992;7718.228177182237;7723.227677232457;7740.187280335484;7750;7824.765257042298;9198.908010919806;9460.337776355589;9498.810023799348;9514.571844267162;9589.760255993657;9717.6598819041;9859.30984831055;9866.703998880044;9950.651727189514;6599.571027883172;6798.93201067983;7024.578525288499;7327.523710958771;7407.66665500043;7917.920820791718;7919.366450684047;7973.083095443866;7983.920160798318;7996.920030799618;7009.334113259232;7093.609851458219;7113.644317784194;7227;7274.745383911538;7046.260142684944;7048.118985126859;7052.2242553318065;7185.497015208885;7203.603801790951;7375.37309328713;7513.4740568159705;7543.245675432413;7550.735724249845;7551.131619863786;6776.15298087739;6884.242733299433;6886.724531018703;6889.242183359726;6899.275576064441;6835.863282734417;6934.826629334307;6986.895196571953;6990.26602206761;6991.965040174767 10:11:18 INFO - PROCESS | 1674 | |4;prototype.html;267.4530584953769;326.48252519756187;327.77056060757474;332.2027134876298;337.701134495971;6391.616503009817;6558.606483610986;6563.868722625544;6617.602943823374;6619.966900165498;6485.124508191393;6618.338166183379;6622.801315960517;6623.2383275923285;6644.468442524599;4598.494165641777;4674.6494012949;4721.740304283263;4903.779329930153;4918.827841025565;3925.685945124383;4771.212749896263;4818.831340903069;4840.806367745286;4854.296127061574;3907.7069219808627;4769.5945844603075;4782.545658162469;4808.2066459034395;4835.661503694742;3837.635424634683;4556.430446194226;4645.558671926162;4652.906941861178;4787.61699064074;3717.8698745544048;3734.290484807878;3962.2075584883137;4040.7777572233517;4053.8783836484954;6168.414000669929;6176.4749996250375;6186.56694031418;6201.81394558164;6208.689565521751;5511.9724401378135;5514.6691198527815;5527.917081243784;5534.225208470817;5542.972285138589;6829;6842.6578671066745;6849.760258390932;6934.47991400642;6957.547759395623;4371.431713877176;4528.50186479487;4543.909121817545;4549.681522293441;4568.200564901163;7290.27097290272;7310.707571697126;7355.485116041879;7364.5949472778975;7372.299631535049;4592.448906131285;4593.173228818845;4595.540445955445;4597.632189424838;4599.793009314589;4652.790624421909;4659.347691323217;4665.813367465264;4672.252439609714;4688.484266730657;5544;5549.334079910436;5554.694491802989;5555.055640541118;5564.582656300713;6725.05849181115;6988.19635741886;6990.021397004423;7020.7893763187185;7032.964835175893;1604.9518514444585;1609.1632351177323;1621.5459671292058;1626.349460215923;1629.2261175941333;1030.5311083457009;1031.8916513766096;1042.3849928542197;1051.1643243621186;1054.0829478353728;5990.161377407167;6117.418845209698;6662.56693314933;6668.766593169313;6675.232348279913;7118;7240.275972402717;7287.526310789782;7297.233790452032;7311.305425984523;6706.22878368984;6730.259671436138;6746.595204287759;6759.155105611799;6777.49168812341;3868.3423817951016;3897.395903634941;3899.2396482685604;3900.239453306578;3902.8829135125993;7390.7413240536325;7601.581912994728;7634.923650763532;7751.457397982087;7768.495047821873;7543.283388078124;7546.924530754732;7567.394608431312;7572.39420846331;7574.621268936531;7709.151993280735;7710.460267781202;7715.151333353327;7730.884036739453;7737.574433406104;7330.780076597711;7343.669534870837;7350.595717235603;7351.705931762884;7361.926380736124;6890.517663763689;7182.748603798842;7213.2065472799;7219.386352160125;7224.89162662571;7640.923590764243;7687.192844751445;7693.615319233904;7695.576743279174;7718;4635.7218566886095;4668.78990445424;4676.111538807616;4679;4682.461516925598;6673.332666733482;7263.963680181565;7310.195878453473;7313.23211062852;7328.3770879473705;6859.794206173823;7057.153141623038;7100.218975912542;7102.857942841218;7104.218535960937;7023.894641580278;7089.503734738519;7090.539114957717;7095.609741464269;7111.217766045627;6439.873022221186;6916.55042422241;6937.7571784987285;6940.02839602446;6950.20072691647;6281.497480201664;6802.3537763912345;7074.292570742885;7081.504294699322;7100.289971002859;6637.601743895381;6801.965990170018;6807.897881531682;6893.448524118159;6929.1684997800585 10:11:18 INFO - PROCESS | 1674 | |5;yui.html;671.1845108193545;680.3876511139973;711.8789805733024;725.818545363659;748.947573669843;14769;14848.183349915764;15029.098254104734;15048.398064077437;15069.62325941852;11557.422128893542;13983.300834958261;14160.645983850409;14174.574762757135;14261.572152835406;715.2597062040788;724.3480867219519;869.2871845087031;874.9081346458626;896.5651658945407;888.3825741109931;888.999875140467;892.857142857143;897.9269772621719;899.3974037394928;759.1080480435467;939.9107084826965;945.5319616789699;946.4179529589322;946.8532377481501;919.586186216202;927.7819712367589;928.308410234373;930.1721467893547;931.7624005878457;688.5111570784749;688.6694386694364;689.7827184436886;691.9965400173018;696.4324075878194;14442.711145777026;14533.927330363385;14536.709265814625;14545.709085818224;14572.125672459686;12747.298898560575;12893.35533223335;12999;13251.13867598603;13465.394057267447;9841.311108222428;9987.077534791253;10308.278420510567;10424.218183636258;10773.5690572377;3980.7412518186225;4051.6150965658217;4079.796010199478;4098.508179018507;4171.228322760299;84154.57922710408;84749;85870.57064714699;86029;86486.56756716239;9256.259499240045;9259.490728009889;9325.626974921062;9518.572763945289;9581.952090239503;20292.79707202909;20521.794782052286;20531.178752850017;20542.794572054387;20627.38117856467;7362.7423040193335;7402.777916662509;7424.443166762407;7475.476716629783;7564.735234266775;4151.750894946253;4159.272127377697;4175.31107367287;4218.1985422770185;4235.110626768414;3448.2758620689433;3461.8442170102408;3477.1480987158307;3478.200013996795;3489.65103489649;564.3171762167741;610.7526451787033;623.2054130982942;623.8159742875863;642.887494688437;514.5986130817968;544.5752313195713;548.1257394455837;603.3212635784743;608.9817305480842;8155.918440815516;8482.618282177316;8666.350023748244;8751.606177722018;8764.167404096728;499.186326288148;562.2690502346933;617.388785102754;626.3503201125819;638.3839594791049;3491.650834916488;3976.701747368959;3989.2819292527042;4278.978605106954;4383.758893260838;86801.56599216964;87076;90025.54987225153;91414.62878056834;92400.53799731092;76664;80836.59581702054;83831.5808420954;83906;84206.15793842106;54816.72591637096;70394.2960570398;70688.93966590505;70779.64610176916;72208.63895680488;7919.524828510308;8154.0215174179475;8645.524496152771;8773.122687731176;8933.106689331014;46129;47109.528904711886;47257;47650.52349476461;51878.48121518736;64640;66990.66504667446;68184.6590767043;70121.94817077646;72394.27605724086;11055.391953442639;11126.22226634264;11288.830667540158;11363.829542557034;11676.065914726632;11973.281603103842;12015.279083255033;12161.148719589544;12256.693582660148;12438.56465023756;9781.657641982496;11247.550097995989;11954.760904781682;12383.504659813507;12395.25628462259;9752;11328.830067548828;11539.596114135966;12070.818937715765;12294.569690060805;10740.409277489813;10821.350718956888;11305.378204198849;11372.033377163034;11600.767984640428;8055.556944368116;8906.153915378029;8992.055834137322;9442.48066356357;9591;9110.7266781994;9160.221381182673;9309.813803724022;10091.0708677902;10165.84751228747 10:11:18 INFO - PROCESS | 1674 | __end_tp_report 10:11:18 INFO - PROCESS | 1674 | __start_cc_report 10:11:18 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1060 10:11:18 INFO - PROCESS | 1674 | __end_cc_report 10:11:18 INFO - PROCESS | 1674 | __startTimestamp1456251078848__endTimestamp 10:11:18 INFO - PROCESS | 1674 | 10:11:18 INFO - PROCESS | 1674 | ------- Summary: start ------- 10:11:18 INFO - PROCESS | 1674 | Number of tests: 6 10:11:18 INFO - PROCESS | 1674 | 10:11:18 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5710.17 Median:5918.41 stddev:632.56 (10.7%) stddev-sans-first:603.56 10:11:18 INFO - PROCESS | 1674 | Values: 3219.2 3514.9 3535.9 3551.9 3593.4 5588.7 5636.4 5640.9 5651.8 5668.4 5600.9 5662.1 5683.1 5745.5 5748.1 5062.1 5111.3 5131.9 5153.6 5188.3 5152.5 5163.5 5181.7 5190.6 5254.8 5096.5 5103.9 5190.1 5214.8 5245.6 5156.0 5173.3 5181.1 5181.2 5237.7 5062.2 5102.6 5131.4 5146.6 5210.5 5528.4 5568.1 5623.3 5664.5 5665.3 6204.4 6209.9 6210.0 6218.8 6223.3 6101.5 6218.7 6284.5 6285.6 6309.0 5754.7 5770.3 5776.1 5800.8 5818.4 6254.6 6264.7 6265.4 6267.6 6281.8 5961.1 5985.5 6053.6 6083.9 6103.4 6111.3 6135.8 6136.2 6138.6 6145.9 6095.7 6107.7 6133.7 6137.4 6138.7 6103.9 6140.3 6216.4 6216.5 6272.3 4849.8 4857.3 4860.5 4892.1 4896.6 4167.9 4327.1 4377.1 4377.2 4377.6 5477.6 5725.2 5754.3 5763.7 5769.9 6155.8 6160.9 6163.3 6172.1 6179.1 5794.2 5798.2 5808.6 5826.7 5833.6 5309.6 5312.5 5314.0 5326.2 5335.0 6184.1 6295.2 6343.4 6368.6 6373.4 6206.9 6221.7 6243.0 6244.3 6252.6 6274.3 6295.7 6316.1 6323.9 6344.0 6000.2 6107.5 6130.1 6179.1 6194.0 6235.1 6255.2 6268.4 6270.7 6278.8 5908.9 6080.6 6083.3 6094.4 6097.1 6040.2 6085.0 6095.6 6107.8 6128.7 5868.8 5903.6 5918.4 5921.9 5927.3 5842.6 5925.7 6063.3 6082.0 6111.6 4956.5 5905.9 5917.4 5933.3 5955.5 10:11:18 INFO - PROCESS | 1674 | 10:11:18 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:63275.31 Median:364702.59 stddev:140272.75 (38.5%) stddev-sans-first:140587.01 10:11:18 INFO - PROCESS | 1674 | Values: 476.1 509.7 572.0 574.7 576.3 28736.3 29698.4 36995.4 37249.0 37398.6 39587.8 39999.2 40002.8 40128.4 40273.8 9351.0 9544.2 9548.2 9555.5 9566.2 9486.1 9679.2 9680.0 9682.7 9704.0 9629.3 9723.9 9724.5 9738.0 9757.0 9625.7 9695.9 9713.7 9721.0 9722.2 9429.2 9597.6 9603.8 9613.1 9631.2 38892.0 39218.6 39238.8 39301.4 39332.8 3169.4 3192.2 3208.0 3464.5 3787.8 27499.0 27983.7 28294.2 28459.7 29225.4 2757.3 2789.0 2863.3 2902.0 2983.9 362813.2 363157.0 364468.2 364937.0 365363.0 36943.8 44248.6 61059.4 61921.0 62030.0 43182.0 43220.6 43459.3 43554.0 43571.1 14992.2 15147.0 15157.8 15167.7 15204.3 12068.5 12140.6 12154.9 12165.6 12178.8 14048.1 14258.3 14322.8 14323.4 14427.6 5312.0 5947.7 6064.7 6065.1 6080.0 956.8 993.9 1031.9 1104.4 1104.7 30575.5 30632.7 30899.5 31227.8 32403.7 920.2 1044.0 1073.1 1091.0 1136.7 13788.7 14077.9 14090.7 14156.2 14163.4 653481.0 664063.0 664737.0 666509.0 676281.0 46027.3 55103.0 55816.7 56199.4 56211.0 1393.0 1400.1 1412.7 1413.1 1551.0 23655.3 28156.6 28276.9 28828.3 29780.3 48284.0 48803.0 49199.0 49264.0 49488.8 497062.0 497308.0 497349.0 497515.3 498199.0 30792.5 31356.5 31669.7 31870.8 31979.9 41520.0 41914.0 42227.0 42643.4 43118.4 33986.0 34901.1 35674.0 35700.8 35777.6 34714.3 35472.1 35610.8 35674.0 35700.8 28224.4 29957.0 34811.7 34864.5 35214.0 29033.0 30873.8 30943.2 31129.7 31678.5 22959.6 23665.2 23794.0 23814.6 23827.9 10:11:18 INFO - PROCESS | 1674 | 10:11:18 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:30632.58 Median:20639.95 stddev:86110.33 (417.2%) stddev-sans-first:86321.83 10:11:18 INFO - PROCESS | 1674 | Values: 330.7 342.1 360.1 361.6 367.4 16050.3 16585.8 19563.0 19587.9 20803.9 16542.0 16933.1 20355.1 20413.5 20424.6 4977.5 5153.1 5234.4 5235.1 5241.9 3946.8 5181.9 5240.6 5268.7 5338.5 5028.7 5989.7 6037.2 6040.9 6041.6 5672.8 5802.4 6003.5 6023.3 6501.4 5676.8 5708.1 5709.6 5717.0 5729.6 13162.9 13586.3 13806.0 13831.3 13835.7 1926.0 2016.4 2098.7 2104.5 2145.3 9572.9 9713.0 9984.8 10031.7 10213.3 1711.6 1722.0 1728.7 1732.5 1736.3 76947.6 103487.5 105036.4 105559.0 110812.4 10925.7 11339.5 11352.7 11355.3 11460.6 13557.3 13561.7 13616.1 13623.9 13689.1 8400.9 8502.5 8527.5 8588.5 8608.7 8669.5 8674.3 8703.4 8742.0 8750.7 3706.3 4366.9 4443.6 4490.0 4510.7 1598.3 1797.6 1846.2 1867.9 1868.6 911.2 940.7 1044.2 1071.9 1089.7 18035.0 18756.2 18808.6 19748.1 20476.0 859.6 996.8 1009.1 1019.9 1026.9 10962.3 11095.4 11123.8 11139.9 11144.1 356372.0 510767.0 514565.0 573356.0 596702.0 74997.3 98124.5 101225.0 114752.0 119028.4 959.4 982.3 995.4 999.3 1002.5 14958.3 18200.0 18322.1 18408.4 18447.8 51256.2 51930.5 51983.7 52775.0 53303.0 68043.0 70002.6 70017.3 71452.3 71741.6 8066.1 8220.8 8224.9 8274.9 8336.4 10615.4 13104.3 13542.2 13796.4 14097.6 11349.6 11835.6 12031.5 12033.2 12053.8 11518.3 11585.0 11810.6 12017.6 12101.8 11427.2 11972.4 12003.2 12047.5 12073.9 7987.9 8037.0 8174.8 8185.0 8245.4 8482.7 10707.5 11863.3 11888.9 12050.1 10:11:18 INFO - PROCESS | 1674 | 10:11:18 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5895.52 Median:5407.68 stddev:3110.11 (57.5%) stddev-sans-first:3100.50 10:11:18 INFO - PROCESS | 1674 | Values: 1403.7 1523.6 1531.6 1543.4 1895.4 7811.6 8420.5 8585.3 8594.9 8614.0 8304.0 8558.0 8562.4 8566.7 8569.8 2139.5 2384.3 2434.1 2436.9 2455.0 2434.0 2451.0 2473.5 2479.3 2479.9 2404.1 2434.3 2435.0 2437.0 2437.7 2359.7 2373.0 2395.8 2400.4 2404.9 2372.6 2405.1 2405.9 2406.8 2419.2 8366.8 8462.0 8467.2 8474.9 8478.3 5272.1 5359.7 5396.9 5418.4 5422.1 3566.5 3600.7 3687.7 3689.4 3703.6 1021.2 1038.7 1042.4 1067.7 1068.4 11436.4 11457.8 11583.2 11603.5 11621.0 4789.5 4822.4 4869.6 4916.8 4925.9 10086.2 10111.7 10113.6 10127.1 10127.6 4833.0 5447.5 5459.1 5480.5 5488.9 4437.3 4497.7 4516.6 4738.2 4889.4 3871.6 3892.2 3908.5 3948.9 3952.2 1081.3 1293.8 1298.2 1299.8 1309.9 1269.7 1298.0 1299.7 1345.8 1365.4 7922.8 7977.7 7988.3 7991.1 8000.0 414.4 467.2 471.1 475.2 478.2 6032.8 6105.3 6106.9 6123.5 6128.4 9920.9 10594.0 10665.6 10668.8 10676.4 8919.8 8951.5 10314.3 10515.9 10580.6 8001.5 8121.3 8142.4 8192.5 8209.2 7644.9 7718.2 7723.2 7740.2 7750.0 7824.8 9198.9 9460.3 9498.8 9514.6 9589.8 9717.7 9859.3 9866.7 9950.7 6599.6 6798.9 7024.6 7327.5 7407.7 7917.9 7919.4 7973.1 7983.9 7996.9 7009.3 7093.6 7113.6 7227.0 7274.7 7046.3 7048.1 7052.2 7185.5 7203.6 7375.4 7513.5 7543.2 7550.7 7551.1 6776.2 6884.2 6886.7 6889.2 6899.3 6835.9 6934.8 6986.9 6990.3 6992.0 10:11:18 INFO - PROCESS | 1674 | 10:11:18 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5740.67 Median:6621.38 stddev:1870.37 (28.2%) stddev-sans-first:1829.94 10:11:18 INFO - PROCESS | 1674 | Values: 267.5 326.5 327.8 332.2 337.7 6391.6 6558.6 6563.9 6617.6 6620.0 6485.1 6618.3 6622.8 6623.2 6644.5 4598.5 4674.6 4721.7 4903.8 4918.8 3925.7 4771.2 4818.8 4840.8 4854.3 3907.7 4769.6 4782.5 4808.2 4835.7 3837.6 4556.4 4645.6 4652.9 4787.6 3717.9 3734.3 3962.2 4040.8 4053.9 6168.4 6176.5 6186.6 6201.8 6208.7 5512.0 5514.7 5527.9 5534.2 5543.0 6829.0 6842.7 6849.8 6934.5 6957.5 4371.4 4528.5 4543.9 4549.7 4568.2 7290.3 7310.7 7355.5 7364.6 7372.3 4592.4 4593.2 4595.5 4597.6 4599.8 4652.8 4659.3 4665.8 4672.3 4688.5 5544.0 5549.3 5554.7 5555.1 5564.6 6725.1 6988.2 6990.0 7020.8 7033.0 1605.0 1609.2 1621.5 1626.3 1629.2 1030.5 1031.9 1042.4 1051.2 1054.1 5990.2 6117.4 6662.6 6668.8 6675.2 7118.0 7240.3 7287.5 7297.2 7311.3 6706.2 6730.3 6746.6 6759.2 6777.5 3868.3 3897.4 3899.2 3900.2 3902.9 7390.7 7601.6 7634.9 7751.5 7768.5 7543.3 7546.9 7567.4 7572.4 7574.6 7709.2 7710.5 7715.2 7730.9 7737.6 7330.8 7343.7 7350.6 7351.7 7361.9 6890.5 7182.7 7213.2 7219.4 7224.9 7640.9 7687.2 7693.6 7695.6 7718.0 4635.7 4668.8 4676.1 4679.0 4682.5 6673.3 7264.0 7310.2 7313.2 7328.4 6859.8 7057.2 7100.2 7102.9 7104.2 7023.9 7089.5 7090.5 7095.6 7111.2 6439.9 6916.6 6937.8 6940.0 6950.2 6281.5 6802.4 7074.3 7081.5 7100.3 6637.6 6802.0 6807.9 6893.4 6929.2 10:11:18 INFO - PROCESS | 1674 | 10:11:18 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18349.81 Median:625.08 stddev:25931.02 (4148.4%) stddev-sans-first:25969.79 10:11:18 INFO - PROCESS | 1674 | Values: 671.2 680.4 711.9 725.8 748.9 14769.0 14848.2 15029.1 15048.4 15069.6 11557.4 13983.3 14160.6 14174.6 14261.6 715.3 724.3 869.3 874.9 896.6 888.4 889.0 892.9 897.9 899.4 759.1 939.9 945.5 946.4 946.9 919.6 927.8 928.3 930.2 931.8 688.5 688.7 689.8 692.0 696.4 14442.7 14533.9 14536.7 14545.7 14572.1 12747.3 12893.4 12999.0 13251.1 13465.4 9841.3 9987.1 10308.3 10424.2 10773.6 3980.7 4051.6 4079.8 4098.5 4171.2 84154.6 84749.0 85870.6 86029.0 86486.6 9256.3 9259.5 9325.6 9518.6 9582.0 20292.8 20521.8 20531.2 20542.8 20627.4 7362.7 7402.8 7424.4 7475.5 7564.7 4151.8 4159.3 4175.3 4218.2 4235.1 3448.3 3461.8 3477.1 3478.2 3489.7 564.3 610.8 623.2 623.8 642.9 514.6 544.6 548.1 603.3 609.0 8155.9 8482.6 8666.4 8751.6 8764.2 499.2 562.3 617.4 626.4 638.4 3491.7 3976.7 3989.3 4279.0 4383.8 86801.6 87076.0 90025.5 91414.6 92400.5 76664.0 80836.6 83831.6 83906.0 84206.2 54816.7 70394.3 70688.9 70779.6 72208.6 7919.5 8154.0 8645.5 8773.1 8933.1 46129.0 47109.5 47257.0 47650.5 51878.5 64640.0 66990.7 68184.7 70121.9 72394.3 11055.4 11126.2 11288.8 11363.8 11676.1 11973.3 12015.3 12161.1 12256.7 12438.6 9781.7 11247.6 11954.8 12383.5 12395.3 9752.0 11328.8 11539.6 12070.8 12294.6 10740.4 10821.4 11305.4 11372.0 11600.8 8055.6 8906.2 8992.1 9442.5 9591.0 9110.7 9160.2 9309.8 10091.1 10165.8 10:11:18 INFO - PROCESS | 1674 | -------- Summary: end -------- 10:11:18 INFO - PROCESS | 1674 | 10:11:19 INFO - TEST-INFO | 1674: exit 0 10:11:19 INFO - TEST-OK | dromaeo_css | took 1112961ms 10:11:19 INFO - TEST-START | kraken 10:11:19 INFO - operating with platform_type : mac_ 10:11:19 INFO - Initialising browser for kraken test... 10:11:19 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpUHBUBa/profile http://localhost:49278/getInfo.html) 10:11:21 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 10:11:21 INFO - PROCESS | 1679 | colorDepth:24 10:11:21 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 10:11:21 INFO - PROCESS | 1679 | __metrics 10:11:21 INFO - PROCESS | 1679 | 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" 10:11:21 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:11:21 INFO - TEST-INFO | 1679: exit 0 10:11:21 INFO - Browser initialized. 10:11:21 INFO - Running cycle 1/1 for kraken test... 10:11:21 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpUHBUBa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:33 INFO - PROCESS | 1681 | RSS: Main: 244506624 10:11:33 INFO - PROCESS | 1681 | 10:11:36 INFO - PROCESS | 1681 | 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) 10:11:36 INFO - PROCESS | 1681 | RSS: Main: 290140160 10:11:36 INFO - PROCESS | 1681 | 10:11:39 INFO - PROCESS | 1681 | 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) 10:11:40 INFO - PROCESS | 1681 | RSS: Main: 300306432 10:11:40 INFO - PROCESS | 1681 | 10:11:43 INFO - PROCESS | 1681 | 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) 10:11:44 INFO - PROCESS | 1681 | RSS: Main: 285720576 10:11:44 INFO - PROCESS | 1681 | 10:11:45 INFO - PROCESS | 1681 | 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) 10:11:46 INFO - PROCESS | 1681 | RSS: Main: 287113216 10:11:46 INFO - PROCESS | 1681 | 10:11:48 INFO - PROCESS | 1681 | 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) 10:11:49 INFO - PROCESS | 1681 | RSS: Main: 288600064 10:11:49 INFO - PROCESS | 1681 | 10:11:51 INFO - PROCESS | 1681 | 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) 10:11:52 INFO - PROCESS | 1681 | RSS: Main: 289505280 10:11:52 INFO - PROCESS | 1681 | 10:11:55 INFO - PROCESS | 1681 | 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) 10:11:55 INFO - PROCESS | 1681 | RSS: Main: 289832960 10:11:55 INFO - PROCESS | 1681 | 10:11:58 INFO - PROCESS | 1681 | 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) 10:11:59 INFO - PROCESS | 1681 | RSS: Main: 290529280 10:11:59 INFO - PROCESS | 1681 | 10:12:00 INFO - PROCESS | 1681 | 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) 10:12:01 INFO - PROCESS | 1681 | RSS: Main: 324816896 10:12:01 INFO - PROCESS | 1681 | 10:12:03 INFO - PROCESS | 1681 | 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) 10:12:03 INFO - PROCESS | 1681 | RSS: Main: 323543040 10:12:03 INFO - PROCESS | 1681 | 10:12:05 INFO - PROCESS | 1681 | 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) 10:12:06 INFO - PROCESS | 1681 | RSS: Main: 332591104 10:12:06 INFO - PROCESS | 1681 | 10:12:09 INFO - PROCESS | 1681 | 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) 10:12:09 INFO - PROCESS | 1681 | RSS: Main: 333234176 10:12:09 INFO - PROCESS | 1681 | 10:12:12 INFO - PROCESS | 1681 | 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) 10:12:12 INFO - PROCESS | 1681 | RSS: Main: 332779520 10:12:12 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | 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) 10:12:14 INFO - PROCESS | 1681 | RSS: Main: 393072640 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | __start_tp_report 10:12:14 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 10:12:14 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 10:12:14 INFO - PROCESS | 1681 | |i|pagename|runs| 10:12:14 INFO - PROCESS | 1681 | |0;ai-astar;112;110;111;111;112;111;115;110;111;112 10:12:14 INFO - PROCESS | 1681 | |1;audio-beat-detection;157;122;142;153;120;141;138;122;146;140 10:12:14 INFO - PROCESS | 1681 | |2;audio-dft;182;185;186;186;182;182;186;183;183;182 10:12:14 INFO - PROCESS | 1681 | |3;audio-fft;79;78;86;77;56;56;58;80;76;56 10:12:14 INFO - PROCESS | 1681 | |4;audio-oscillator;92;97;125;79;78;84;107;77;78;110 10:12:14 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;86;85;84;90;84;93;85;91;83;90 10:12:14 INFO - PROCESS | 1681 | |6;imaging-darkroom;93;93;93;93;99;93;92;93;92;92 10:12:14 INFO - PROCESS | 1681 | |7;imaging-desaturate;84;107;136;135;85;87;86;85;84;86 10:12:14 INFO - PROCESS | 1681 | |8;json-parse-financial;55;53;53;54;56;53;54;66;52;51 10:12:14 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;63;63;73;74;70;68;67;67;67;68 10:12:14 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;86;84;83;83;83;83;83;84;84;85 10:12:14 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;126;125;128;124;122;131;110;127;134;125 10:12:14 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;140;137;137;140;139;126;137;137;138;139 10:12:14 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;67;66;67;65;66;79;91;91;91;76 10:12:14 INFO - PROCESS | 1681 | __end_tp_report 10:12:14 INFO - PROCESS | 1681 | __start_cc_report 10:12:14 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1122 10:12:14 INFO - PROCESS | 1681 | __end_cc_report 10:12:14 INFO - PROCESS | 1681 | __startTimestamp1456251134749__endTimestamp 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | ------- Summary: start ------- 10:12:14 INFO - PROCESS | 1681 | Number of tests: 14 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:1.43 (1.3%) stddev-sans-first:1.51 10:12:14 INFO - PROCESS | 1681 | Values: 112.0 110.0 111.0 111.0 112.0 111.0 115.0 110.0 111.0 112.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:141.50 stddev:12.97 (9.2%) stddev-sans-first:11.82 10:12:14 INFO - PROCESS | 1681 | Values: 157.0 122.0 142.0 153.0 120.0 141.0 138.0 122.0 146.0 140.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.83 (1.0%) stddev-sans-first:1.83 10:12:14 INFO - PROCESS | 1681 | Values: 182.0 185.0 186.0 186.0 182.0 182.0 186.0 183.0 183.0 182.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:70.20 Median:77.50 stddev:12.10 (15.6%) stddev-sans-first:12.41 10:12:14 INFO - PROCESS | 1681 | Values: 79.0 78.0 86.0 77.0 56.0 56.0 58.0 80.0 76.0 56.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:78.50 stddev:16.69 (21.3%) stddev-sans-first:17.70 10:12:14 INFO - PROCESS | 1681 | Values: 92.0 97.0 125.0 79.0 78.0 84.0 107.0 77.0 78.0 110.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:3.54 (4.0%) stddev-sans-first:3.73 10:12:14 INFO - PROCESS | 1681 | Values: 86.0 85.0 84.0 90.0 84.0 93.0 85.0 91.0 83.0 90.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:2.06 (2.2%) stddev-sans-first:2.18 10:12:14 INFO - PROCESS | 1681 | Values: 93.0 93.0 93.0 93.0 99.0 93.0 92.0 93.0 92.0 92.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:85.00 stddev:21.16 (24.9%) stddev-sans-first:21.87 10:12:14 INFO - PROCESS | 1681 | Values: 84.0 107.0 136.0 135.0 85.0 87.0 86.0 85.0 84.0 86.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.00 stddev:4.22 (7.8%) stddev-sans-first:4.47 10:12:14 INFO - PROCESS | 1681 | Values: 55.0 53.0 53.0 54.0 56.0 53.0 54.0 66.0 52.0 51.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:3.62 (5.3%) stddev-sans-first:3.36 10:12:14 INFO - PROCESS | 1681 | Values: 63.0 63.0 73.0 74.0 70.0 68.0 67.0 67.0 67.0 68.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:0.73 10:12:14 INFO - PROCESS | 1681 | Values: 86.0 84.0 83.0 83.0 83.0 83.0 83.0 84.0 84.0 85.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.50 stddev:6.37 (5.0%) stddev-sans-first:6.75 10:12:14 INFO - PROCESS | 1681 | Values: 126.0 125.0 128.0 124.0 122.0 131.0 110.0 127.0 134.0 125.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.00 Median:138.50 stddev:4.06 (2.9%) stddev-sans-first:4.15 10:12:14 INFO - PROCESS | 1681 | Values: 140.0 137.0 137.0 140.0 139.0 126.0 137.0 137.0 138.0 139.0 10:12:14 INFO - PROCESS | 1681 | 10:12:14 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:77.50 stddev:11.39 (14.7%) stddev-sans-first:11.61 10:12:14 INFO - PROCESS | 1681 | Values: 67.0 66.0 67.0 65.0 66.0 79.0 91.0 91.0 91.0 76.0 10:12:14 INFO - PROCESS | 1681 | -------- Summary: end -------- 10:12:14 INFO - PROCESS | 1681 | 10:12:15 INFO - TEST-INFO | 1681: exit 0 10:12:15 INFO - TEST-OK | kraken | took 56150ms 10:12:15 INFO - SUITE-END | took 1169s 10:12:15 INFO - Completed test suite (00:19:29) 10:12:15 INFO - Working with test: dromaeo_css 10:12:15 INFO - Generating results file: dromaeo_css 10:12:15 INFO - Working with test: kraken 10:12:15 INFO - Generating results file: kraken 10:12:15 INFO - javascript benchmark 10:12:15 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:12:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 10:12:16 INFO - process_Request line: dromaeo_css 7365.43 graph.html#tests=[[72,1,59]] 10:12:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:12:16 INFO - process_Request line: kraken 1418.70 graph.html#tests=[[232,1,59]] 10:12:16 INFO - RETURN: dromaeo_css: 7365.43 10:12:16 INFO - RETURN: kraken: 1418.70 10:12:16 INFO - javascript benchmark 10:12:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3219.1952011996996, 3514.8594056237735, 3535.876244331449, 3551.857925682973, 3593.371160046991, 5588.720563971795, 5636.408177141403, 5640.915386269204, 5651.7739290428435, 5668.404817494161, 5600.915986260199, 5662.122371032487, 5683.119116536933, 5745.540356771458, 5748.080307150857, 5062.114130027249, 5111.258867464216, 5131.923021154686, 5153.613478989072, 5188.325517682696, 5152.458991805863, 5163.483651634825, 5181.663191892534, 5190.584753219733, 5254.81608143715, 5096.4648711885275, 5103.923441148386, 5190.117679994391, 5214.8174813881715, 5245.554127899133, 5156.046131465653, 5173.327467429248, 5181.093308670967, 5181.222816577506, 5237.659552129099, 5062.2406639004075, 5102.591792656615, 5131.4098878629065, 5146.614003949681, 5210.531052205281, 5528.419515950807, 5568.136938774456, 5623.297087864017, 5664.49019588239, 5665.263515742927, 6204.379562043805, 6209.87580248397, 6209.968950155266, 6218.81343559694, 6223.346548612421, 6101.51187904971, 6218.68906554675, 6284.528660350492, 6285.622862628257, 6309.022101574264, 5754.654720716812, 5770.278715160605, 5776.133579962997, 5800.8259752207505, 5818.389069147678, 6254.6247225166635, 6264.686765661699, 6265.404786545271, 6267.623942563369, 6281.780137695158, 5961.105834124916, 5985.491233245136, 6053.606515576474, 6083.908741368883, 6103.35914728956, 6111.266648002268, 6135.7839197735275, 6136.182108626252, 6138.633639632459, 6145.893739127, 6095.710389288371, 6107.664078475637, 6133.662648554283, 6137.447629713258, 6138.7237574309265, 6103.943827031755, 6140.289530736458, 6216.409441103088, 6216.471599913967, 6272.3100458949475, 4849.830255941025, 4857.344258525054, 4860.465348811628, 4892.0705066037335, 4896.559309662148, 4167.895802604899, 4327.1345730853955, 4377.124575084996, 4377.190219809346, 4377.584129507692, 5477.643953143033, 5725.198472213893, 5754.338251101093, 5763.740631671585, 5769.8557536061935, 6155.784547540815, 6160.907586386208, 6163.291221509494, 6172.135900973867, 6179.134921111048, 5794.246747922827, 5798.246227990334, 5808.593398462067, 5826.679532625746, 5833.620814647034, 5309.601779866525, 5312.5218730314455, 5314.016906872241, 5326.174442961347, 5334.973325133427, 6184.134221209034, 6295.150154729053, 6343.429091381706, 6368.554201205964, 6373.3945275198785, 6206.875862482815, 6221.688915554114, 6242.968785156045, 6244.250689917239, 6252.5935814171935, 6274.341194174546, 6295.748170073329, 6316.05259211122, 6323.936760632335, 6344.016677415008, 6000.249968753906, 6107.480864126422, 6130.111133885651, 6179.073139029002, 6193.969030154821, 6235.064740288993, 6255.18682571281, 6268.43584077417, 6270.686465676789, 6278.843028924313, 5908.911366329595, 6080.604760690541, 6083.270007599116, 6094.421030002142, 6097.054956481752, 6040.244969378828, 6084.969575152273, 6095.603785753912, 6107.755689772359, 6128.693565321805, 5868.823935281948, 5903.586748927534, 5918.408159184047, 5921.851953701192, 5927.288725352985, 5842.649441033382, 5925.703714814156, 6063.302720187235, 6081.996470582304, 6111.591738512148, 4956.529129732669, 5905.852353691193, 5917.437843404869, 5933.347331793413, 5955.523558115254], "unit": "score", "name": "dojo.html", "value": 5670.265957781865}, {"lowerIsBetter": false, "replicates": [476.1310608140145, 509.6687153350322, 572.0446853754232, 574.7269797398761, 576.2796504369538, 28736.281592960186, 29698.406031879378, 36995.44506832396, 37249.0, 37398.62601373986, 39587.812365629004, 39999.20001599973, 40002.7999860001, 40128.39807402891, 40273.79178624639, 9351.01814309498, 9544.188743956738, 9548.236141108695, 9555.474448905308, 9566.186874115709, 9486.098820612031, 9679.177269932065, 9680.0, 9682.661106861262, 9704.029597040275, 9629.27780416468, 9723.90276097237, 9724.465154416504, 9737.977512361207, 9757.024297570257, 9625.71122866315, 9695.884973228098, 9713.660021899235, 9720.95139524305, 9722.222222222204, 9429.15137637616, 9597.568109435093, 9603.807923841485, 9613.134817866356, 9631.181349585293, 38892.02769930746, 39218.60781392178, 39238.80380598107, 39301.41047884284, 39332.80333598314, 3169.4453470642547, 3192.154079169022, 3207.983960080208, 3464.4630082337276, 3787.810609469543, 27499.0, 27983.72016279852, 28294.15117546477, 28459.67962930665, 29225.41549169026, 2757.2555410039377, 2788.9581656275172, 2863.3271181272385, 2901.956470652942, 2983.8806447742063, 362813.18593406864, 363157.0, 364468.17765911267, 364937.0, 365363.0, 36943.81528092342, 44248.55751442509, 61059.38940610626, 61921.0, 62030.0, 43182.0, 43220.56779432228, 43459.34810977838, 43554.0, 43571.12857742827, 14992.175430351217, 15147.0, 15157.772633410508, 15167.696646067017, 15204.315805788767, 12068.456919438646, 12140.575079872162, 12154.939225303817, 12165.635030949086, 12178.75642487163, 14048.08687435334, 14258.287085645676, 14322.785158222636, 14323.427062917366, 14427.639309017148, 5311.973440132774, 5947.672877991752, 6064.66644334557, 6065.090236464477, 6080.0, 956.8134213828375, 993.9403635781877, 1031.9484025798681, 1104.4422566603814, 1104.6630777612745, 30575.541366879068, 30632.693673062982, 30899.536506952412, 31227.843860781006, 32403.675963240064, 920.1902325953118, 1044.0, 1073.1146803886825, 1090.9727256818485, 1136.72718547548, 13788.655283617989, 14077.85922140786, 14090.71818563623, 14156.150630962175, 14163.433462661584, 653481.0, 664063.0, 664737.0, 666509.0, 676281.0, 46027.30959035617, 55103.0, 55816.720916395156, 56199.438005620235, 56211.0, 1393.0, 1400.103933482572, 1412.6750847305177, 1413.1168019987508, 1550.9686058771017, 23655.29034128979, 28156.577651335658, 28276.85861570679, 28828.279293017844, 29780.255493612833, 48284.0, 48803.0, 49199.01601968012, 49264.0, 49488.752556238425, 497062.0, 497308.0, 497349.0, 497515.27331994177, 498199.0, 30792.53811192879, 31356.529652055695, 31669.683303166672, 31870.840645796623, 31979.88070417524, 41519.96200095022, 41914.0, 42227.0, 42643.36034959416, 43118.35322470228, 33986.0, 34901.12747181341, 35674.0, 35700.821495892356, 35777.64222357743, 34714.30571388508, 35472.11319717028, 35610.82194589011, 35674.0, 35700.821495892356, 28224.43551129007, 29956.95150669716, 34811.65188348084, 34864.47703284402, 35214.0, 29032.98384556615, 30873.8456307726, 30943.226419339695, 31129.688703113585, 31678.524822127227, 22959.60366994431, 23665.171718989754, 23794.0, 23814.555213277985, 23827.880860595586], "unit": "score", "name": "ext.html", "value": 18651.52569184428}, {"lowerIsBetter": false, "replicates": [330.71558459724633, 342.10539439366056, 360.11950780342073, 361.6004315231669, 367.3736279643205, 16050.27773750181, 16585.83414165858, 19563.0, 19587.902060489712, 20803.895980520116, 16542.007479551234, 16933.06868122253, 20355.084021219045, 20413.48966275844, 20424.59150816983, 4977.502249775021, 5153.149730294515, 5234.398044224906, 5235.11003129467, 5241.8951620967555, 3946.842126314944, 5181.870453238662, 5240.554552862992, 5268.710220937847, 5338.46615338465, 5028.723420211887, 5989.730462129193, 6037.184980027706, 6040.909386359208, 6041.577089603729, 5672.829815105532, 5802.419758024206, 6003.459688628022, 6023.337432882379, 6501.414872661436, 5676.829695109153, 5708.143778433268, 5709.62887412321, 5717.0, 5729.570282228808, 13162.893936970135, 13586.320683965761, 13806.033577649468, 13831.308434578332, 13835.723285534334, 1925.9903700481548, 2016.405160477648, 2098.748150221968, 2104.515961328903, 2145.324222869807, 9572.856407153899, 9713.0, 9984.750381240527, 10031.699049028468, 10213.2850700451, 1711.6319991201826, 1721.9913900430417, 1728.7061199596099, 1732.5322163015915, 1736.2794440307384, 76947.61526192333, 103487.48256258745, 105036.42445363326, 105559.0, 110812.4459377698, 10925.726856828484, 11339.546418143182, 11352.716182095348, 11355.318680879174, 11460.598879039193, 13557.322133893265, 13561.660958476117, 13616.114952528054, 13623.910087193199, 13689.110207836458, 8400.915990840012, 8502.489850608983, 8527.488350698977, 8588.52763098023, 8608.655653773903, 8669.479831210021, 8674.262687671619, 8703.43427677199, 8741.956290218635, 8750.737477875675, 3706.3328600851564, 4366.868993930188, 4443.600075993176, 4489.9551004490195, 4510.684252102321, 1598.3207136966744, 1797.6494583556082, 1846.18767742193, 1867.9252829886925, 1868.560888191274, 911.2391153386997, 940.7177846645978, 1044.2324891204958, 1071.919606029551, 1089.7493576477455, 18035.0, 18756.24975001012, 18808.623827523374, 19748.11133498996, 20476.0, 859.5616235719828, 996.8056229035268, 1009.1371877045168, 1019.9031092046243, 1026.8716410448694, 10962.287451315799, 11095.44522773858, 11123.777524449466, 11139.944300278608, 11144.05275551571, 356372.0, 510767.0, 514565.0, 573356.0, 596702.0, 74997.25002750012, 98124.52813207808, 101224.98775012155, 114752.0, 119028.40485797689, 959.4051687953513, 982.3418309732497, 995.4176806568094, 999.2954966748571, 1002.4837208837455, 14958.326875290855, 18200.0, 18322.083895804888, 18408.35570755017, 18447.815521844608, 51256.23115653193, 51930.48069519408, 51983.70040749011, 52775.0, 53303.0, 68043.0, 70002.64998674973, 70017.33102253024, 71452.28547714664, 71741.6412917932, 8066.1127275998415, 8220.83558328842, 8224.876626850482, 8274.917250827415, 8336.416450848383, 10615.363078215332, 13104.279264640536, 13542.187468751907, 13796.379162937492, 14097.647558810702, 11349.602763903224, 11835.644930652094, 12031.4585843639, 12033.217840840318, 12053.75892482163, 11518.308901465938, 11585.0, 11810.586629467927, 12017.63947081589, 12101.81847272274, 11427.200095993534, 11972.401379931143, 12003.159778815749, 12047.457864395948, 12073.879261207276, 7987.92012079895, 8036.959815200887, 8174.754757357289, 8184.959075204586, 8245.422820402515, 8482.703105391529, 10707.464626768786, 11863.288202707865, 11888.940555297168, 12050.09624278165], "unit": "score", "name": "jquery.html", "value": 9076.049368349475}, {"lowerIsBetter": false, "replicates": [1403.6631208509948, 1523.6190952261934, 1531.594127556197, 1543.3672194400292, 1895.431370588823, 7811.570363629998, 8420.494770313779, 8585.313174946004, 8594.871076933836, 8614.009388920269, 8303.95848020759, 8557.957210213955, 8562.400631955765, 8566.700165494209, 8569.785755356119, 2139.5399989002362, 2384.29663249341, 2434.0507202191116, 2436.8903399347073, 2455.0057226823164, 2433.963490547634, 2451.044092803808, 2473.468204336067, 2479.2810085075307, 2479.913203037894, 2404.110479122727, 2434.318390850565, 2434.987825060872, 2437.0373702387546, 2437.695288088989, 2359.6578496118054, 2372.9762702372927, 2395.8083353331867, 2400.423898264413, 2404.8797560121925, 2372.5966585680476, 2405.0740464920955, 2405.867677277749, 2406.7713567211263, 2419.2379400488967, 8366.790830229233, 8461.95769021151, 8467.237948584596, 8474.898263225803, 8478.321734261244, 5272.103742363807, 5359.651622644516, 5396.946030539683, 5418.4039755626845, 5422.105352616813, 3566.5363502744735, 3600.6939410150167, 3687.704983601332, 3689.3728066228537, 3703.6296370363016, 1021.2340744441668, 1038.7247379444452, 1042.4318746283293, 1067.7330667333167, 1068.385678235018, 11436.428178591037, 11457.828132577935, 11583.18917675763, 11603.477843496978, 11621.012213961823, 4789.473157952622, 4822.373091498153, 4869.610431165498, 4916.754162291871, 4925.926111108336, 10086.24353173515, 10111.7472063199, 10113.64602238918, 10127.088562029452, 10127.64553240633, 4832.95167048332, 5447.536959358499, 5459.071957767189, 5480.534154596824, 5488.890222195534, 4437.267850804646, 4497.662675299365, 4516.593506584358, 4738.218193997952, 4889.413270407503, 3871.5741268460447, 3892.1826416452295, 3908.511436070491, 3948.881533553998, 3952.1898010907694, 1081.324172392255, 1293.780057390246, 1298.1821452485062, 1299.7725398055302, 1309.8952083833271, 1269.6889262130837, 1298.0199949038604, 1299.7010687541917, 1345.838499380061, 1365.4401695304878, 7922.801929951682, 7977.7207797726805, 7988.320992715568, 7991.0810256821205, 8000.039995200613, 414.42188147534023, 467.21274652211133, 471.14957501709057, 475.15185394071415, 478.19662966216396, 6032.819015429544, 6105.32841387447, 6106.908396374058, 6123.510119190454, 6128.417800308964, 9920.851187232198, 10593.993570610779, 10665.573377064831, 10668.839967400496, 10676.359418434919, 8919.777005574913, 8951.462912225288, 10314.27800054004, 10515.894841051491, 10580.576776928836, 8001.519908805491, 8121.309688676529, 8142.4300298978505, 8192.54940978252, 8209.220124088202, 7644.885326719992, 7718.228177182237, 7723.227677232457, 7740.187280335484, 7750.0, 7824.765257042298, 9198.908010919806, 9460.337776355589, 9498.810023799348, 9514.571844267162, 9589.760255993657, 9717.6598819041, 9859.30984831055, 9866.703998880044, 9950.651727189514, 6599.571027883172, 6798.93201067983, 7024.578525288499, 7327.523710958771, 7407.66665500043, 7917.920820791718, 7919.366450684047, 7973.083095443866, 7983.920160798318, 7996.920030799618, 7009.334113259232, 7093.609851458219, 7113.644317784194, 7227.0, 7274.745383911538, 7046.260142684944, 7048.118985126859, 7052.2242553318065, 7185.497015208885, 7203.603801790951, 7375.37309328713, 7513.4740568159705, 7543.245675432413, 7550.735724249845, 7551.131619863786, 6776.15298087739, 6884.242733299433, 6886.724531018703, 6889.242183359726, 6899.275576064441, 6835.863282734417, 6934.826629334307, 6986.895196571953, 6990.26602206761, 6991.965040174767], "unit": "score", "name": "mootools.html", "value": 4726.390481002096}, {"lowerIsBetter": false, "replicates": [267.4530584953769, 326.48252519756187, 327.77056060757474, 332.2027134876298, 337.701134495971, 6391.616503009817, 6558.606483610986, 6563.868722625544, 6617.602943823374, 6619.966900165498, 6485.124508191393, 6618.338166183379, 6622.801315960517, 6623.2383275923285, 6644.468442524599, 4598.494165641777, 4674.6494012949, 4721.740304283263, 4903.779329930153, 4918.827841025565, 3925.685945124383, 4771.212749896263, 4818.831340903069, 4840.806367745286, 4854.296127061574, 3907.7069219808627, 4769.5945844603075, 4782.545658162469, 4808.2066459034395, 4835.661503694742, 3837.635424634683, 4556.430446194226, 4645.558671926162, 4652.906941861178, 4787.61699064074, 3717.8698745544048, 3734.290484807878, 3962.2075584883137, 4040.7777572233517, 4053.8783836484954, 6168.414000669929, 6176.4749996250375, 6186.56694031418, 6201.81394558164, 6208.689565521751, 5511.9724401378135, 5514.6691198527815, 5527.917081243784, 5534.225208470817, 5542.972285138589, 6829.0, 6842.6578671066745, 6849.760258390932, 6934.47991400642, 6957.547759395623, 4371.431713877176, 4528.50186479487, 4543.909121817545, 4549.681522293441, 4568.200564901163, 7290.27097290272, 7310.707571697126, 7355.485116041879, 7364.5949472778975, 7372.299631535049, 4592.448906131285, 4593.173228818845, 4595.540445955445, 4597.632189424838, 4599.793009314589, 4652.790624421909, 4659.347691323217, 4665.813367465264, 4672.252439609714, 4688.484266730657, 5544.0, 5549.334079910436, 5554.694491802989, 5555.055640541118, 5564.582656300713, 6725.05849181115, 6988.19635741886, 6990.021397004423, 7020.7893763187185, 7032.964835175893, 1604.9518514444585, 1609.1632351177323, 1621.5459671292058, 1626.349460215923, 1629.2261175941333, 1030.5311083457009, 1031.8916513766096, 1042.3849928542197, 1051.1643243621186, 1054.0829478353728, 5990.161377407167, 6117.418845209698, 6662.56693314933, 6668.766593169313, 6675.232348279913, 7118.0, 7240.275972402717, 7287.526310789782, 7297.233790452032, 7311.305425984523, 6706.22878368984, 6730.259671436138, 6746.595204287759, 6759.155105611799, 6777.49168812341, 3868.3423817951016, 3897.395903634941, 3899.2396482685604, 3900.239453306578, 3902.8829135125993, 7390.7413240536325, 7601.581912994728, 7634.923650763532, 7751.457397982087, 7768.495047821873, 7543.283388078124, 7546.924530754732, 7567.394608431312, 7572.39420846331, 7574.621268936531, 7709.151993280735, 7710.460267781202, 7715.151333353327, 7730.884036739453, 7737.574433406104, 7330.780076597711, 7343.669534870837, 7350.595717235603, 7351.705931762884, 7361.926380736124, 6890.517663763689, 7182.748603798842, 7213.2065472799, 7219.386352160125, 7224.89162662571, 7640.923590764243, 7687.192844751445, 7693.615319233904, 7695.576743279174, 7718.0, 4635.7218566886095, 4668.78990445424, 4676.111538807616, 4679.0, 4682.461516925598, 6673.332666733482, 7263.963680181565, 7310.195878453473, 7313.23211062852, 7328.3770879473705, 6859.794206173823, 7057.153141623038, 7100.218975912542, 7102.857942841218, 7104.218535960937, 7023.894641580278, 7089.503734738519, 7090.539114957717, 7095.609741464269, 7111.217766045627, 6439.873022221186, 6916.55042422241, 6937.7571784987285, 6940.02839602446, 6950.20072691647, 6281.497480201664, 6802.3537763912345, 7074.292570742885, 7081.504294699322, 7100.289971002859, 6637.601743895381, 6801.965990170018, 6807.897881531682, 6893.448524118159, 6929.1684997800585], "unit": "score", "name": "prototype.html", "value": 5109.185723072796}, {"lowerIsBetter": false, "replicates": [671.1845108193545, 680.3876511139973, 711.8789805733024, 725.818545363659, 748.947573669843, 14769.0, 14848.183349915764, 15029.098254104734, 15048.398064077437, 15069.62325941852, 11557.422128893542, 13983.300834958261, 14160.645983850409, 14174.574762757135, 14261.572152835406, 715.2597062040788, 724.3480867219519, 869.2871845087031, 874.9081346458626, 896.5651658945407, 888.3825741109931, 888.999875140467, 892.857142857143, 897.9269772621719, 899.3974037394928, 759.1080480435467, 939.9107084826965, 945.5319616789699, 946.4179529589322, 946.8532377481501, 919.586186216202, 927.7819712367589, 928.308410234373, 930.1721467893547, 931.7624005878457, 688.5111570784749, 688.6694386694364, 689.7827184436886, 691.9965400173018, 696.4324075878194, 14442.711145777026, 14533.927330363385, 14536.709265814625, 14545.709085818224, 14572.125672459686, 12747.298898560575, 12893.35533223335, 12999.0, 13251.13867598603, 13465.394057267447, 9841.311108222428, 9987.077534791253, 10308.278420510567, 10424.218183636258, 10773.5690572377, 3980.7412518186225, 4051.6150965658217, 4079.796010199478, 4098.508179018507, 4171.228322760299, 84154.57922710408, 84749.0, 85870.57064714699, 86029.0, 86486.56756716239, 9256.259499240045, 9259.490728009889, 9325.626974921062, 9518.572763945289, 9581.952090239503, 20292.79707202909, 20521.794782052286, 20531.178752850017, 20542.794572054387, 20627.38117856467, 7362.7423040193335, 7402.777916662509, 7424.443166762407, 7475.476716629783, 7564.735234266775, 4151.750894946253, 4159.272127377697, 4175.31107367287, 4218.1985422770185, 4235.110626768414, 3448.2758620689433, 3461.8442170102408, 3477.1480987158307, 3478.200013996795, 3489.65103489649, 564.3171762167741, 610.7526451787033, 623.2054130982942, 623.8159742875863, 642.887494688437, 514.5986130817968, 544.5752313195713, 548.1257394455837, 603.3212635784743, 608.9817305480842, 8155.918440815516, 8482.618282177316, 8666.350023748244, 8751.606177722018, 8764.167404096728, 499.186326288148, 562.2690502346933, 617.388785102754, 626.3503201125819, 638.3839594791049, 3491.650834916488, 3976.701747368959, 3989.2819292527042, 4278.978605106954, 4383.758893260838, 86801.56599216964, 87076.0, 90025.54987225153, 91414.62878056834, 92400.53799731092, 76664.0, 80836.59581702054, 83831.5808420954, 83906.0, 84206.15793842106, 54816.72591637096, 70394.2960570398, 70688.93966590505, 70779.64610176916, 72208.63895680488, 7919.524828510308, 8154.0215174179475, 8645.524496152771, 8773.122687731176, 8933.106689331014, 46129.0, 47109.528904711886, 47257.0, 47650.52349476461, 51878.48121518736, 64640.0, 66990.66504667446, 68184.6590767043, 70121.94817077646, 72394.27605724086, 11055.391953442639, 11126.22226634264, 11288.830667540158, 11363.829542557034, 11676.065914726632, 11973.281603103842, 12015.279083255033, 12161.148719589544, 12256.693582660148, 12438.56465023756, 9781.657641982496, 11247.550097995989, 11954.760904781682, 12383.504659813507, 12395.25628462259, 9752.0, 11328.830067548828, 11539.596114135966, 12070.818937715765, 12294.569690060805, 10740.409277489813, 10821.350718956888, 11305.378204198849, 11372.033377163034, 11600.767984640428, 8055.556944368116, 8906.153915378029, 8992.055834137322, 9442.48066356357, 9591.0, 9110.7266781994, 9160.221381182673, 9309.813803724022, 10091.0708677902, 10165.84751228747], "unit": "score", "name": "yui.html", "value": 6887.415299367927}], "name": "dromaeo_css", "value": 7365.422774812563}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 111.0, 111.0, 112.0, 111.0, 115.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [157.0, 122.0, 142.0, 153.0, 120.0, 141.0, 138.0, 122.0, 146.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 138.1}, {"lowerIsBetter": true, "replicates": [182.0, 185.0, 186.0, 186.0, 182.0, 182.0, 186.0, 183.0, 183.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.7}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 86.0, 77.0, 56.0, 56.0, 58.0, 80.0, 76.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.2}, {"lowerIsBetter": true, "replicates": [92.0, 97.0, 125.0, 79.0, 78.0, 84.0, 107.0, 77.0, 78.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 84.0, 90.0, 84.0, 93.0, 85.0, 91.0, 83.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 99.0, 93.0, 92.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.3}, {"lowerIsBetter": true, "replicates": [84.0, 107.0, 136.0, 135.0, 85.0, 87.0, 86.0, 85.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 97.5}, {"lowerIsBetter": true, "replicates": [55.0, 53.0, 53.0, 54.0, 56.0, 53.0, 54.0, 66.0, 52.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.7}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 73.0, 74.0, 70.0, 68.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 83.0, 83.0, 83.0, 83.0, 83.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [126.0, 125.0, 128.0, 124.0, 122.0, 131.0, 110.0, 127.0, 134.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [140.0, 137.0, 137.0, 140.0, 139.0, 126.0, 137.0, 137.0, 138.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 65.0, 66.0, 79.0, 91.0, 91.0, 91.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.9}], "name": "kraken", "value": 1418.7}]} 10:12:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1418.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7365.43"}}} 10:12:16 INFO - Return code: 0 10:12:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:12:16 INFO - # TBPL SUCCESS # 10:12:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:12:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:12:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:12:16 INFO - 2016-02-23 10:12:16.546 screenresolution[1685:10171] starting screenresolution argv=screenresolution get 10:12:16 INFO - 2016-02-23 10:12:16.549 screenresolution[1685:10171] Display 0: 1600x1200x32@60 10:12:16 INFO - 2016-02-23 10:12:16.555 screenresolution[1686:10174] starting screenresolution argv=screenresolution list 10:12:16 INFO - Available Modes on Display 0 10:12:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:12:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:12:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:12:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:12:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:12:16 INFO - Intel Iris: 10:12:16 INFO - Chipset Model: Intel Iris 10:12:16 INFO - Type: GPU 10:12:16 INFO - Bus: Built-In 10:12:16 INFO - VRAM (Dynamic, Max): 1536 MB 10:12:16 INFO - Vendor: Intel (0x8086) 10:12:16 INFO - Device ID: 0x0a2e 10:12:16 INFO - Revision ID: 0x0009 10:12:16 INFO - Displays: 10:12:16 INFO - Display: 10:12:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:12:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:12:16 INFO - Display Serial Number: 1600x1200 60 10:12:16 INFO - Main Display: Yes 10:12:16 INFO - Mirror: Off 10:12:16 INFO - Online: Yes 10:12:16 INFO - Rotation: Supported 10:12:16 INFO - Return code: 0 10:12:16 INFO - Running post-action listener: _resource_record_post_action 10:12:16 INFO - Running post-run listener: _resource_record_post_run 10:12:17 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 33840640; Write bytes: 708602368; Read time: 348; Write time: 2067 10:12:17 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403730944; Write bytes: 397569536; Read time: 30106; Write time: 694 10:12:17 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 32050688; Write bytes: 300538880; Read time: 330; Write time: 1340 10:12:17 INFO - Running post-run listener: _upload_blobber_files 10:12:17 INFO - Blob upload gear active. 10:12:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:12:17 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 10:12:17 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'] 10:12:17 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 10:12:18 INFO - (blobuploader) - INFO - Open directory for files ... 10:12:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:12:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:18 INFO - (blobuploader) - INFO - Done attempting. 10:12:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:12:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:12:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:19 INFO - (blobuploader) - INFO - Done attempting. 10:12:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:12:19 INFO - Return code: 0 10:12:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:12:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:12:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86b25c521ad6d761e1f684e93b2098100fd0ffd2ad112e626594ac6591d0594cb2554bd528c412b650a792a2e5532ed1ba0997f00b23ff55e51594ab78e796b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1f1cac309392704abdc6bddb13cf941083223a062916b27a3176acabcbba1e631ea42797533f8169c926690d9eac53badbf3cf4bbbcd011d42fb3bbbea733b"} 10:12:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:12:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:12:19 INFO - Contents: 10:12:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86b25c521ad6d761e1f684e93b2098100fd0ffd2ad112e626594ac6591d0594cb2554bd528c412b650a792a2e5532ed1ba0997f00b23ff55e51594ab78e796b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1f1cac309392704abdc6bddb13cf941083223a062916b27a3176acabcbba1e631ea42797533f8169c926690d9eac53badbf3cf4bbbcd011d42fb3bbbea733b"} 10:12:20 INFO - Running post-run listener: copy_logs_to_upload_dir 10:12:20 INFO - Copying logs to upload dir... 10:12:20 INFO - mkdir: /builds/slave/test/build/upload/logs 10:12:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.887150 ========= master_lag: 1.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-23 10:12:21.055295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:21.062263) ========= 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.6kTRroNrzT/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.HWB2WKxiAI/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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/86b25c521ad6d761e1f684e93b2098100fd0ffd2ad112e626594ac6591d0594cb2554bd528c412b650a792a2e5532ed1ba0997f00b23ff55e51594ab78e796b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1f1cac309392704abdc6bddb13cf941083223a062916b27a3176acabcbba1e631ea42797533f8169c926690d9eac53badbf3cf4bbbcd011d42fb3bbbea733b"} build_url:https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011029 build_url: 'https://queue.taskcluster.net/v1/task/DxqKje3KTfCSW8UqCf9p_g/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/86b25c521ad6d761e1f684e93b2098100fd0ffd2ad112e626594ac6591d0594cb2554bd528c412b650a792a2e5532ed1ba0997f00b23ff55e51594ab78e796b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1f1cac309392704abdc6bddb13cf941083223a062916b27a3176acabcbba1e631ea42797533f8169c926690d9eac53badbf3cf4bbbcd011d42fb3bbbea733b"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:21.451923) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:21.452206) ========= 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.6kTRroNrzT/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.HWB2WKxiAI/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005584 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:21.497262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:12:21.497529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:12:21.503233) ========= ========= Total master_lag: 8.97 =========