builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0116 starttime: 1455455770.27 results: success (0) buildid: 20160214030236 builduid: 81b04e5138264ec8b2e67d94e9951e12 revision: e355cacefc881ba360d412853b57e8e060e966f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.265559) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.265930) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.266231) ========= 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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005712 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.353545) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.353812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.468048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.468321) ========= 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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005275 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.531801) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.532074) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.532428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.532719) ========= 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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-14 05:16:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 211M=0s 2016-02-14 05:16:10 (211 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.753950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.754238) ========= 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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.019450 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:10.802800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-14 05:16:10.803148) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e355cacefc881ba360d412853b57e8e060e966f4 --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 e355cacefc881ba360d412853b57e8e060e966f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FayIhaBmJA/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.jOv1U3o6ZT/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-14 05:16:10,866 truncating revision to first 12 chars 2016-02-14 05:16:10,866 Setting DEBUG logging. 2016-02-14 05:16:10,866 attempt 1/10 2016-02-14 05:16:10,867 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e355cacefc88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-14 05:16:12,032 unpacking tar archive at: mozilla-central-e355cacefc88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.415859 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-14 05:16:12.237445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:12.237739) ========= echo e355cacefc881ba360d412853b57e8e060e966f4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e355cacefc881ba360d412853b57e8e060e966f4'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FayIhaBmJA/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.jOv1U3o6ZT/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 e355cacefc881ba360d412853b57e8e060e966f4 program finished with exit code 0 elapsedTime=0.005066 script_repo_revision: 'e355cacefc881ba360d412853b57e8e060e966f4' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:12.286532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:12.286808) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-14 05:16:12.299673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-02-14 05:16:12.299995) ========= /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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:16:12 INFO - MultiFileLogger online at 20160214 05:16:12 in /builds/slave/test 05:16:12 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 05:16:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:12 INFO - {'append_to_log': False, 05:16:12 INFO - 'base_work_dir': '/builds/slave/test', 05:16:12 INFO - 'blob_upload_branch': 'Firefox', 05:16:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:12 INFO - 'branch': 'Firefox', 05:16:12 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:12 INFO - 'config_files': ('talos/mac_config.py',), 05:16:12 INFO - 'default_actions': ('clobber', 05:16:12 INFO - 'read-buildbot-config', 05:16:12 INFO - 'download-and-extract', 05:16:12 INFO - 'populate-webroot', 05:16:12 INFO - 'create-virtualenv', 05:16:12 INFO - 'install', 05:16:12 INFO - 'run-tests'), 05:16:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:12 INFO - 'download_minidump_stackwalk': True, 05:16:12 INFO - 'download_symbols': 'ondemand', 05:16:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:12 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:12 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:12 INFO - 'installer_path': 'installer.exe', 05:16:12 INFO - 'log_level': 'info', 05:16:12 INFO - 'log_name': 'talos', 05:16:12 INFO - 'log_to_console': True, 05:16:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:16:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:16:12 INFO - 'opt_config_files': (), 05:16:12 INFO - 'pip_index': False, 05:16:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:12 INFO - 'cmd': ('bash', 05:16:12 INFO - '-c', 05:16:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:12 INFO - 'enabled': True, 05:16:12 INFO - 'halt_on_failure': False, 05:16:12 INFO - 'name': 'check_screen_resolution'},), 05:16:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:12 INFO - 'cmd': ('bash', 05:16:12 INFO - '-c', 05:16:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:12 INFO - 'enabled': True, 05:16:12 INFO - 'halt_on_failure': False, 05:16:12 INFO - 'name': 'check_screen_resolution'},), 05:16:12 INFO - 'run_cmd_checks_enabled': True, 05:16:12 INFO - 'sps_profile': False, 05:16:12 INFO - 'sps_profile_interval': 0, 05:16:12 INFO - 'suite': 'dromaeojs', 05:16:12 INFO - 'system_bits': '32', 05:16:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:12 INFO - 'title': 't-yosemite-r7-0116', 05:16:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:12 INFO - 'use_talos_json': True, 05:16:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:12 INFO - 'work_dir': 'build'} 05:16:12 INFO - ##### 05:16:12 INFO - ##### Running clobber step. 05:16:12 INFO - ##### 05:16:12 INFO - Running pre-action listener: _resource_record_pre_action 05:16:12 INFO - Running main action method: clobber 05:16:12 INFO - rmtree: /builds/slave/test/build 05:16:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:13 INFO - Running post-action listener: _resource_record_post_action 05:16:13 INFO - ##### 05:16:13 INFO - ##### Running read-buildbot-config step. 05:16:13 INFO - ##### 05:16:13 INFO - Running pre-action listener: _resource_record_pre_action 05:16:13 INFO - Running main action method: read_buildbot_config 05:16:13 INFO - Using buildbot properties: 05:16:13 INFO - { 05:16:13 INFO - "project": "", 05:16:13 INFO - "product": "firefox", 05:16:13 INFO - "script_repo_revision": "production", 05:16:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:16:13 INFO - "repository": "", 05:16:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:16:13 INFO - "buildid": "20160214030236", 05:16:13 INFO - "stage_platform": "macosx64", 05:16:13 INFO - "basedir": "/builds/slave/test", 05:16:13 INFO - "nightly_build": "True", 05:16:13 INFO - "buildnumber": 117, 05:16:13 INFO - "slavename": "t-yosemite-r7-0116", 05:16:13 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:16:13 INFO - "platform": "yosemite_r7", 05:16:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:16:13 INFO - "branch": "mozilla-central", 05:16:13 INFO - "repo_path": "mozilla-central", 05:16:13 INFO - "revision": "e355cacefc881ba360d412853b57e8e060e966f4", 05:16:13 INFO - "pgo_build": "False", 05:16:13 INFO - "builduid": "81b04e5138264ec8b2e67d94e9951e12", 05:16:13 INFO - "slavebuilddir": "test" 05:16:13 INFO - } 05:16:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:16:13 INFO - Running post-action listener: _resource_record_post_action 05:16:13 INFO - ##### 05:16:13 INFO - ##### Running download-and-extract step. 05:16:13 INFO - ##### 05:16:13 INFO - Running pre-action listener: _resource_record_pre_action 05:16:13 INFO - Running main action method: download_and_extract 05:16:13 INFO - mkdir: /builds/slave/test/build/tests 05:16: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')]} 05:16:13 INFO - https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:16:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/test_packages.json 05:16:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/test_packages.json 05:16:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:16:15 INFO - Downloaded 1277 bytes. 05:16:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:16:15 INFO - Using the following test package requirements: 05:16:15 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:16:15 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:15 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:16:15 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:15 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:16:15 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:15 INFO - u'jsshell-mac.zip'], 05:16:15 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:15 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:16:15 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:16:15 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:15 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:16:15 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:15 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:16:15 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:15 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:16:15 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:16:15 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:16:15 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:16:15 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:15 INFO - https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/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 05:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/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 05:16:16 INFO - Downloaded 17756446 bytes. 05:16:16 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'] 05:16:16 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 05:16:19 INFO - Return code: 0 05:16:19 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 05:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:19 INFO - https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/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 05:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/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 05:16:31 INFO - Downloaded 17756446 bytes. 05:16:31 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'] 05:16:31 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 05:16:35 INFO - Return code: 0 05:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:35 INFO - https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/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 05:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/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 05:16:36 INFO - Downloaded 10707070 bytes. 05:16:36 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'] 05:16:36 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 05:16:36 INFO - Return code: 0 05:16:36 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')]} 05:16:36 INFO - https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUzq-xY9Rky9gItsudUhpQ/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 05:16:45 INFO - Downloaded 111221693 bytes. 05:16:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:16:45 INFO - mkdir: /builds/slave/test/properties 05:16:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:45 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:45 INFO - Contents: 05:16:45 INFO - build_url:https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:16:46 INFO - Running post-action listener: _resource_record_post_action 05:16:46 INFO - Running post-action listener: set_extra_try_arguments 05:16:46 INFO - ##### 05:16:46 INFO - ##### Running populate-webroot step. 05:16:46 INFO - ##### 05:16:46 INFO - Running pre-action listener: _resource_record_pre_action 05:16:46 INFO - Running main action method: populate_webroot 05:16:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:46 INFO - '--tppagecycles', 05:16:46 INFO - '7'], 05:16:46 INFO - 'tests': ['tsvgm']}}, 05:16:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:16:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:16:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:16:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:16:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:46 INFO - 'talos_options': ['--e10s'], 05:16:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:46 INFO - 'tests': ['damp', 'tps']}, 05:16:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:46 INFO - 'talos_options': ['--e10s'], 05:16:46 INFO - 'tests': ['damp', 'tps']}, 05:16:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:16:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:46 INFO - 'other': {'tests': ['a11yr', 05:16:46 INFO - 'ts_paint', 05:16:46 INFO - 'tpaint', 05:16:46 INFO - 'sessionrestore', 05:16:46 INFO - 'sessionrestore_no_auto_restore']}, 05:16:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:16:46 INFO - 'tests': ['a11yr', 05:16:46 INFO - 'ts_paint', 05:16:46 INFO - 'tpaint', 05:16:46 INFO - 'sessionrestore', 05:16:46 INFO - 'sessionrestore_no_auto_restore']}, 05:16:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:16:46 INFO - 'tests': ['a11yr', 05:16:46 INFO - 'ts_paint', 05:16:46 INFO - 'tpaint', 05:16:46 INFO - 'sessionrestore', 05:16:46 INFO - 'sessionrestore_no_auto_restore']}, 05:16:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:16:46 INFO - 'tests': ['a11yr', 05:16:46 INFO - 'ts_paint', 05:16:46 INFO - 'tpaint', 05:16:46 INFO - 'sessionrestore', 05:16:46 INFO - 'sessionrestore_no_auto_restore']}, 05:16:46 INFO - 'other_l64': {'tests': ['a11yr', 05:16:46 INFO - 'ts_paint', 05:16:46 INFO - 'tpaint', 05:16:46 INFO - 'sessionrestore', 05:16:46 INFO - 'sessionrestore_no_auto_restore']}, 05:16:46 INFO - 'other_nol64': {'tests': ['a11yr', 05:16:46 INFO - 'ts_paint', 05:16:46 INFO - 'tpaint', 05:16:46 INFO - 'sessionrestore', 05:16:46 INFO - 'sessionrestore_no_auto_restore']}, 05:16:46 INFO - 'svgr': {'tests': ['tsvgx', 05:16:46 INFO - 'tsvgr_opacity', 05:16:46 INFO - 'tart', 05:16:46 INFO - 'tscrollx', 05:16:46 INFO - 'cart']}, 05:16:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:16:46 INFO - 'tests': ['tsvgx', 05:16:46 INFO - 'tsvgr_opacity', 05:16:46 INFO - 'tart', 05:16:46 INFO - 'tscrollx', 05:16:46 INFO - 'cart']}, 05:16:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:46 INFO - 'tests': ['tp5o']}, 05:16:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:46 INFO - 'talos_options': ['--e10s'], 05:16:46 INFO - 'tests': ['tp5o']}, 05:16:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:46 INFO - 'talos_options': ['--xperf_path', 05:16:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:46 INFO - 'tests': ['tp5n']}, 05:16:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:46 INFO - 'talos_options': ['--e10s', 05:16:46 INFO - '--xperf_path', 05:16:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:46 INFO - 'tests': ['tp5n']}}, 05:16:46 INFO - 'talos.zip': {'path': '', 05:16:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:46 INFO - Running post-action listener: _resource_record_post_action 05:16:46 INFO - ##### 05:16:46 INFO - ##### Running create-virtualenv step. 05:16:46 INFO - ##### 05:16:46 INFO - Running pre-action listener: _resource_record_pre_action 05:16:46 INFO - Running main action method: create_virtualenv 05:16:46 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:46 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 05:16:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:46 INFO - Using real prefix '/tools/python27' 05:16:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:47 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:50 INFO - Installing pip.................done. 05:16:50 INFO - Return code: 0 05:16:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc6ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63046dd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, '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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:50 INFO - 'HOME': '/Users/cltbld', 05:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:50 INFO - 'LOGNAME': 'cltbld', 05:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:50 INFO - 'MOZ_NO_REMOTE': '1', 05:16:50 INFO - 'NO_EM_RESTART': '1', 05:16:50 INFO - 'PAGER': '/bin/cat', 05:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:50 INFO - 'PWD': '/builds/slave/test', 05:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:50 INFO - 'SHELL': '/bin/bash', 05:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:16:50 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:50 INFO - 'USER': 'cltbld', 05:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:50 INFO - 'XPC_FLAGS': '0x0', 05:16:50 INFO - 'XPC_SERVICE_NAME': '0', 05:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:50 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 05:16:50 INFO - Cleaning up... 05:16:50 INFO - Return code: 0 05:16:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cc6ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63046dd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, '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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:50 INFO - 'HOME': '/Users/cltbld', 05:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:50 INFO - 'LOGNAME': 'cltbld', 05:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:50 INFO - 'MOZ_NO_REMOTE': '1', 05:16:50 INFO - 'NO_EM_RESTART': '1', 05:16:50 INFO - 'PAGER': '/bin/cat', 05:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:50 INFO - 'PWD': '/builds/slave/test', 05:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:50 INFO - 'SHELL': '/bin/bash', 05:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:16:50 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:50 INFO - 'USER': 'cltbld', 05:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:50 INFO - 'XPC_FLAGS': '0x0', 05:16:50 INFO - 'XPC_SERVICE_NAME': '0', 05:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:51 INFO - Downloading/unpacking psutil>=0.7.1 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:54 INFO - Installing collected packages: psutil 05:16:54 INFO - Running setup.py install for psutil 05:16:54 INFO - building 'psutil._psutil_osx' extension 05:16:54 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 05:16:54 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 05:16:54 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 05:16:54 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 05:16:54 INFO - building 'psutil._psutil_posix' extension 05:16:54 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 05:16:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:16:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:16:54 INFO - ^ 05:16:54 INFO - 1 warning generated. 05:16:54 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 05:16:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:55 INFO - Successfully installed psutil 05:16:55 INFO - Cleaning up... 05:16:55 INFO - Return code: 0 05:16:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:16:55 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')]} 05:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:55 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')]} 05:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:55 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 0x10cc6ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63046dd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, '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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:16:55 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 05:16:55 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 05:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:55 INFO - 'HOME': '/Users/cltbld', 05:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:55 INFO - 'LOGNAME': 'cltbld', 05:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:55 INFO - 'MOZ_NO_REMOTE': '1', 05:16:55 INFO - 'NO_EM_RESTART': '1', 05:16:55 INFO - 'PAGER': '/bin/cat', 05:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:55 INFO - 'PWD': '/builds/slave/test', 05:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:55 INFO - 'SHELL': '/bin/bash', 05:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:16:55 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:55 INFO - 'USER': 'cltbld', 05:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:55 INFO - 'XPC_FLAGS': '0x0', 05:16:55 INFO - 'XPC_SERVICE_NAME': '0', 05:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16:55 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 05:16:55 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 05:16:55 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 05:16:55 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 05:16:55 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 05:16:55 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 05:16:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:16:57 INFO - Installing collected packages: mozsystemmonitor 05:16:57 INFO - Running setup.py install for mozsystemmonitor 05:16:57 INFO - Successfully installed mozsystemmonitor 05:16:57 INFO - Cleaning up... 05:16:57 INFO - Return code: 0 05:16:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:58 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 0x10cc6ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63046dd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, '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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:16:58 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 05:16:58 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 05:16:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:16:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:58 INFO - 'HOME': '/Users/cltbld', 05:16:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:58 INFO - 'LOGNAME': 'cltbld', 05:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:58 INFO - 'MOZ_NO_REMOTE': '1', 05:16:58 INFO - 'NO_EM_RESTART': '1', 05:16:58 INFO - 'PAGER': '/bin/cat', 05:16:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:58 INFO - 'PWD': '/builds/slave/test', 05:16:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:58 INFO - 'SHELL': '/bin/bash', 05:16:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:16:58 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:16:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:58 INFO - 'USER': 'cltbld', 05:16:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:58 INFO - 'XPC_FLAGS': '0x0', 05:16:58 INFO - 'XPC_SERVICE_NAME': '0', 05:16:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:58 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 05:16:58 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 05:16:58 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 05:16:58 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 05:16:58 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 05:16:58 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 05:17:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:00 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 05:17:00 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 05:17:00 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 05:17:00 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 05:17:00 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 05:17:00 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 05:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 INFO - Downloading docopt-0.6.1.tar.gz 05:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:01 INFO - Running setup.py install for blobuploader 05:17:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:01 INFO - Running setup.py install for requests 05:17:02 INFO - Running setup.py install for docopt 05:17:02 INFO - Successfully installed blobuploader requests docopt 05:17:02 INFO - Cleaning up... 05:17:02 INFO - Return code: 0 05:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:02 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 0x10cc6ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63046dd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, '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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:17:02 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 05:17:02 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 05:17:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:17:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:02 INFO - 'HOME': '/Users/cltbld', 05:17:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:02 INFO - 'LOGNAME': 'cltbld', 05:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:02 INFO - 'MOZ_NO_REMOTE': '1', 05:17:02 INFO - 'NO_EM_RESTART': '1', 05:17:02 INFO - 'PAGER': '/bin/cat', 05:17:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:02 INFO - 'PWD': '/builds/slave/test', 05:17:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:02 INFO - 'SHELL': '/bin/bash', 05:17:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:17:02 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:17:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:02 INFO - 'USER': 'cltbld', 05:17:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:02 INFO - 'XPC_FLAGS': '0x0', 05:17:02 INFO - 'XPC_SERVICE_NAME': '0', 05:17:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:02 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-46i_yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-jY2cBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-cyiZpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-JwlrLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2JhgSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-oGV2mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-cD3vpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-o5CBiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-upRVs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-lz3zTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:03 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-94x6rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:04 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-IWnkNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:04 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-SV47Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:04 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-yAOk2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:04 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Ggnxxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:04 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-zJ74Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:04 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2Xjg5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:04 INFO - Running setup.py install for manifestparser 05:17:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Running setup.py install for mozcrash 05:17:04 INFO - Running setup.py install for mozdebug 05:17:05 INFO - Running setup.py install for mozdevice 05:17:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Running setup.py install for mozfile 05:17:05 INFO - Running setup.py install for mozhttpd 05:17:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Running setup.py install for mozinfo 05:17:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Running setup.py install for mozInstall 05:17:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Running setup.py install for mozleak 05:17:05 INFO - Running setup.py install for mozlog 05:17:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:06 INFO - Running setup.py install for moznetwork 05:17:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:06 INFO - Running setup.py install for mozprocess 05:17:06 INFO - Running setup.py install for mozprofile 05:17:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:06 INFO - Running setup.py install for mozrunner 05:17:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:06 INFO - Running setup.py install for mozscreenshot 05:17:06 INFO - Running setup.py install for moztest 05:17:07 INFO - Running setup.py install for mozversion 05:17:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:07 INFO - Cleaning up... 05:17:07 INFO - Return code: 0 05:17:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:07 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 0x10cc6ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63046dd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, '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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:17:07 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 05:17:07 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 05:17:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:17:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:07 INFO - 'HOME': '/Users/cltbld', 05:17:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:07 INFO - 'LOGNAME': 'cltbld', 05:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:07 INFO - 'MOZ_NO_REMOTE': '1', 05:17:07 INFO - 'NO_EM_RESTART': '1', 05:17:07 INFO - 'PAGER': '/bin/cat', 05:17:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:07 INFO - 'PWD': '/builds/slave/test', 05:17:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:07 INFO - 'SHELL': '/bin/bash', 05:17:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:17:07 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:17:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:07 INFO - 'USER': 'cltbld', 05:17:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:07 INFO - 'XPC_FLAGS': '0x0', 05:17:07 INFO - 'XPC_SERVICE_NAME': '0', 05:17:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-jPBXsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:07 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)) 05:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-e2strv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:07 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)) 05:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-B9GfNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:07 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)) 05:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-MwNMg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:07 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)) 05:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-58W9xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:07 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)) 05:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-sCehaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:08 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)) 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-DVvFrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:08 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)) 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2BM7Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:08 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)) 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2kBb20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:08 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)) 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-cWFN9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:08 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)) 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-YS42qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:08 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)) 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-4di666-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:08 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)) 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2BCspq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:08 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)) 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Lk_5DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:08 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)) 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-IQzJZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:09 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)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:09 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-uSbNpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:09 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)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:09 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-GAIDLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:11 INFO - Downloading blessings-1.6.tar.gz 05:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:11 INFO - Installing collected packages: blessings 05:17:11 INFO - Running setup.py install for blessings 05:17:11 INFO - Successfully installed blessings 05:17:11 INFO - Cleaning up... 05:17:11 INFO - Return code: 0 05:17:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:12 INFO - Reading from file tmpfile_stdout 05:17:12 INFO - Current package versions: 05:17:12 INFO - blessings == 1.6 05:17:12 INFO - blobuploader == 1.2.4 05:17:12 INFO - docopt == 0.6.1 05:17:12 INFO - manifestparser == 1.1 05:17:12 INFO - mozInstall == 1.12 05:17:12 INFO - mozcrash == 0.16 05:17:12 INFO - mozdebug == 0.1 05:17:12 INFO - mozdevice == 0.48 05:17:12 INFO - mozfile == 1.2 05:17:12 INFO - mozhttpd == 0.7 05:17:12 INFO - mozinfo == 0.9 05:17:12 INFO - mozleak == 0.1 05:17:12 INFO - mozlog == 3.1 05:17:12 INFO - moznetwork == 0.27 05:17:12 INFO - mozprocess == 0.22 05:17:12 INFO - mozprofile == 0.28 05:17:12 INFO - mozrunner == 6.11 05:17:12 INFO - mozscreenshot == 0.1 05:17:12 INFO - mozsystemmonitor == 0.0 05:17:12 INFO - moztest == 0.7 05:17:12 INFO - mozversion == 1.4 05:17:12 INFO - psutil == 3.1.1 05:17:12 INFO - requests == 1.2.3 05:17:12 INFO - wsgiref == 0.1.2 05:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:12 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')]} 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 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')]} 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 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 0x10cc6ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63046dd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, '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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:17:12 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 05:17:12 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 05:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:12 INFO - 'HOME': '/Users/cltbld', 05:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:12 INFO - 'LOGNAME': 'cltbld', 05:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:12 INFO - 'MOZ_NO_REMOTE': '1', 05:17:12 INFO - 'NO_EM_RESTART': '1', 05:17:12 INFO - 'PAGER': '/bin/cat', 05:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:12 INFO - 'PWD': '/builds/slave/test', 05:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:12 INFO - 'SHELL': '/bin/bash', 05:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:17:12 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:12 INFO - 'USER': 'cltbld', 05:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:12 INFO - 'XPC_FLAGS': '0x0', 05:17:12 INFO - 'XPC_SERVICE_NAME': '0', 05:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:12 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)) 05:17:12 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)) 05:17:12 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)) 05:17:12 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)) 05:17:12 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)) 05:17:12 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)) 05:17:12 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)) 05:17:12 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)) 05:17:12 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)) 05:17:12 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)) 05:17:12 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)) 05:17:12 INFO - Cleaning up... 05:17:12 INFO - Return code: 0 05:17:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:12 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')]} 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 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')]} 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 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 0x10cc6ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63046dd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, '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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:17:12 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 05:17:12 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 05:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:12 INFO - 'HOME': '/Users/cltbld', 05:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:12 INFO - 'LOGNAME': 'cltbld', 05:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:12 INFO - 'MOZ_NO_REMOTE': '1', 05:17:12 INFO - 'NO_EM_RESTART': '1', 05:17:12 INFO - 'PAGER': '/bin/cat', 05:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:12 INFO - 'PWD': '/builds/slave/test', 05:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:12 INFO - 'SHELL': '/bin/bash', 05:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:17:12 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:12 INFO - 'USER': 'cltbld', 05:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:12 INFO - 'XPC_FLAGS': '0x0', 05:17:12 INFO - 'XPC_SERVICE_NAME': '0', 05:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:12 INFO - Downloading/unpacking jsonschema 05:17:12 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 05:17:12 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 05:17:12 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 05:17:12 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 05:17:12 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 05:17:12 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 05:17:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:17:15 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 05:17:15 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 05:17:15 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 05:17:15 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 05:17:15 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 05:17:15 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 05:17:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:15 INFO - warning: no files found matching '*.txt' 05:17:15 INFO - no previously-included directories found matching 'build' 05:17:15 INFO - no previously-included directories found matching 'dist' 05:17:15 INFO - no previously-included directories found matching '.git*' 05:17:15 INFO - Installing collected packages: jsonschema, functools32 05:17:15 INFO - Running setup.py install for functools32 05:17:16 INFO - warning: no files found matching '*.txt' 05:17:16 INFO - no previously-included directories found matching 'build' 05:17:16 INFO - no previously-included directories found matching 'dist' 05:17:16 INFO - no previously-included directories found matching '.git*' 05:17:16 INFO - Successfully installed jsonschema functools32 05:17:16 INFO - Cleaning up... 05:17:16 INFO - Return code: 0 05:17:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:17:16 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')]} 05:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:16 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')]} 05:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:16 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 0x10cc6ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63046dd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, '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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:17:16 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 05:17:16 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 05:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:16 INFO - 'HOME': '/Users/cltbld', 05:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:16 INFO - 'LOGNAME': 'cltbld', 05:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:16 INFO - 'MOZ_NO_REMOTE': '1', 05:17:16 INFO - 'NO_EM_RESTART': '1', 05:17:16 INFO - 'PAGER': '/bin/cat', 05:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:16 INFO - 'PWD': '/builds/slave/test', 05:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:16 INFO - 'SHELL': '/bin/bash', 05:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:17:16 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:16 INFO - 'USER': 'cltbld', 05:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:16 INFO - 'XPC_FLAGS': '0x0', 05:17:16 INFO - 'XPC_SERVICE_NAME': '0', 05:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:16 INFO - Downloading/unpacking flake8 05:17:16 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 05:17:16 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 05:17:16 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 05:17:16 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 05:17:16 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 05:17:16 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 05:17:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:17:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:17:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 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 05:17:19 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 05:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:17:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:20 INFO - no previously-included directories found matching 'docs/_build' 05:17:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:17:20 INFO - Running setup.py install for pep8 05:17:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:20 INFO - no previously-included directories found matching 'docs/_build' 05:17:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:17:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:17:20 INFO - Cleaning up... 05:17:20 INFO - Return code: 0 05:17:20 INFO - Running post-action listener: _resource_record_post_action 05:17:20 INFO - Running post-action listener: _start_resource_monitoring 05:17:20 INFO - Starting resource monitoring. 05:17:20 INFO - ##### 05:17:20 INFO - ##### Running install step. 05:17:20 INFO - ##### 05:17:20 INFO - Running pre-action listener: _resource_record_pre_action 05:17:20 INFO - Running main action method: install 05:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:21 INFO - Reading from file tmpfile_stdout 05:17:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:21 INFO - Reading from file tmpfile_stdout 05:17:21 INFO - Output received: 05:17:21 INFO - Usage: mozinstall [options] installer 05:17:21 INFO - Options: 05:17:21 INFO - -h, --help show this help message and exit 05:17:21 INFO - -d DEST, --destination=DEST 05:17:21 INFO - Directory to install application into. [default: 05:17:21 INFO - "/builds/slave/test"] 05:17:21 INFO - --app=APP Application being installed. [default: firefox] 05:17:21 INFO - mkdir: /builds/slave/test/build/application 05:17:21 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'] 05:17:21 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 05:17:55 INFO - Reading from file tmpfile_stdout 05:17:55 INFO - Output received: 05:17:55 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:17:55 INFO - Running post-action listener: _resource_record_post_action 05:17:55 INFO - ##### 05:17:55 INFO - ##### Running run-tests step. 05:17:55 INFO - ##### 05:17:55 INFO - Running pre-action listener: _resource_record_pre_action 05:17:55 INFO - Running main action method: run_tests 05:17:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:55 INFO - 2016-02-14 05:17:55.320 screenresolution[2071:21773] starting screenresolution argv=screenresolution get 05:17:55 INFO - 2016-02-14 05:17:55.323 screenresolution[2071:21773] Display 0: 1600x1200x32@60 05:17:55 INFO - 2016-02-14 05:17:55.328 screenresolution[2072:21775] starting screenresolution argv=screenresolution list 05:17:55 INFO - Available Modes on Display 0 05:17:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:55 INFO - Intel Iris: 05:17:55 INFO - Chipset Model: Intel Iris 05:17:55 INFO - Type: GPU 05:17:55 INFO - Bus: Built-In 05:17:55 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:55 INFO - Vendor: Intel (0x8086) 05:17:55 INFO - Device ID: 0x0a2e 05:17:55 INFO - Revision ID: 0x0009 05:17:55 INFO - Displays: 05:17:55 INFO - Display: 05:17:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:55 INFO - Display Serial Number: 1600x1200 60 05:17:55 INFO - Main Display: Yes 05:17:55 INFO - Mirror: Off 05:17:55 INFO - Online: Yes 05:17:55 INFO - Rotation: Supported 05:17:55 INFO - Return code: 0 05:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:55 INFO - Python 2.7.3 05:17:55 INFO - Return code: 0 05:17:55 INFO - grabbing minidump binary from tooltool 05:17:55 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')]} 05:17:55 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 0x10cb12d30>, '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 0x10c936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb09b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:55 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 05:17:55 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 05:17:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:55 INFO - Return code: 0 05:17:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:17:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:17:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:17:56 INFO - Return code: 0 05:17:56 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 05:17:56 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --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 05:17:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FayIhaBmJA/Render', 05:17:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:56 INFO - 'HOME': '/Users/cltbld', 05:17:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:56 INFO - 'LOGNAME': 'cltbld', 05:17:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:56 INFO - 'MOZ_NO_REMOTE': '1', 05:17:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:56 INFO - 'NO_EM_RESTART': '1', 05:17:56 INFO - 'PAGER': '/bin/cat', 05:17:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:56 INFO - 'PWD': '/builds/slave/test', 05:17:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:56 INFO - 'SHELL': '/bin/bash', 05:17:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jOv1U3o6ZT/Listeners', 05:17:56 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:17:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:56 INFO - 'USER': 'cltbld', 05:17:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:56 INFO - 'XPC_FLAGS': '0x0', 05:17:56 INFO - 'XPC_SERVICE_NAME': '0', 05:17:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:56 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 05:17:57 INFO - mozversion application_buildid: 20160214030236 05:17:57 INFO - mozversion application_changeset: e355cacefc881ba360d412853b57e8e060e966f4 05:17:57 INFO - mozversion application_display_name: Nightly 05:17:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:57 INFO - mozversion application_name: Firefox 05:17:57 INFO - mozversion application_remotingname: firefox 05:17:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:17:57 INFO - mozversion application_vendor: Mozilla 05:17:57 INFO - mozversion application_version: 47.0a1 05:17:57 INFO - mozversion platform_buildid: 20160214030236 05:17:57 INFO - mozversion platform_changeset: e355cacefc881ba360d412853b57e8e060e966f4 05:17:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:17:57 INFO - mozversion platform_version: 47.0a1 05:17:57 INFO - using testdate: 1455455877 05:17:57 INFO - actual date: 1455455877 05:17:57 INFO - starting webserver on 'localhost:49707' 05:17:57 INFO - SUITE-START | Running 2 tests 05:17:57 INFO - TEST-START | dromaeo_css 05:17:57 INFO - operating with platform_type : mac_ 05:17:57 INFO - Initialising browser for dromaeo_css test... 05:17:57 INFO - TEST-INFO | started process 2090 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpN3nKKO/profile http://localhost:49707/getInfo.html) 05:17:59 INFO - PROCESS | 2090 | __metrics Screen width/height:1600/1200 05:17:59 INFO - PROCESS | 2090 | colorDepth:24 05:17:59 INFO - PROCESS | 2090 | Browser inner width/height: 1024/689 05:17:59 INFO - PROCESS | 2090 | __metrics 05:17:59 INFO - PROCESS | 2090 | 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" 05:17:59 INFO - PROCESS | 2090 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:18:00 INFO - TEST-INFO | 2090: exit 0 05:18:00 INFO - Browser initialized. 05:18:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:00 INFO - TEST-INFO | started process 2093 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpN3nKKO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:12 INFO - PROCESS | 2093 | RSS: Main: 246304768 05:18:12 INFO - PROCESS | 2093 | 05:19:03 INFO - PROCESS | 2093 | 1455455943396 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] 05:21:13 INFO - PROCESS | 2093 | Cycle 1(1): loaded http://localhost:49707/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49707/tests/dromaeo/cssquery-ext.html) 05:21:15 INFO - PROCESS | 2093 | RSS: Main: 472252416 05:21:15 INFO - PROCESS | 2093 | 05:24:18 INFO - PROCESS | 2093 | Cycle 1(1): loaded http://localhost:49707/tests/dromaeo/cssquery-ext.html (next: http://localhost:49707/tests/dromaeo/cssquery-jquery.html) 05:24:19 INFO - PROCESS | 2093 | RSS: Main: 382717952 05:24:19 INFO - PROCESS | 2093 | 05:27:21 INFO - PROCESS | 2093 | Cycle 1(1): loaded http://localhost:49707/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49707/tests/dromaeo/cssquery-mootools.html) 05:27:22 INFO - PROCESS | 2093 | RSS: Main: 378736640 05:27:22 INFO - PROCESS | 2093 | 05:30:24 INFO - PROCESS | 2093 | Cycle 1(1): loaded http://localhost:49707/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49707/tests/dromaeo/cssquery-prototype.html) 05:30:24 INFO - PROCESS | 2093 | RSS: Main: 373403648 05:30:24 INFO - PROCESS | 2093 | 05:33:28 INFO - PROCESS | 2093 | Cycle 1(1): loaded http://localhost:49707/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49707/tests/dromaeo/cssquery-yui.html) 05:33:28 INFO - PROCESS | 2093 | RSS: Main: 346402816 05:33:28 INFO - PROCESS | 2093 | 05:36:31 INFO - PROCESS | 2093 | Cycle 1(1): loaded http://localhost:49707/tests/dromaeo/cssquery-yui.html (next: http://localhost:49707/tests/dromaeo/cssquery-dojo.html) 05:36:31 INFO - PROCESS | 2093 | RSS: Main: 404836352 05:36:31 INFO - PROCESS | 2093 | 05:36:31 INFO - PROCESS | 2093 | __start_tp_report 05:36:31 INFO - PROCESS | 2093 | _x_x_mozilla_page_load 05:36:31 INFO - PROCESS | 2093 | _x_x_mozilla_page_load_details 05:36:31 INFO - PROCESS | 2093 | |i|pagename|runs| 05:36:31 INFO - PROCESS | 2093 | |0;dojo.html;3396.269801992572;3449.44808830587;3474.861005559777;3486.755927085105;3520.559930008749;5610.354809196943;5639.802606908759;5649.12438572022;5660.0660890952995;5670.489655930971;5661.943380566193;5680.176374425706;5714.314282286121;5805;5821.010428227201;5058.645894787366;5111.309973153623;5112.539871411572;5130.846074617767;5233.084210263189;5197.532222100011;5210.7655155517905;5238.161894096946;5258.684478931276;5295.232191332255;5048.545630893201;5071.543561079502;5149.176131818891;5154.304168937202;5216.556592689626;5139.280500729901;5140.177571588528;5143;5152.407473140599;5155.097857874857;5099.71951542665;5123.129068058439;5136.871578210537;5138.794448222066;5158.226266060084;5475.972620136914;5587.55299576037;5614.578906582023;5631.324241091054;5646.6894320812335;5178.223266510016;6135.570510064297;6143.9385606143815;6150.815475535741;6156.261248650146;6121.081837724332;6166.414190651881;6197.783077592308;6197.81406557804;6329.113924050636;5676.318841739017;5677.630953987978;5750.856228594235;5766.942330576682;5780.50865676418;6257.374262573797;6281.685915704196;6282.717277722513;6299.874002519924;6305.211848518935;6002.219711437485;6062.4726781385125;6067.878642427127;6154.415330543591;6155.7688462307715;6225.782097626652;6265.62406255617;6269.059641053878;6273.12176295319;6287.46556542699;6046.425589568984;6161.106639537242;6193.659348735772;6209.0996805462955;6214.223222097238;6127.372786728385;6130.917941862977;6138.51101655979;6144.754209831646;6145.586515101551;4820.325154478376;4840.515948405131;4870.8782280442565;4875.8049678012485;4911.386076740408;4362.149380870763;4368.956310436918;4375.671824613167;4381.474223093185;4412.4043254160915;5539.584531160179;5634.352049514277;5650.095984642519;5656.8020119295625;5663.433656634304;6212.316645169028;6263.248410190715;6265.624062556261;6284;6291.622502649856;5611.971940140274;5632.239647647515;5636.802711905064;5651.46311100453;5697.259356283656;5266.605004624592;5300.09898317287;5373.140297552372;5376.623636345496;5413.377461591967;6278.372162783685;6289.811305660837;6310.274318453345;6319.589226700158;6330.461910737455;6288.6855657217875;6297.149884765498;6305.4009869062365;6309.400606942333;6379.52153588492;6222.719977601109;6224.533160012927;6271.843203919939;6310.558260921692;6322.430981211529;6093.329733729375;6122.846928826815;6137.1101190328045;6146.200993870768;6165.630062196283;6182.072689096672;6199.349068347939;6212.844678883064;6220.533459990609;6226.221722284715;5897.174395584536;5924.4667979882015;6049.971504844275;6064.848378790565;6074.635521868525;5968.045112781934;6004.189434426471;6008.969955150371;6018.037114061729;6021.608595441282;4940.555350018371;5862.384449632727;5863.970680146572;5867.266591676041;5886.499647530008;5945.762169513171;6010.1585777991995;6032.306284777307;6094.939050609437;6103.6032657877095;5925.881482370414;5932.021216499229;5933.525317974465;5935.525157987437;5942.494887934574 05:36:31 INFO - PROCESS | 2093 | |1;ext.html;458.7545663070258;460.76270720578884;543.04695259819;570.6148349863844;628.6573817269589;36169.63830361696;38984;38991.22017559654;39016.804915975415;39087.609123908755;33073.33853322932;38782;39671;39813;40110;9304.209142222919;9537.904620953806;9544.236461083132;9545.188658963996;9545.284103692251;9437;9548.379355341915;9551.713448596518;9674.9516252419;9675.806483870318;9611.567479463441;9686.418814871095;9693.515324233795;9707.70876873695;9733.951330243373;9587.089226523469;9657.22742180624;9664.903350966471;9665.081817227423;9673.90326096737;9429.434233945985;9560.378575392646;9570.56932438042;9582.425054496753;9598.952005239998;40418.78743637696;40787;40829.795851020855;40843.795781020905;40876.59123408757;1731.284695267527;3286.2441638423056;3327.916802079943;3336.432806422914;3377.172592714776;26820.195394138205;27745;28289.71710282912;28472.572911406347;28474.003409880763;2743.6570428696414;2760.1995421327792;2855.6715977662625;2883.034183548493;2885.927851803701;354655;355113;399908;608876;624380;52022.739886300325;52180.73909630428;52626.73686631619;52726.73636631792;52824;54762.72618636881;54884.451155488736;55026;55073.44926550763;55089;16069.67860642804;16296;16304.266308016167;16332.75500867488;16343;12639.241645501299;12889.742205155844;12902.967762578972;12913;12918;19866.304679336154;19895.801041989685;19925.302614408425;19930.402087937386;20059.59880802405;7919.564423956737;8056.234657707509;8064.435489515795;8066.959665201636;8119.878201826978;906.2523418179896;924.8890133184061;966.3573723473811;1035.7467464368199;1058.5501162006271;29853;29961.400771984438;29984.55023174654;30018.685474397702;30064.248393789894;1079.379356869803;1095.6359332630766;1139.0659659079474;1205.6383085074442;1218.1899037140379;12760.872391275969;15070.773938390932;15086.924565377323;15352.692946141238;15514.689706205812;607581;615334;615606;616695;618150.8184918093;59487;59983;60000;60136.69931650401;60189;1373.086897213362;1380.3719307714966;1407.1346122134814;1412.1103704665995;1419.3258202354211;29448.82204711873;29706.257343566584;30235.848820755757;31001.68998309988;31085.533716994716;48213.276800847314;53496;54192.18711719249;54224.45775542194;54284;538069;540681;541298.0545680883;542187.289063568;543559;39882.40176397414;40652;41779.37330940099;41816.163676725686;41873.79063104665;42947.35578966256;43435.56564434315;44047;45293;45343;35664.64335356717;37390.626093739804;37639;38349;38986.415203772536;36987.63012369842;37033.629663704094;37783;38074.80962595169;38198.427023594115;37472.81263593664;37767.05582360463;38001.23997519979;38279.23441531098;38366;33426.66573334236;33660.32679346448;34171.31657366888;34200.97397078091;34247.48628770521;24986.875065624554;25591;25643.230703078938;26064.34839129037;26226.213213603623 05:36:31 INFO - PROCESS | 2093 | |2;jquery.html;313.25289185293076;366.5528055771959;368.776889981561;371.26119023143934;375.4893345050732;14619;14944.626384340398;18410.631787364244;18465.538361540952;19309.806901930995;18035.27858885643;18211.544711382223;18738.470306508618;19666.11502482388;19673.803261967376;5646.661200327993;5831.679257640828;5855;5858.941410585903;5879.382664820197;4191.622753952159;4383.232934236512;5759.568032397566;5822.446867547576;6156.84607884802;6090.725917333731;6272.059191121345;6352.872942541147;6359.65021923794;6370.872582548346;6250.562460627758;6317.305096439434;6324.051392291147;6326.0510923361635;6328.557001009931;5345.251664766935;5484.095124304525;5587.9941610510095;5588.189712491666;5589.972050139723;12465.626031219077;12467.94022508088;12648.430820613094;13016.153949993315;13043.543475978295;2041.1427200575795;2086.4992401823606;2235.8770267635273;2280.600894843396;2385.272491889973;8309.753536969443;8733.606987685569;9258.861117083248;9288.256939444827;9647.083527064917;1689.8732595055296;1729.4811556533116;1736.4269790969076;1738.0875040603657;1757.674830156425;88895.55552222262;89979.55010224972;90256;90637.54681226551;100164;8844.425112367675;10747.462626868626;10777.730556736144;10840.241183117263;11013;13132.934335328453;13257.138286011379;13266.40301186449;13278.468861245636;13282;8179.672813087529;8394.916050839536;8397.370197235232;8471.915280847235;8485;8575.957120214483;8582.613782379807;8638.697645582375;8675.21923026918;8684.826303474021;3706.5366829146355;4083.959160408417;4371.388005679208;4468.396766436489;4497.460304763449;1752.97370539442;1779.5729025034157;1843.6220574782137;1843.64970655575;1860.599971006213;857.1599832164513;910.6266430763487;936.4896131608153;1001.464216644092;1043.7547176413536;14744;19125.2349906005;19663.70504442406;19906.800931990783;20135.295264665667;863.4430792139035;898.3352319283683;920.0753242990752;990.9702708918744;1005.3163848583034;10742.665949692286;10787.617845742583;11144.33134011962;11399.715007124889;11444.771104577861;567424;576367;662403;765355;791660;107244.46377768062;111125;111194;111857.44071279591;117422.8257717429;1151.7408583068743;1198.9580364687195;1208.0939295528178;1209.1475509765594;1212.2786941769632;17279.827201728323;17604.119794010505;17640.73538896892;17709.645807084045;17997.280108796025;44057.77971110124;44212.55787442085;44425.55574444344;44896;46956.530434696586;62678.686606566676;64810.70378592496;64854.67572662106;65388.346116538225;66227.66886165539;7288.67200975968;7440.330370266702;7458.440616953641;7542.773716788505;7602.885956710543;6785.93214067853;7479.738209162653;10127.923775626126;10617.301231802874;11901.404929753651;6833.214180369321;8172.713955011546;10244.487775611338;10341.4312212829;10659.520321585393;9982;10236.744081398025;10239.436830974368;10436.63471778484;10449.216308777024;10339.276250662382;10413.739656508647;10532.57869685204;10732.678019659423;10812.67561973142;5837.620554663933;6292.11910332563;7461.291177338144;7570.886436703344;7673.923260767321;9398.812023759623;10453.006964338376;10459.320144190604;10644;10654 05:36:31 INFO - PROCESS | 2093 | |3;mootools.html;1401.1593044173492;1502.444095684597;1556.2607761313375;1771.8582513398928;1924.7112933060039;6657.33426657334;7911.41771645671;8666.869996950036;8666.956665216672;8668.479891206533;7672.46292759507;8310.085890552034;8341.791455213623;8630.439021463617;8639.308855291578;2143.624865648513;2208.845380823343;2395.64065390192;2433.2456938349123;2473.6165894286323;2459.938501537467;2482.503499300138;2489.601663733803;2494.3888747256947;2497.4505608766135;2430.8419952703016;2470.8764561771927;2473.826832121752;2474.2206205045354;2474.2453551666736;2275.488015196584;2281.23578601168;2300.953980920389;2304.066852924568;2309.4688221709102;2368.3842201027855;2400.3759022654235;2416.299273210767;2418.069043418279;2418.1294733895784;8678.826423471559;8754.956225218833;8759.693410730657;8765.561721913879;8788.51663158526;5305.628605997582;5473.917891231635;5503.422140675251;5503.834884953458;5512.39363669996;3588.8743893963588;3623.4564815277918;3728.1425272187275;3739.5886452490204;3745.831437585288;927.3137877970321;1049.0610903241632;1059.5814653212014;1064.8668916385452;1096.7916095941825;11871.940640296743;11876.821847672292;11895.702607434883;11902.523899044028;11925.403729813475;4849.854504364875;4853.684510506806;4882.316475693406;4891.804327826918;4922.778474968635;10008.14930730896;10052.849207261897;10059.547320370455;10061.993800619879;10062.597496100221;5467.808626698046;5472.398036216013;5474.91787623186;5484.643498172686;5487.478689524489;4916.139675556763;4981.078500477423;4984.077945580079;4984.551390374883;4994.825181118644;3501.6148223695373;3876.592957739453;3888.5916978716828;3900.395438707005;3937.684985201177;1282.3395951085013;1288.916220445668;1289.142720091129;1303.8565757766637;1307.7253776706807;1313.7766579681477;1324.6886981559326;1348.4538761801487;1355.898307626932;1356.7150898311268;6818.863622727517;7941.801454963556;8024.197580241929;8240.340772738167;8247.587620619064;1183.5975768238668;1183.928964262147;1187.8455800746021;1197.9760404791855;1198.4966314148078;6233.158523599256;6238.719257633417;6246.500279977591;6312.621242725451;6335.904961425582;10140.898591014144;10569.630062947914;10573.418461984666;10685;10713.78572428547;10020.24848136378;10600.99290567395;10705.83941240882;10727.517261723086;10727.946360268148;8126.593670316579;8283.337333013344;8288.544130072903;8324.916750832535;8335.833283334421;7953.6818527260575;7972.282494575284;8033.638486268015;8052.8792068117855;8083.989501312336;9323.533823308942;9367.765805854908;9601.32790704644;9637.518124093907;9748.463834489172;9762.658306959222;9776.951115244377;9781.364211326241;9977;10127.24045696561;6758.966205169139;6952.826179345557;7206.783796486114;7424.96287518559;7434.814129646802;8142.348612110898;8154.103048664523;8200.712975046083;8206.179382061746;8225.629846656795;7397.223291554309;7635.198304178203;7672.539647621161;7753.185915479019;7802.141764406025;7387.7783666490095;7492.288232617892;7552;7579.1284002340435;7653.387728981556;7591.734289300069;7650.4644674872225;7650.923490765021;7654.961725191339;7673.271039251262;6673.232578253369;6737.9326206737305;6754.8649027020165;6755.4257888080065;6814.727410903707;7179.533330333512;7218.061651985208;7237.276272372931;7238.022866912899;7245.492815502864 05:36:31 INFO - PROCESS | 2093 | |4;prototype.html;321.2514840421817;325.92014956335703;329.72962171019776;331.62526345229895;335.1905149065008;6302.527310451712;6532.118164047864;6571.0800487931665;6624.834379140524;6640.667966601674;6464.773732919349;6474.611523308593;6492.123563318951;6499.1876015498065;6505.479561635069;4734.90530189396;4785.999999999991;4838.104950584136;4857.222844344906;4870.245112007645;4828.71027738335;4837.830675926343;4849.908770526638;4854.587360074398;4855.053264613402;4537.546245375469;4569.131864945666;4629.976850115745;4672.415948006499;4711.740854253015;4641.814327426899;4645.535446455361;4650.395448591678;4650.511696271877;4673.509281525459;4043.251998380309;4057.878263652095;4058.2086493133556;4068.3490641497515;4068.3694027425795;6263.87472250557;6317.5893566918;6330.272018717815;6332.715027823759;6358.841028974266;5435.022973537441;5569.248151499536;5571.470710282517;5596.748146333425;5605.047141985872;6942.757003504853;6946.3053694630635;6953.721851125949;6954.895676564855;6957.61733104679;3918.8432462701458;4060.7360521566;4181.310083836163;4274.252005898955;4519.615832654228;5979.22270104888;6565.704543295563;7096.680649370791;7308.01341818853;7315.524490908074;4561.589456948891;4568.520305367955;4594.218982772936;4595.540445955445;4605.125026245003;4658.650601204923;4674.415698037746;4680.695754775928;4683;4698.342232087511;5045.192769156917;5177.197534382177;5311.548518375981;5520.779168833202;5525.11598144303;7036.788896333118;7038.5073044887395;7041.401480874183;7054.6472676367;7062;1332.7534406134896;1607.7106120898118;1609.855113039832;1611.4440518021263;1614.6932082904211;1025.6256466389714;1042.0517329230363;1047.0471870597871;1049.7585555322319;1061.7239517725293;6581.40767330933;6586.637734924625;6587.736490540325;6600.405963463215;6604.513984353578;7254.927450725425;7259.709611615476;7263.673134708951;7286.344229019308;7286.7085316586745;5477.561795056386;6383.776567820197;6570.704318305688;6574.276829548746;6580.374864387875;3842.4620553122586;3875.9612403876163;3876.457295978565;3883.708721845873;3884.8834534964;6215.968920155461;7595.620218989028;7620.466567340344;7642.69429222836;7647.923520764721;7299;7508.249175082448;7513.023306970059;7530.849383012419;7549.698012079565;6282.717277722422;7711.421643376769;7717.575533345607;7718.807029824299;7741.574213418204;7389.371903388057;7417.703291868264;7418.406527477681;7420.888686669597;7425.405967522694;6333.714982825876;6943.65281735901;7054.858902822018;7059.223485416497;7286.380657644159;7575.621218939141;7600.239976002576;7623.0270194623035;7623.313901748869;7639.968604238356;3981.2037592482197;4613.907721845477;4623.42207224097;4625.953740462553;4663.487016428122;7142.607156606228;7257.056582644434;7328.816779580553;7340.70637174507;7344.155422126524;5755.482006619424;7045.859082818212;7053.047838541731;7091.858162836817;7092;7004.719811207495;7057.470689698191;7059.399951004222;7062.364387205176;7065.540739851893;6637.402633762985;6877.037214789833;6904.861902761816;6924.4114250289285;6941.618210998444;5762.493315407811;5806;7046.964765176346;7073.469489788184;7079.82300442493;6708.26209116987;6910.827229319106;6911.516193866582;6916.827079323057;6917.688704008432 05:36:31 INFO - PROCESS | 2093 | |5;yui.html;669.1568623534346;698.4935921456943;715.5742333311678;720.4380583145148;733.0799846193026;13851.93074034631;14001.159930404183;14003.509877154302;14019.5093171739;14022.649433764149;13402;13445.058845880767;13450.663733406669;13463.663408414795;13464.798028029587;676.8612434450926;688.2360579756466;736.469741785916;830.236182711905;854.3506934729619;840.1682334488873;847.2459511035183;849.3587341557115;854.1458541458542;859.6776208921655;863.7754183912197;868.535333596526;871.6861929705301;874.7813046738315;875.4047247871445;716.7527203114917;728.2171665459625;881.0572687224673;897.3897749530316;899.2491269789733;667.3760034367882;667.4393509452084;670.0351493848891;670.4267850987384;672.3646154384109;14338.56984290473;14397.424103035866;14416.567502974927;14436.133831970115;14447.711045779131;12317.938410307892;12332.876671233353;12495.812562811565;12525.93737031318;12743.824441424866;8721.433106848035;9856.260780441495;9954.9502252489;10271.229657775622;10294.639687610972;3540.451230059319;3559.839807208656;3566;3574.088607405121;3621.4205727083804;81857.59071204666;82983.17016829815;83157.58421207916;83376.16623833745;83405.58297208475;9269.304802139866;9277;9384.8592271116;9687.951560242294;9863;20455.8977205113;20821.958902054837;21334.893325533583;21367.46581335479;21377.893110534347;6165.591602004499;7456.1798202197715;7544.509606875536;7646.541207527566;7754.3796496280165;4140.15126898985;4142.855000075043;4159;4161.667066634662;4209.621134097946;3488.947665785015;3533.7455203402938;3537.080359106599;3537.876174333886;3542.964570354315;526.7182057599166;610.366318876761;617.8331850400457;650.408128602969;652.6704014472756;526.3552148617913;559.5998860814537;568.6985897474345;638.9137466442064;645.3739872323838;8745.693900713444;9118.680846170351;9284.582193801296;9291.62833486653;9294.767630809283;440.5088326515976;490.17650347416685;531.7500774635915;532.6271609873104;567.9943200567941;3787.905302367463;3947.526296844397;3995.380715989026;4061.298100874793;4078.327076032481;98041.0195898032;101833.47249791259;101936;101973;102457.46313805299;81537;82875.5856220715;84412;85342.57328713317;85584;68132.3186768126;68465;69123.58067467716;69573;71741.6412917932;8500.957495212484;8795.780105497413;8827.911720882967;8922.776930576787;8952.418092823946;50843.74578127086;50896.72758181075;51297;51411.48588514217;53709.46290537045;70686.2328441793;72028.63985680038;72195.94628375964;72225.27774722186;72348.63825680838;10762.733364174861;10833.837492437777;10874;11484.827727583926;11884.049276057722;12044;12252.632421027383;12318.199317044364;12422.006239500999;12664.240145591293;11455.656330310105;11563.479643415898;11722.062235021007;11742.530298787953;12038.819417708566;11203.271787333797;11626.360550169822;11802.82295765547;11898.821517677068;12446;11228.606998755004;11277.210595258253;11277.774444511228;11543.283582089553;12277;9101.544922753968;9123.178913897782;9337.906620933703;9364.812703746024;9630.2777291702;8752.21230089295;9091.59087841062;9301.069893010645;9965.10314071737;9966.850497242693 05:36:31 INFO - PROCESS | 2093 | __end_tp_report 05:36:31 INFO - PROCESS | 2093 | __start_cc_report 05:36:31 INFO - PROCESS | 2093 | _x_x_mozilla_cycle_collect,2277 05:36:31 INFO - PROCESS | 2093 | __end_cc_report 05:36:31 INFO - PROCESS | 2093 | __startTimestamp1455456991790__endTimestamp 05:36:31 INFO - PROCESS | 2093 | 05:36:31 INFO - PROCESS | 2093 | ------- Summary: start ------- 05:36:31 INFO - PROCESS | 2093 | Number of tests: 6 05:36:31 INFO - PROCESS | 2093 | 05:36:31 INFO - PROCESS | 2093 | [#0] dojo.html Cycles:165 Average:5698.89 Median:5924.47 stddev:633.07 (10.7%) stddev-sans-first:608.70 05:36:31 INFO - PROCESS | 2093 | Values: 3396.3 3449.4 3474.9 3486.8 3520.6 5610.4 5639.8 5649.1 5660.1 5670.5 5661.9 5680.2 5714.3 5805.0 5821.0 5058.6 5111.3 5112.5 5130.8 5233.1 5197.5 5210.8 5238.2 5258.7 5295.2 5048.5 5071.5 5149.2 5154.3 5216.6 5139.3 5140.2 5143.0 5152.4 5155.1 5099.7 5123.1 5136.9 5138.8 5158.2 5476.0 5587.6 5614.6 5631.3 5646.7 5178.2 6135.6 6143.9 6150.8 6156.3 6121.1 6166.4 6197.8 6197.8 6329.1 5676.3 5677.6 5750.9 5766.9 5780.5 6257.4 6281.7 6282.7 6299.9 6305.2 6002.2 6062.5 6067.9 6154.4 6155.8 6225.8 6265.6 6269.1 6273.1 6287.5 6046.4 6161.1 6193.7 6209.1 6214.2 6127.4 6130.9 6138.5 6144.8 6145.6 4820.3 4840.5 4870.9 4875.8 4911.4 4362.1 4369.0 4375.7 4381.5 4412.4 5539.6 5634.4 5650.1 5656.8 5663.4 6212.3 6263.2 6265.6 6284.0 6291.6 5612.0 5632.2 5636.8 5651.5 5697.3 5266.6 5300.1 5373.1 5376.6 5413.4 6278.4 6289.8 6310.3 6319.6 6330.5 6288.7 6297.1 6305.4 6309.4 6379.5 6222.7 6224.5 6271.8 6310.6 6322.4 6093.3 6122.8 6137.1 6146.2 6165.6 6182.1 6199.3 6212.8 6220.5 6226.2 5897.2 5924.5 6050.0 6064.8 6074.6 5968.0 6004.2 6009.0 6018.0 6021.6 4940.6 5862.4 5864.0 5867.3 5886.5 5945.8 6010.2 6032.3 6094.9 6103.6 5925.9 5932.0 5933.5 5935.5 5942.5 05:36:31 INFO - PROCESS | 2093 | 05:36:31 INFO - PROCESS | 2093 | [#1] ext.html Cycles:180 Average:67733.17 Median:39379.30 stddev:146726.77 (372.6%) stddev-sans-first:147051.44 05:36:31 INFO - PROCESS | 2093 | Values: 458.8 460.8 543.0 570.6 628.7 36169.6 38984.0 38991.2 39016.8 39087.6 33073.3 38782.0 39671.0 39813.0 40110.0 9304.2 9537.9 9544.2 9545.2 9545.3 9437.0 9548.4 9551.7 9675.0 9675.8 9611.6 9686.4 9693.5 9707.7 9734.0 9587.1 9657.2 9664.9 9665.1 9673.9 9429.4 9560.4 9570.6 9582.4 9599.0 40418.8 40787.0 40829.8 40843.8 40876.6 1731.3 3286.2 3327.9 3336.4 3377.2 26820.2 27745.0 28289.7 28472.6 28474.0 2743.7 2760.2 2855.7 2883.0 2885.9 354655.0 355113.0 399908.0 608876.0 624380.0 52022.7 52180.7 52626.7 52726.7 52824.0 54762.7 54884.5 55026.0 55073.4 55089.0 16069.7 16296.0 16304.3 16332.8 16343.0 12639.2 12889.7 12903.0 12913.0 12918.0 19866.3 19895.8 19925.3 19930.4 20059.6 7919.6 8056.2 8064.4 8067.0 8119.9 906.3 924.9 966.4 1035.7 1058.6 29853.0 29961.4 29984.6 30018.7 30064.2 1079.4 1095.6 1139.1 1205.6 1218.2 12760.9 15070.8 15086.9 15352.7 15514.7 607581.0 615334.0 615606.0 616695.0 618150.8 59487.0 59983.0 60000.0 60136.7 60189.0 1373.1 1380.4 1407.1 1412.1 1419.3 29448.8 29706.3 30235.8 31001.7 31085.5 48213.3 53496.0 54192.2 54224.5 54284.0 538069.0 540681.0 541298.1 542187.3 543559.0 39882.4 40652.0 41779.4 41816.2 41873.8 42947.4 43435.6 44047.0 45293.0 45343.0 35664.6 37390.6 37639.0 38349.0 38986.4 36987.6 37033.6 37783.0 38074.8 38198.4 37472.8 37767.1 38001.2 38279.2 38366.0 33426.7 33660.3 34171.3 34201.0 34247.5 24986.9 25591.0 25643.2 26064.3 26226.2 05:36:31 INFO - PROCESS | 2093 | 05:36:31 INFO - PROCESS | 2093 | [#2] jquery.html Cycles:180 Average:34413.79 Median:2038.90 stddev:111938.52 (5490.1%) stddev-sans-first:112223.24 05:36:31 INFO - PROCESS | 2093 | Values: 313.3 366.6 368.8 371.3 375.5 14619.0 14944.6 18410.6 18465.5 19309.8 18035.3 18211.5 18738.5 19666.1 19673.8 5646.7 5831.7 5855.0 5858.9 5879.4 4191.6 4383.2 5759.6 5822.4 6156.8 6090.7 6272.1 6352.9 6359.7 6370.9 6250.6 6317.3 6324.1 6326.1 6328.6 5345.3 5484.1 5588.0 5588.2 5590.0 12465.6 12467.9 12648.4 13016.2 13043.5 2041.1 2086.5 2235.9 2280.6 2385.3 8309.8 8733.6 9258.9 9288.3 9647.1 1689.9 1729.5 1736.4 1738.1 1757.7 88895.6 89979.6 90256.0 90637.5 100164.0 8844.4 10747.5 10777.7 10840.2 11013.0 13132.9 13257.1 13266.4 13278.5 13282.0 8179.7 8394.9 8397.4 8471.9 8485.0 8576.0 8582.6 8638.7 8675.2 8684.8 3706.5 4084.0 4371.4 4468.4 4497.5 1753.0 1779.6 1843.6 1843.6 1860.6 857.2 910.6 936.5 1001.5 1043.8 14744.0 19125.2 19663.7 19906.8 20135.3 863.4 898.3 920.1 991.0 1005.3 10742.7 10787.6 11144.3 11399.7 11444.8 567424.0 576367.0 662403.0 765355.0 791660.0 107244.5 111125.0 111194.0 111857.4 117422.8 1151.7 1199.0 1208.1 1209.1 1212.3 17279.8 17604.1 17640.7 17709.6 17997.3 44057.8 44212.6 44425.6 44896.0 46956.5 62678.7 64810.7 64854.7 65388.3 66227.7 7288.7 7440.3 7458.4 7542.8 7602.9 6785.9 7479.7 10127.9 10617.3 11901.4 6833.2 8172.7 10244.5 10341.4 10659.5 9982.0 10236.7 10239.4 10436.6 10449.2 10339.3 10413.7 10532.6 10732.7 10812.7 5837.6 6292.1 7461.3 7570.9 7673.9 9398.8 10453.0 10459.3 10644.0 10654.0 05:36:31 INFO - PROCESS | 2093 | 05:36:31 INFO - PROCESS | 2093 | [#3] mootools.html Cycles:180 Average:6026.97 Median:5386.72 stddev:3154.33 (58.6%) stddev-sans-first:3144.01 05:36:31 INFO - PROCESS | 2093 | Values: 1401.2 1502.4 1556.3 1771.9 1924.7 6657.3 7911.4 8666.9 8667.0 8668.5 7672.5 8310.1 8341.8 8630.4 8639.3 2143.6 2208.8 2395.6 2433.2 2473.6 2459.9 2482.5 2489.6 2494.4 2497.5 2430.8 2470.9 2473.8 2474.2 2474.2 2275.5 2281.2 2301.0 2304.1 2309.5 2368.4 2400.4 2416.3 2418.1 2418.1 8678.8 8755.0 8759.7 8765.6 8788.5 5305.6 5473.9 5503.4 5503.8 5512.4 3588.9 3623.5 3728.1 3739.6 3745.8 927.3 1049.1 1059.6 1064.9 1096.8 11871.9 11876.8 11895.7 11902.5 11925.4 4849.9 4853.7 4882.3 4891.8 4922.8 10008.1 10052.8 10059.5 10062.0 10062.6 5467.8 5472.4 5474.9 5484.6 5487.5 4916.1 4981.1 4984.1 4984.6 4994.8 3501.6 3876.6 3888.6 3900.4 3937.7 1282.3 1288.9 1289.1 1303.9 1307.7 1313.8 1324.7 1348.5 1355.9 1356.7 6818.9 7941.8 8024.2 8240.3 8247.6 1183.6 1183.9 1187.8 1198.0 1198.5 6233.2 6238.7 6246.5 6312.6 6335.9 10140.9 10569.6 10573.4 10685.0 10713.8 10020.2 10601.0 10705.8 10727.5 10727.9 8126.6 8283.3 8288.5 8324.9 8335.8 7953.7 7972.3 8033.6 8052.9 8084.0 9323.5 9367.8 9601.3 9637.5 9748.5 9762.7 9777.0 9781.4 9977.0 10127.2 6759.0 6952.8 7206.8 7425.0 7434.8 8142.3 8154.1 8200.7 8206.2 8225.6 7397.2 7635.2 7672.5 7753.2 7802.1 7387.8 7492.3 7552.0 7579.1 7653.4 7591.7 7650.5 7650.9 7655.0 7673.3 6673.2 6737.9 6754.9 6755.4 6814.7 7179.5 7218.1 7237.3 7238.0 7245.5 05:36:31 INFO - PROCESS | 2093 | 05:36:31 INFO - PROCESS | 2093 | [#4] prototype.html Cycles:180 Average:5684.62 Median:6469.69 stddev:1844.50 (28.5%) stddev-sans-first:1805.21 05:36:31 INFO - PROCESS | 2093 | Values: 321.3 325.9 329.7 331.6 335.2 6302.5 6532.1 6571.1 6624.8 6640.7 6464.8 6474.6 6492.1 6499.2 6505.5 4734.9 4786.0 4838.1 4857.2 4870.2 4828.7 4837.8 4849.9 4854.6 4855.1 4537.5 4569.1 4630.0 4672.4 4711.7 4641.8 4645.5 4650.4 4650.5 4673.5 4043.3 4057.9 4058.2 4068.3 4068.4 6263.9 6317.6 6330.3 6332.7 6358.8 5435.0 5569.2 5571.5 5596.7 5605.0 6942.8 6946.3 6953.7 6954.9 6957.6 3918.8 4060.7 4181.3 4274.3 4519.6 5979.2 6565.7 7096.7 7308.0 7315.5 4561.6 4568.5 4594.2 4595.5 4605.1 4658.7 4674.4 4680.7 4683.0 4698.3 5045.2 5177.2 5311.5 5520.8 5525.1 7036.8 7038.5 7041.4 7054.6 7062.0 1332.8 1607.7 1609.9 1611.4 1614.7 1025.6 1042.1 1047.0 1049.8 1061.7 6581.4 6586.6 6587.7 6600.4 6604.5 7254.9 7259.7 7263.7 7286.3 7286.7 5477.6 6383.8 6570.7 6574.3 6580.4 3842.5 3876.0 3876.5 3883.7 3884.9 6216.0 7595.6 7620.5 7642.7 7647.9 7299.0 7508.2 7513.0 7530.8 7549.7 6282.7 7711.4 7717.6 7718.8 7741.6 7389.4 7417.7 7418.4 7420.9 7425.4 6333.7 6943.7 7054.9 7059.2 7286.4 7575.6 7600.2 7623.0 7623.3 7640.0 3981.2 4613.9 4623.4 4626.0 4663.5 7142.6 7257.1 7328.8 7340.7 7344.2 5755.5 7045.9 7053.0 7091.9 7092.0 7004.7 7057.5 7059.4 7062.4 7065.5 6637.4 6877.0 6904.9 6924.4 6941.6 5762.5 5806.0 7047.0 7073.5 7079.8 6708.3 6910.8 6911.5 6916.8 6917.7 05:36:31 INFO - PROCESS | 2093 | 05:36:31 INFO - PROCESS | 2093 | [#5] yui.html Cycles:180 Average:18887.18 Median:3387.98 stddev:27212.22 (803.2%) stddev-sans-first:27254.18 05:36:31 INFO - PROCESS | 2093 | Values: 669.2 698.5 715.6 720.4 733.1 13851.9 14001.2 14003.5 14019.5 14022.6 13402.0 13445.1 13450.7 13463.7 13464.8 676.9 688.2 736.5 830.2 854.4 840.2 847.2 849.4 854.1 859.7 863.8 868.5 871.7 874.8 875.4 716.8 728.2 881.1 897.4 899.2 667.4 667.4 670.0 670.4 672.4 14338.6 14397.4 14416.6 14436.1 14447.7 12317.9 12332.9 12495.8 12525.9 12743.8 8721.4 9856.3 9955.0 10271.2 10294.6 3540.5 3559.8 3566.0 3574.1 3621.4 81857.6 82983.2 83157.6 83376.2 83405.6 9269.3 9277.0 9384.9 9688.0 9863.0 20455.9 20822.0 21334.9 21367.5 21377.9 6165.6 7456.2 7544.5 7646.5 7754.4 4140.2 4142.9 4159.0 4161.7 4209.6 3488.9 3533.7 3537.1 3537.9 3543.0 526.7 610.4 617.8 650.4 652.7 526.4 559.6 568.7 638.9 645.4 8745.7 9118.7 9284.6 9291.6 9294.8 440.5 490.2 531.8 532.6 568.0 3787.9 3947.5 3995.4 4061.3 4078.3 98041.0 101833.5 101936.0 101973.0 102457.5 81537.0 82875.6 84412.0 85342.6 85584.0 68132.3 68465.0 69123.6 69573.0 71741.6 8501.0 8795.8 8827.9 8922.8 8952.4 50843.7 50896.7 51297.0 51411.5 53709.5 70686.2 72028.6 72195.9 72225.3 72348.6 10762.7 10833.8 10874.0 11484.8 11884.0 12044.0 12252.6 12318.2 12422.0 12664.2 11455.7 11563.5 11722.1 11742.5 12038.8 11203.3 11626.4 11802.8 11898.8 12446.0 11228.6 11277.2 11277.8 11543.3 12277.0 9101.5 9123.2 9337.9 9364.8 9630.3 8752.2 9091.6 9301.1 9965.1 9966.9 05:36:31 INFO - PROCESS | 2093 | -------- Summary: end -------- 05:36:31 INFO - PROCESS | 2093 | 05:36:32 INFO - TEST-INFO | 2093: exit 0 05:36:32 INFO - TEST-OK | dromaeo_css | took 1115140ms 05:36:32 INFO - TEST-START | kraken 05:36:32 INFO - operating with platform_type : mac_ 05:36:32 INFO - Initialising browser for kraken test... 05:36:32 INFO - TEST-INFO | started process 2097 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpxoRxFq/profile http://localhost:49707/getInfo.html) 05:36:34 INFO - PROCESS | 2097 | __metrics Screen width/height:1600/1200 05:36:34 INFO - PROCESS | 2097 | colorDepth:24 05:36:34 INFO - PROCESS | 2097 | Browser inner width/height: 1024/689 05:36:34 INFO - PROCESS | 2097 | __metrics 05:36:34 INFO - PROCESS | 2097 | 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" 05:36:34 INFO - PROCESS | 2097 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:35 INFO - TEST-INFO | 2097: exit 0 05:36:35 INFO - Browser initialized. 05:36:35 INFO - Running cycle 1/1 for kraken test... 05:36:35 INFO - TEST-INFO | started process 2100 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpxoRxFq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:47 INFO - PROCESS | 2100 | RSS: Main: 246235136 05:36:47 INFO - PROCESS | 2100 | 05:36:49 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49707/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:50 INFO - PROCESS | 2100 | RSS: Main: 292835328 05:36:50 INFO - PROCESS | 2100 | 05:36:53 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49707/tests/kraken/driver.html?testName=audio-dft) 05:36:53 INFO - PROCESS | 2100 | RSS: Main: 303820800 05:36:53 INFO - PROCESS | 2100 | 05:36:56 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49707/tests/kraken/driver.html?testName=audio-fft) 05:36:57 INFO - PROCESS | 2100 | RSS: Main: 285925376 05:36:57 INFO - PROCESS | 2100 | 05:36:59 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49707/tests/kraken/driver.html?testName=audio-oscillator) 05:37:00 INFO - PROCESS | 2100 | RSS: Main: 288665600 05:37:00 INFO - PROCESS | 2100 | 05:37:02 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49707/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:02 INFO - PROCESS | 2100 | RSS: Main: 287789056 05:37:02 INFO - PROCESS | 2100 | 05:37:05 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49707/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:05 INFO - PROCESS | 2100 | RSS: Main: 289923072 05:37:05 INFO - PROCESS | 2100 | 05:37:08 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49707/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:09 INFO - PROCESS | 2100 | RSS: Main: 289374208 05:37:09 INFO - PROCESS | 2100 | 05:37:12 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49707/tests/kraken/driver.html?testName=json-parse-financial) 05:37:12 INFO - PROCESS | 2100 | RSS: Main: 291913728 05:37:12 INFO - PROCESS | 2100 | 05:37:14 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49707/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:14 INFO - PROCESS | 2100 | RSS: Main: 324497408 05:37:14 INFO - PROCESS | 2100 | 05:37:16 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49707/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:17 INFO - PROCESS | 2100 | RSS: Main: 324734976 05:37:17 INFO - PROCESS | 2100 | 05:37:19 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49707/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:19 INFO - PROCESS | 2100 | RSS: Main: 332988416 05:37:19 INFO - PROCESS | 2100 | 05:37:22 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:22 INFO - PROCESS | 2100 | RSS: Main: 334843904 05:37:22 INFO - PROCESS | 2100 | 05:37:25 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:26 INFO - PROCESS | 2100 | RSS: Main: 334610432 05:37:26 INFO - PROCESS | 2100 | 05:37:27 INFO - PROCESS | 2100 | Cycle 1(1): loaded http://localhost:49707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49707/tests/kraken/driver.html?testName=ai-astar) 05:37:28 INFO - PROCESS | 2100 | RSS: Main: 394674176 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | __start_tp_report 05:37:28 INFO - PROCESS | 2100 | _x_x_mozilla_page_load 05:37:28 INFO - PROCESS | 2100 | _x_x_mozilla_page_load_details 05:37:28 INFO - PROCESS | 2100 | |i|pagename|runs| 05:37:28 INFO - PROCESS | 2100 | |0;ai-astar;109;109;110;111;111;110;116;111;114;159 05:37:28 INFO - PROCESS | 2100 | |1;audio-beat-detection;154;119;145;156;120;143;138;113;161;119 05:37:28 INFO - PROCESS | 2100 | |2;audio-dft;185;183;186;186;182;185;184;184;181;182 05:37:28 INFO - PROCESS | 2100 | |3;audio-fft;82;72;74;113;56;57;58;58;105;55 05:37:28 INFO - PROCESS | 2100 | |4;audio-oscillator;92;98;125;78;81;85;114;76;79;117 05:37:28 INFO - PROCESS | 2100 | |5;imaging-gaussian-blur;85;91;85;90;84;89;84;93;84;90 05:37:28 INFO - PROCESS | 2100 | |6;imaging-darkroom;93;93;92;95;92;92;93;92;92;93 05:37:28 INFO - PROCESS | 2100 | |7;imaging-desaturate;87;85;84;83;86;88;86;85;84;84 05:37:28 INFO - PROCESS | 2100 | |8;json-parse-financial;55;56;56;55;54;53;53;63;52;52 05:37:28 INFO - PROCESS | 2100 | |9;json-stringify-tinderbox;65;62;71;71;69;64;66;65;66;67 05:37:28 INFO - PROCESS | 2100 | |10;stanford-crypto-aes;81;82;84;82;82;80;82;83;84;82 05:37:28 INFO - PROCESS | 2100 | |11;stanford-crypto-ccm;121;125;126;111;121;126;127;125;129;115 05:37:28 INFO - PROCESS | 2100 | |12;stanford-crypto-pbkdf2;138;130;173;145;137;125;139;137;138;136 05:37:28 INFO - PROCESS | 2100 | |13;stanford-crypto-sha256-iterative;66;66;67;67;67;67;67;68;66;67 05:37:28 INFO - PROCESS | 2100 | __end_tp_report 05:37:28 INFO - PROCESS | 2100 | __start_cc_report 05:37:28 INFO - PROCESS | 2100 | _x_x_mozilla_cycle_collect,1124 05:37:28 INFO - PROCESS | 2100 | __end_cc_report 05:37:28 INFO - PROCESS | 2100 | __startTimestamp1455457048024__endTimestamp 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | ------- Summary: start ------- 05:37:28 INFO - PROCESS | 2100 | Number of tests: 14 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#0] ai-astar Cycles:10 Average:116.00 Median:111.00 stddev:15.27 (13.8%) stddev-sans-first:15.98 05:37:28 INFO - PROCESS | 2100 | Values: 109.0 109.0 110.0 111.0 111.0 110.0 116.0 111.0 114.0 159.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:144.00 stddev:17.76 (12.3%) stddev-sans-first:17.72 05:37:28 INFO - PROCESS | 2100 | Values: 154.0 119.0 145.0 156.0 120.0 143.0 138.0 113.0 161.0 119.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.75 (0.9%) stddev-sans-first:1.80 05:37:28 INFO - PROCESS | 2100 | Values: 185.0 183.0 186.0 186.0 182.0 185.0 184.0 184.0 181.0 182.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#3] audio-fft Cycles:10 Average:73.00 Median:58.00 stddev:21.15 (36.5%) stddev-sans-first:22.18 05:37:28 INFO - PROCESS | 2100 | Values: 82.0 72.0 74.0 113.0 56.0 57.0 58.0 58.0 105.0 55.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:80.00 stddev:18.14 (22.7%) stddev-sans-first:19.22 05:37:28 INFO - PROCESS | 2100 | Values: 92.0 98.0 125.0 78.0 81.0 85.0 114.0 76.0 79.0 117.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:89.50 stddev:3.44 (3.8%) stddev-sans-first:3.53 05:37:28 INFO - PROCESS | 2100 | Values: 85.0 91.0 85.0 90.0 84.0 89.0 84.0 93.0 84.0 90.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 05:37:28 INFO - PROCESS | 2100 | Values: 93.0 93.0 92.0 95.0 92.0 92.0 93.0 92.0 92.0 93.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.55 (1.8%) stddev-sans-first:1.50 05:37:28 INFO - PROCESS | 2100 | Values: 87.0 85.0 84.0 83.0 86.0 88.0 86.0 85.0 84.0 84.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:3.21 (5.8%) stddev-sans-first:3.41 05:37:28 INFO - PROCESS | 2100 | Values: 55.0 56.0 56.0 55.0 54.0 53.0 53.0 63.0 52.0 52.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:2.95 (4.4%) stddev-sans-first:3.07 05:37:28 INFO - PROCESS | 2100 | Values: 65.0 62.0 71.0 71.0 69.0 64.0 66.0 65.0 66.0 67.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.23 (1.5%) stddev-sans-first:1.22 05:37:28 INFO - PROCESS | 2100 | Values: 81.0 82.0 84.0 82.0 82.0 80.0 82.0 83.0 84.0 82.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:125.50 stddev:5.70 (4.5%) stddev-sans-first:6.02 05:37:28 INFO - PROCESS | 2100 | Values: 121.0 125.0 126.0 111.0 121.0 126.0 127.0 125.0 129.0 115.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:138.00 stddev:12.83 (9.3%) stddev-sans-first:13.59 05:37:28 INFO - PROCESS | 2100 | Values: 138.0 130.0 173.0 145.0 137.0 125.0 139.0 137.0 138.0 136.0 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - PROCESS | 2100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 05:37:28 INFO - PROCESS | 2100 | Values: 66.0 66.0 67.0 67.0 67.0 67.0 67.0 68.0 66.0 67.0 05:37:28 INFO - PROCESS | 2100 | -------- Summary: end -------- 05:37:28 INFO - PROCESS | 2100 | 05:37:28 INFO - TEST-INFO | 2100: exit 0 05:37:28 INFO - TEST-OK | kraken | took 56440ms 05:37:28 INFO - SUITE-END | took 1171s 05:37:29 INFO - Completed test suite (00:19:32) 05:37:29 INFO - Working with test: dromaeo_css 05:37:29 INFO - Generating results file: dromaeo_css 05:37:29 INFO - Working with test: kraken 05:37:29 INFO - Generating results file: kraken 05:37:29 INFO - javascript benchmark 05:37:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 05:37:29 INFO - process_Request line: dromaeo_css 7437.04 graph.html#tests=[[72,1,59]] 05:37:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:29 INFO - process_Request line: kraken 1402.40 graph.html#tests=[[232,1,59]] 05:37:29 INFO - RETURN: dromaeo_css: 7437.04 05:37:29 INFO - RETURN: kraken: 1402.40 05:37:29 INFO - javascript benchmark 05:37:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3396.269801992572, 3449.44808830587, 3474.861005559777, 3486.755927085105, 3520.559930008749, 5610.354809196943, 5639.802606908759, 5649.12438572022, 5660.0660890952995, 5670.489655930971, 5661.943380566193, 5680.176374425706, 5714.314282286121, 5805.0, 5821.010428227201, 5058.645894787366, 5111.309973153623, 5112.539871411572, 5130.846074617767, 5233.084210263189, 5197.532222100011, 5210.7655155517905, 5238.161894096946, 5258.684478931276, 5295.232191332255, 5048.545630893201, 5071.543561079502, 5149.176131818891, 5154.304168937202, 5216.556592689626, 5139.280500729901, 5140.177571588528, 5143.0, 5152.407473140599, 5155.097857874857, 5099.71951542665, 5123.129068058439, 5136.871578210537, 5138.794448222066, 5158.226266060084, 5475.972620136914, 5587.55299576037, 5614.578906582023, 5631.324241091054, 5646.6894320812335, 5178.223266510016, 6135.570510064297, 6143.9385606143815, 6150.815475535741, 6156.261248650146, 6121.081837724332, 6166.414190651881, 6197.783077592308, 6197.81406557804, 6329.113924050636, 5676.318841739017, 5677.630953987978, 5750.856228594235, 5766.942330576682, 5780.50865676418, 6257.374262573797, 6281.685915704196, 6282.717277722513, 6299.874002519924, 6305.211848518935, 6002.219711437485, 6062.4726781385125, 6067.878642427127, 6154.415330543591, 6155.7688462307715, 6225.782097626652, 6265.62406255617, 6269.059641053878, 6273.12176295319, 6287.46556542699, 6046.425589568984, 6161.106639537242, 6193.659348735772, 6209.0996805462955, 6214.223222097238, 6127.372786728385, 6130.917941862977, 6138.51101655979, 6144.754209831646, 6145.586515101551, 4820.325154478376, 4840.515948405131, 4870.8782280442565, 4875.8049678012485, 4911.386076740408, 4362.149380870763, 4368.956310436918, 4375.671824613167, 4381.474223093185, 4412.4043254160915, 5539.584531160179, 5634.352049514277, 5650.095984642519, 5656.8020119295625, 5663.433656634304, 6212.316645169028, 6263.248410190715, 6265.624062556261, 6284.0, 6291.622502649856, 5611.971940140274, 5632.239647647515, 5636.802711905064, 5651.46311100453, 5697.259356283656, 5266.605004624592, 5300.09898317287, 5373.140297552372, 5376.623636345496, 5413.377461591967, 6278.372162783685, 6289.811305660837, 6310.274318453345, 6319.589226700158, 6330.461910737455, 6288.6855657217875, 6297.149884765498, 6305.4009869062365, 6309.400606942333, 6379.52153588492, 6222.719977601109, 6224.533160012927, 6271.843203919939, 6310.558260921692, 6322.430981211529, 6093.329733729375, 6122.846928826815, 6137.1101190328045, 6146.200993870768, 6165.630062196283, 6182.072689096672, 6199.349068347939, 6212.844678883064, 6220.533459990609, 6226.221722284715, 5897.174395584536, 5924.4667979882015, 6049.971504844275, 6064.848378790565, 6074.635521868525, 5968.045112781934, 6004.189434426471, 6008.969955150371, 6018.037114061729, 6021.608595441282, 4940.555350018371, 5862.384449632727, 5863.970680146572, 5867.266591676041, 5886.499647530008, 5945.762169513171, 6010.1585777991995, 6032.306284777307, 6094.939050609437, 6103.6032657877095, 5925.881482370414, 5932.021216499229, 5933.525317974465, 5935.525157987437, 5942.494887934574], "unit": "score", "name": "dojo.html", "value": 5659.242588667087}, {"lowerIsBetter": false, "replicates": [458.7545663070258, 460.76270720578884, 543.04695259819, 570.6148349863844, 628.6573817269589, 36169.63830361696, 38984.0, 38991.22017559654, 39016.804915975415, 39087.609123908755, 33073.33853322932, 38782.0, 39671.0, 39813.0, 40110.0, 9304.209142222919, 9537.904620953806, 9544.236461083132, 9545.188658963996, 9545.284103692251, 9437.0, 9548.379355341915, 9551.713448596518, 9674.9516252419, 9675.806483870318, 9611.567479463441, 9686.418814871095, 9693.515324233795, 9707.70876873695, 9733.951330243373, 9587.089226523469, 9657.22742180624, 9664.903350966471, 9665.081817227423, 9673.90326096737, 9429.434233945985, 9560.378575392646, 9570.56932438042, 9582.425054496753, 9598.952005239998, 40418.78743637696, 40787.0, 40829.795851020855, 40843.795781020905, 40876.59123408757, 1731.284695267527, 3286.2441638423056, 3327.916802079943, 3336.432806422914, 3377.172592714776, 26820.195394138205, 27745.0, 28289.71710282912, 28472.572911406347, 28474.003409880763, 2743.6570428696414, 2760.1995421327792, 2855.6715977662625, 2883.034183548493, 2885.927851803701, 354655.0, 355113.0, 399908.0, 608876.0, 624380.0, 52022.739886300325, 52180.73909630428, 52626.73686631619, 52726.73636631792, 52824.0, 54762.72618636881, 54884.451155488736, 55026.0, 55073.44926550763, 55089.0, 16069.67860642804, 16296.0, 16304.266308016167, 16332.75500867488, 16343.0, 12639.241645501299, 12889.742205155844, 12902.967762578972, 12913.0, 12918.0, 19866.304679336154, 19895.801041989685, 19925.302614408425, 19930.402087937386, 20059.59880802405, 7919.564423956737, 8056.234657707509, 8064.435489515795, 8066.959665201636, 8119.878201826978, 906.2523418179896, 924.8890133184061, 966.3573723473811, 1035.7467464368199, 1058.5501162006271, 29853.0, 29961.400771984438, 29984.55023174654, 30018.685474397702, 30064.248393789894, 1079.379356869803, 1095.6359332630766, 1139.0659659079474, 1205.6383085074442, 1218.1899037140379, 12760.872391275969, 15070.773938390932, 15086.924565377323, 15352.692946141238, 15514.689706205812, 607581.0, 615334.0, 615606.0, 616695.0, 618150.8184918093, 59487.0, 59983.0, 60000.0, 60136.69931650401, 60189.0, 1373.086897213362, 1380.3719307714966, 1407.1346122134814, 1412.1103704665995, 1419.3258202354211, 29448.82204711873, 29706.257343566584, 30235.848820755757, 31001.68998309988, 31085.533716994716, 48213.276800847314, 53496.0, 54192.18711719249, 54224.45775542194, 54284.0, 538069.0, 540681.0, 541298.0545680883, 542187.289063568, 543559.0, 39882.40176397414, 40652.0, 41779.37330940099, 41816.163676725686, 41873.79063104665, 42947.35578966256, 43435.56564434315, 44047.0, 45293.0, 45343.0, 35664.64335356717, 37390.626093739804, 37639.0, 38349.0, 38986.415203772536, 36987.63012369842, 37033.629663704094, 37783.0, 38074.80962595169, 38198.427023594115, 37472.81263593664, 37767.05582360463, 38001.23997519979, 38279.23441531098, 38366.0, 33426.66573334236, 33660.32679346448, 34171.31657366888, 34200.97397078091, 34247.48628770521, 24986.875065624554, 25591.0, 25643.230703078938, 26064.34839129037, 26226.213213603623], "unit": "score", "name": "ext.html", "value": 19858.60239737466}, {"lowerIsBetter": false, "replicates": [313.25289185293076, 366.5528055771959, 368.776889981561, 371.26119023143934, 375.4893345050732, 14619.0, 14944.626384340398, 18410.631787364244, 18465.538361540952, 19309.806901930995, 18035.27858885643, 18211.544711382223, 18738.470306508618, 19666.11502482388, 19673.803261967376, 5646.661200327993, 5831.679257640828, 5855.0, 5858.941410585903, 5879.382664820197, 4191.622753952159, 4383.232934236512, 5759.568032397566, 5822.446867547576, 6156.84607884802, 6090.725917333731, 6272.059191121345, 6352.872942541147, 6359.65021923794, 6370.872582548346, 6250.562460627758, 6317.305096439434, 6324.051392291147, 6326.0510923361635, 6328.557001009931, 5345.251664766935, 5484.095124304525, 5587.9941610510095, 5588.189712491666, 5589.972050139723, 12465.626031219077, 12467.94022508088, 12648.430820613094, 13016.153949993315, 13043.543475978295, 2041.1427200575795, 2086.4992401823606, 2235.8770267635273, 2280.600894843396, 2385.272491889973, 8309.753536969443, 8733.606987685569, 9258.861117083248, 9288.256939444827, 9647.083527064917, 1689.8732595055296, 1729.4811556533116, 1736.4269790969076, 1738.0875040603657, 1757.674830156425, 88895.55552222262, 89979.55010224972, 90256.0, 90637.54681226551, 100164.0, 8844.425112367675, 10747.462626868626, 10777.730556736144, 10840.241183117263, 11013.0, 13132.934335328453, 13257.138286011379, 13266.40301186449, 13278.468861245636, 13282.0, 8179.672813087529, 8394.916050839536, 8397.370197235232, 8471.915280847235, 8485.0, 8575.957120214483, 8582.613782379807, 8638.697645582375, 8675.21923026918, 8684.826303474021, 3706.5366829146355, 4083.959160408417, 4371.388005679208, 4468.396766436489, 4497.460304763449, 1752.97370539442, 1779.5729025034157, 1843.6220574782137, 1843.64970655575, 1860.599971006213, 857.1599832164513, 910.6266430763487, 936.4896131608153, 1001.464216644092, 1043.7547176413536, 14744.0, 19125.2349906005, 19663.70504442406, 19906.800931990783, 20135.295264665667, 863.4430792139035, 898.3352319283683, 920.0753242990752, 990.9702708918744, 1005.3163848583034, 10742.665949692286, 10787.617845742583, 11144.33134011962, 11399.715007124889, 11444.771104577861, 567424.0, 576367.0, 662403.0, 765355.0, 791660.0, 107244.46377768062, 111125.0, 111194.0, 111857.44071279591, 117422.8257717429, 1151.7408583068743, 1198.9580364687195, 1208.0939295528178, 1209.1475509765594, 1212.2786941769632, 17279.827201728323, 17604.119794010505, 17640.73538896892, 17709.645807084045, 17997.280108796025, 44057.77971110124, 44212.55787442085, 44425.55574444344, 44896.0, 46956.530434696586, 62678.686606566676, 64810.70378592496, 64854.67572662106, 65388.346116538225, 66227.66886165539, 7288.67200975968, 7440.330370266702, 7458.440616953641, 7542.773716788505, 7602.885956710543, 6785.93214067853, 7479.738209162653, 10127.923775626126, 10617.301231802874, 11901.404929753651, 6833.214180369321, 8172.713955011546, 10244.487775611338, 10341.4312212829, 10659.520321585393, 9982.0, 10236.744081398025, 10239.436830974368, 10436.63471778484, 10449.216308777024, 10339.276250662382, 10413.739656508647, 10532.57869685204, 10732.678019659423, 10812.67561973142, 5837.620554663933, 6292.11910332563, 7461.291177338144, 7570.886436703344, 7673.923260767321, 9398.812023759623, 10453.006964338376, 10459.320144190604, 10644.0, 10654.0], "unit": "score", "name": "jquery.html", "value": 8810.949436931427}, {"lowerIsBetter": false, "replicates": [1401.1593044173492, 1502.444095684597, 1556.2607761313375, 1771.8582513398928, 1924.7112933060039, 6657.33426657334, 7911.41771645671, 8666.869996950036, 8666.956665216672, 8668.479891206533, 7672.46292759507, 8310.085890552034, 8341.791455213623, 8630.439021463617, 8639.308855291578, 2143.624865648513, 2208.845380823343, 2395.64065390192, 2433.2456938349123, 2473.6165894286323, 2459.938501537467, 2482.503499300138, 2489.601663733803, 2494.3888747256947, 2497.4505608766135, 2430.8419952703016, 2470.8764561771927, 2473.826832121752, 2474.2206205045354, 2474.2453551666736, 2275.488015196584, 2281.23578601168, 2300.953980920389, 2304.066852924568, 2309.4688221709102, 2368.3842201027855, 2400.3759022654235, 2416.299273210767, 2418.069043418279, 2418.1294733895784, 8678.826423471559, 8754.956225218833, 8759.693410730657, 8765.561721913879, 8788.51663158526, 5305.628605997582, 5473.917891231635, 5503.422140675251, 5503.834884953458, 5512.39363669996, 3588.8743893963588, 3623.4564815277918, 3728.1425272187275, 3739.5886452490204, 3745.831437585288, 927.3137877970321, 1049.0610903241632, 1059.5814653212014, 1064.8668916385452, 1096.7916095941825, 11871.940640296743, 11876.821847672292, 11895.702607434883, 11902.523899044028, 11925.403729813475, 4849.854504364875, 4853.684510506806, 4882.316475693406, 4891.804327826918, 4922.778474968635, 10008.14930730896, 10052.849207261897, 10059.547320370455, 10061.993800619879, 10062.597496100221, 5467.808626698046, 5472.398036216013, 5474.91787623186, 5484.643498172686, 5487.478689524489, 4916.139675556763, 4981.078500477423, 4984.077945580079, 4984.551390374883, 4994.825181118644, 3501.6148223695373, 3876.592957739453, 3888.5916978716828, 3900.395438707005, 3937.684985201177, 1282.3395951085013, 1288.916220445668, 1289.142720091129, 1303.8565757766637, 1307.7253776706807, 1313.7766579681477, 1324.6886981559326, 1348.4538761801487, 1355.898307626932, 1356.7150898311268, 6818.863622727517, 7941.801454963556, 8024.197580241929, 8240.340772738167, 8247.587620619064, 1183.5975768238668, 1183.928964262147, 1187.8455800746021, 1197.9760404791855, 1198.4966314148078, 6233.158523599256, 6238.719257633417, 6246.500279977591, 6312.621242725451, 6335.904961425582, 10140.898591014144, 10569.630062947914, 10573.418461984666, 10685.0, 10713.78572428547, 10020.24848136378, 10600.99290567395, 10705.83941240882, 10727.517261723086, 10727.946360268148, 8126.593670316579, 8283.337333013344, 8288.544130072903, 8324.916750832535, 8335.833283334421, 7953.6818527260575, 7972.282494575284, 8033.638486268015, 8052.8792068117855, 8083.989501312336, 9323.533823308942, 9367.765805854908, 9601.32790704644, 9637.518124093907, 9748.463834489172, 9762.658306959222, 9776.951115244377, 9781.364211326241, 9977.0, 10127.24045696561, 6758.966205169139, 6952.826179345557, 7206.783796486114, 7424.96287518559, 7434.814129646802, 8142.348612110898, 8154.103048664523, 8200.712975046083, 8206.179382061746, 8225.629846656795, 7397.223291554309, 7635.198304178203, 7672.539647621161, 7753.185915479019, 7802.141764406025, 7387.7783666490095, 7492.288232617892, 7552.0, 7579.1284002340435, 7653.387728981556, 7591.734289300069, 7650.4644674872225, 7650.923490765021, 7654.961725191339, 7673.271039251262, 6673.232578253369, 6737.9326206737305, 6754.8649027020165, 6755.4257888080065, 6814.727410903707, 7179.533330333512, 7218.061651985208, 7237.276272372931, 7238.022866912899, 7245.492815502864], "unit": "score", "name": "mootools.html", "value": 4927.381358785041}, {"lowerIsBetter": false, "replicates": [321.2514840421817, 325.92014956335703, 329.72962171019776, 331.62526345229895, 335.1905149065008, 6302.527310451712, 6532.118164047864, 6571.0800487931665, 6624.834379140524, 6640.667966601674, 6464.773732919349, 6474.611523308593, 6492.123563318951, 6499.1876015498065, 6505.479561635069, 4734.90530189396, 4785.999999999991, 4838.104950584136, 4857.222844344906, 4870.245112007645, 4828.71027738335, 4837.830675926343, 4849.908770526638, 4854.587360074398, 4855.053264613402, 4537.546245375469, 4569.131864945666, 4629.976850115745, 4672.415948006499, 4711.740854253015, 4641.814327426899, 4645.535446455361, 4650.395448591678, 4650.511696271877, 4673.509281525459, 4043.251998380309, 4057.878263652095, 4058.2086493133556, 4068.3490641497515, 4068.3694027425795, 6263.87472250557, 6317.5893566918, 6330.272018717815, 6332.715027823759, 6358.841028974266, 5435.022973537441, 5569.248151499536, 5571.470710282517, 5596.748146333425, 5605.047141985872, 6942.757003504853, 6946.3053694630635, 6953.721851125949, 6954.895676564855, 6957.61733104679, 3918.8432462701458, 4060.7360521566, 4181.310083836163, 4274.252005898955, 4519.615832654228, 5979.22270104888, 6565.704543295563, 7096.680649370791, 7308.01341818853, 7315.524490908074, 4561.589456948891, 4568.520305367955, 4594.218982772936, 4595.540445955445, 4605.125026245003, 4658.650601204923, 4674.415698037746, 4680.695754775928, 4683.0, 4698.342232087511, 5045.192769156917, 5177.197534382177, 5311.548518375981, 5520.779168833202, 5525.11598144303, 7036.788896333118, 7038.5073044887395, 7041.401480874183, 7054.6472676367, 7062.0, 1332.7534406134896, 1607.7106120898118, 1609.855113039832, 1611.4440518021263, 1614.6932082904211, 1025.6256466389714, 1042.0517329230363, 1047.0471870597871, 1049.7585555322319, 1061.7239517725293, 6581.40767330933, 6586.637734924625, 6587.736490540325, 6600.405963463215, 6604.513984353578, 7254.927450725425, 7259.709611615476, 7263.673134708951, 7286.344229019308, 7286.7085316586745, 5477.561795056386, 6383.776567820197, 6570.704318305688, 6574.276829548746, 6580.374864387875, 3842.4620553122586, 3875.9612403876163, 3876.457295978565, 3883.708721845873, 3884.8834534964, 6215.968920155461, 7595.620218989028, 7620.466567340344, 7642.69429222836, 7647.923520764721, 7299.0, 7508.249175082448, 7513.023306970059, 7530.849383012419, 7549.698012079565, 6282.717277722422, 7711.421643376769, 7717.575533345607, 7718.807029824299, 7741.574213418204, 7389.371903388057, 7417.703291868264, 7418.406527477681, 7420.888686669597, 7425.405967522694, 6333.714982825876, 6943.65281735901, 7054.858902822018, 7059.223485416497, 7286.380657644159, 7575.621218939141, 7600.239976002576, 7623.0270194623035, 7623.313901748869, 7639.968604238356, 3981.2037592482197, 4613.907721845477, 4623.42207224097, 4625.953740462553, 4663.487016428122, 7142.607156606228, 7257.056582644434, 7328.816779580553, 7340.70637174507, 7344.155422126524, 5755.482006619424, 7045.859082818212, 7053.047838541731, 7091.858162836817, 7092.0, 7004.719811207495, 7057.470689698191, 7059.399951004222, 7062.364387205176, 7065.540739851893, 6637.402633762985, 6877.037214789833, 6904.861902761816, 6924.4114250289285, 6941.618210998444, 5762.493315407811, 5806.0, 7046.964765176346, 7073.469489788184, 7079.82300442493, 6708.26209116987, 6910.827229319106, 6911.516193866582, 6916.827079323057, 6917.688704008432], "unit": "score", "name": "prototype.html", "value": 5068.647279842975}, {"lowerIsBetter": false, "replicates": [669.1568623534346, 698.4935921456943, 715.5742333311678, 720.4380583145148, 733.0799846193026, 13851.93074034631, 14001.159930404183, 14003.509877154302, 14019.5093171739, 14022.649433764149, 13402.0, 13445.058845880767, 13450.663733406669, 13463.663408414795, 13464.798028029587, 676.8612434450926, 688.2360579756466, 736.469741785916, 830.236182711905, 854.3506934729619, 840.1682334488873, 847.2459511035183, 849.3587341557115, 854.1458541458542, 859.6776208921655, 863.7754183912197, 868.535333596526, 871.6861929705301, 874.7813046738315, 875.4047247871445, 716.7527203114917, 728.2171665459625, 881.0572687224673, 897.3897749530316, 899.2491269789733, 667.3760034367882, 667.4393509452084, 670.0351493848891, 670.4267850987384, 672.3646154384109, 14338.56984290473, 14397.424103035866, 14416.567502974927, 14436.133831970115, 14447.711045779131, 12317.938410307892, 12332.876671233353, 12495.812562811565, 12525.93737031318, 12743.824441424866, 8721.433106848035, 9856.260780441495, 9954.9502252489, 10271.229657775622, 10294.639687610972, 3540.451230059319, 3559.839807208656, 3566.0, 3574.088607405121, 3621.4205727083804, 81857.59071204666, 82983.17016829815, 83157.58421207916, 83376.16623833745, 83405.58297208475, 9269.304802139866, 9277.0, 9384.8592271116, 9687.951560242294, 9863.0, 20455.8977205113, 20821.958902054837, 21334.893325533583, 21367.46581335479, 21377.893110534347, 6165.591602004499, 7456.1798202197715, 7544.509606875536, 7646.541207527566, 7754.3796496280165, 4140.15126898985, 4142.855000075043, 4159.0, 4161.667066634662, 4209.621134097946, 3488.947665785015, 3533.7455203402938, 3537.080359106599, 3537.876174333886, 3542.964570354315, 526.7182057599166, 610.366318876761, 617.8331850400457, 650.408128602969, 652.6704014472756, 526.3552148617913, 559.5998860814537, 568.6985897474345, 638.9137466442064, 645.3739872323838, 8745.693900713444, 9118.680846170351, 9284.582193801296, 9291.62833486653, 9294.767630809283, 440.5088326515976, 490.17650347416685, 531.7500774635915, 532.6271609873104, 567.9943200567941, 3787.905302367463, 3947.526296844397, 3995.380715989026, 4061.298100874793, 4078.327076032481, 98041.0195898032, 101833.47249791259, 101936.0, 101973.0, 102457.46313805299, 81537.0, 82875.5856220715, 84412.0, 85342.57328713317, 85584.0, 68132.3186768126, 68465.0, 69123.58067467716, 69573.0, 71741.6412917932, 8500.957495212484, 8795.780105497413, 8827.911720882967, 8922.776930576787, 8952.418092823946, 50843.74578127086, 50896.72758181075, 51297.0, 51411.48588514217, 53709.46290537045, 70686.2328441793, 72028.63985680038, 72195.94628375964, 72225.27774722186, 72348.63825680838, 10762.733364174861, 10833.837492437777, 10874.0, 11484.827727583926, 11884.049276057722, 12044.0, 12252.632421027383, 12318.199317044364, 12422.006239500999, 12664.240145591293, 11455.656330310105, 11563.479643415898, 11722.062235021007, 11742.530298787953, 12038.819417708566, 11203.271787333797, 11626.360550169822, 11802.82295765547, 11898.821517677068, 12446.0, 11228.606998755004, 11277.210595258253, 11277.774444511228, 11543.283582089553, 12277.0, 9101.544922753968, 9123.178913897782, 9337.906620933703, 9364.812703746024, 9630.2777291702, 8752.21230089295, 9091.59087841062, 9301.069893010645, 9965.10314071737, 9966.850497242693], "unit": "score", "name": "yui.html", "value": 6841.126778963441}], "name": "dromaeo_css", "value": 7437.039146228347}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 111.0, 111.0, 110.0, 116.0, 111.0, 114.0, 159.0], "unit": "score", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [154.0, 119.0, 145.0, 156.0, 120.0, 143.0, 138.0, 113.0, 161.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 136.8}, {"lowerIsBetter": true, "replicates": [185.0, 183.0, 186.0, 186.0, 182.0, 185.0, 184.0, 184.0, 181.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [82.0, 72.0, 74.0, 113.0, 56.0, 57.0, 58.0, 58.0, 105.0, 55.0], "unit": "score", "name": "audio-fft", "value": 73.0}, {"lowerIsBetter": true, "replicates": [92.0, 98.0, 125.0, 78.0, 81.0, 85.0, 114.0, 76.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.5}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 85.0, 90.0, 84.0, 89.0, 84.0, 93.0, 84.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 92.0, 95.0, 92.0, 92.0, 93.0, 92.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.7}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 84.0, 83.0, 86.0, 88.0, 86.0, 85.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 55.0, 54.0, 53.0, 53.0, 63.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [65.0, 62.0, 71.0, 71.0, 69.0, 64.0, 66.0, 65.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 84.0, 82.0, 82.0, 80.0, 82.0, 83.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [121.0, 125.0, 126.0, 111.0, 121.0, 126.0, 127.0, 125.0, 129.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [138.0, 130.0, 173.0, 145.0, 137.0, 125.0, 139.0, 137.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1402.3999999999999}]} 05:37:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1402.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7437.04"}}} 05:37:29 INFO - Return code: 0 05:37:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:29 INFO - # TBPL SUCCESS # 05:37:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:29 INFO - 2016-02-14 05:37:29.410 screenresolution[2104:23836] starting screenresolution argv=screenresolution get 05:37:29 INFO - 2016-02-14 05:37:29.413 screenresolution[2104:23836] Display 0: 1600x1200x32@60 05:37:29 INFO - 2016-02-14 05:37:29.418 screenresolution[2105:23839] starting screenresolution argv=screenresolution list 05:37:29 INFO - Available Modes on Display 0 05:37:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:29 INFO - Intel Iris: 05:37:29 INFO - Chipset Model: Intel Iris 05:37:29 INFO - Type: GPU 05:37:29 INFO - Bus: Built-In 05:37:29 INFO - VRAM (Dynamic, Max): 1536 MB 05:37:29 INFO - Vendor: Intel (0x8086) 05:37:29 INFO - Device ID: 0x0a2e 05:37:29 INFO - Revision ID: 0x0009 05:37:29 INFO - Displays: 05:37:29 INFO - Display: 05:37:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:29 INFO - Display Serial Number: 1600x1200 60 05:37:29 INFO - Main Display: Yes 05:37:29 INFO - Mirror: Off 05:37:29 INFO - Online: Yes 05:37:29 INFO - Rotation: Supported 05:37:29 INFO - Return code: 0 05:37:29 INFO - Running post-action listener: _resource_record_post_action 05:37:29 INFO - Running post-run listener: _resource_record_post_run 05:37:30 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 2154496; Write bytes: 712643072; Read time: 34; Write time: 2123 05:37:30 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 396888576; Write bytes: 395058688; Read time: 30132; Write time: 730 05:37:30 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 2154496; Write bytes: 301835264; Read time: 34; Write time: 1352 05:37:30 INFO - Running post-run listener: _upload_blobber_files 05:37:30 INFO - Blob upload gear active. 05:37:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:37:31 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:32 INFO - (blobuploader) - INFO - Done attempting. 05:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:33 INFO - (blobuploader) - INFO - Done attempting. 05:37:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:33 INFO - Return code: 0 05:37:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ab8f986c7f6fa893be3ff7e9374c015c3bc9919a5cca493b60e862bae8af5cf7073dce22d9402caa85886e1692d980999a8040b4ab0e58b17ce7954b2a37585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2507d10398b524ff9f900e3c3cfc5885588d80a0b73d1a1e9bbe23414ba2a9306a4bb5391b08d603da627d85cc2e65465ec95e7d12f9e3da8aa92de0071c003"} 05:37:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:33 INFO - Contents: 05:37:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ab8f986c7f6fa893be3ff7e9374c015c3bc9919a5cca493b60e862bae8af5cf7073dce22d9402caa85886e1692d980999a8040b4ab0e58b17ce7954b2a37585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2507d10398b524ff9f900e3c3cfc5885588d80a0b73d1a1e9bbe23414ba2a9306a4bb5391b08d603da627d85cc2e65465ec95e7d12f9e3da8aa92de0071c003"} 05:37:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:33 INFO - Copying logs to upload dir... 05:37:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.067817 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-02-14 05:37:33.409360) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-14 05:37:33.412823) ========= 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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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/9ab8f986c7f6fa893be3ff7e9374c015c3bc9919a5cca493b60e862bae8af5cf7073dce22d9402caa85886e1692d980999a8040b4ab0e58b17ce7954b2a37585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2507d10398b524ff9f900e3c3cfc5885588d80a0b73d1a1e9bbe23414ba2a9306a4bb5391b08d603da627d85cc2e65465ec95e7d12f9e3da8aa92de0071c003"} build_url:https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011117 build_url: 'https://queue.taskcluster.net/v1/task/cUzq-xY9Rky9gItsudUhpQ/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/9ab8f986c7f6fa893be3ff7e9374c015c3bc9919a5cca493b60e862bae8af5cf7073dce22d9402caa85886e1692d980999a8040b4ab0e58b17ce7954b2a37585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2507d10398b524ff9f900e3c3cfc5885588d80a0b73d1a1e9bbe23414ba2a9306a4bb5391b08d603da627d85cc2e65465ec95e7d12f9e3da8aa92de0071c003"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-14 05:37:33.441886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-14 05:37:33.442384) ========= 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.FayIhaBmJA/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.jOv1U3o6ZT/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005044 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-14 05:37:33.493653) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-14 05:37:33.494154) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-14 05:37:33.494802) ========= ========= Total master_lag: 0.36 =========