builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0063 starttime: 1458412977.46 results: success (0) buildid: 20160319104635 builduid: bc91c34a1c364e5f88b6cd432cb569ac revision: 332ce77a41c79b38bcb280655f6323bb8f70ec5d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.457706) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.458199) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.458480) ========= 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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005991 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.551959) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.552235) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.725337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.725712) ========= 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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005421 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.786774) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.787055) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.787382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:57.787649) ========= 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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-19 11:42:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 49.1M=0s 2016-03-19 11:42:57 (49.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173455 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:58.009343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:58.009645) ========= 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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.020438 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:58.063213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-19 11:42:58.063528) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 332ce77a41c79b38bcb280655f6323bb8f70ec5d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 332ce77a41c79b38bcb280655f6323bb8f70ec5d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PL17Pf8Oma/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.gWFpXyqmNS/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-19 11:42:58,132 truncating revision to first 12 chars 2016-03-19 11:42:58,132 Setting DEBUG logging. 2016-03-19 11:42:58,132 attempt 1/10 2016-03-19 11:42:58,132 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/332ce77a41c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-19 11:42:59,709 unpacking tar archive at: mozilla-aurora-332ce77a41c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.828543 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-19 11:42:59.925277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:59.925608) ========= echo 332ce77a41c79b38bcb280655f6323bb8f70ec5d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'332ce77a41c79b38bcb280655f6323bb8f70ec5d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PL17Pf8Oma/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.gWFpXyqmNS/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 332ce77a41c79b38bcb280655f6323bb8f70ec5d program finished with exit code 0 elapsedTime=0.005697 script_repo_revision: '332ce77a41c79b38bcb280655f6323bb8f70ec5d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:59.977056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:59.977391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 11:42:59.992061) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-03-19 11:42:59.992378) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PL17Pf8Oma/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.gWFpXyqmNS/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:43:00 INFO - MultiFileLogger online at 20160319 11:43:00 in /builds/slave/test 11:43:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:43:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:43:00 INFO - {'append_to_log': False, 11:43:00 INFO - 'base_work_dir': '/builds/slave/test', 11:43:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:43:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:43:00 INFO - 'branch': 'Mozilla-Aurora', 11:43:00 INFO - 'buildbot_json_path': 'buildprops.json', 11:43:00 INFO - 'config_files': ('talos/mac_config.py',), 11:43:00 INFO - 'default_actions': ('clobber', 11:43:00 INFO - 'read-buildbot-config', 11:43:00 INFO - 'download-and-extract', 11:43:00 INFO - 'populate-webroot', 11:43:00 INFO - 'create-virtualenv', 11:43:00 INFO - 'install', 11:43:00 INFO - 'run-tests'), 11:43:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:43:00 INFO - 'download_minidump_stackwalk': True, 11:43:00 INFO - 'download_symbols': 'ondemand', 11:43:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:43:00 INFO - 'tooltool.py': '/tools/tooltool.py', 11:43:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:43:00 INFO - '/tools/misc-python/virtualenv.py')}, 11:43:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:43:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:43:00 INFO - 'installer_path': 'installer.exe', 11:43:00 INFO - 'log_level': 'info', 11:43:00 INFO - 'log_name': 'talos', 11:43:00 INFO - 'log_to_console': True, 11:43:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:43:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:43:00 INFO - 'opt_config_files': (), 11:43:00 INFO - 'pip_index': False, 11:43:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:43:00 INFO - 'cmd': ('bash', 11:43:00 INFO - '-c', 11:43:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:43:00 INFO - 'enabled': True, 11:43:00 INFO - 'halt_on_failure': False, 11:43:00 INFO - 'name': 'check_screen_resolution'},), 11:43:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:43:00 INFO - 'cmd': ('bash', 11:43:00 INFO - '-c', 11:43:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:43:00 INFO - 'enabled': True, 11:43:00 INFO - 'halt_on_failure': False, 11:43:00 INFO - 'name': 'check_screen_resolution'},), 11:43:00 INFO - 'run_cmd_checks_enabled': True, 11:43:00 INFO - 'sps_profile': False, 11:43:00 INFO - 'sps_profile_interval': 0, 11:43:00 INFO - 'suite': 'dromaeojs', 11:43:00 INFO - 'system_bits': '32', 11:43:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:43:00 INFO - 'title': 't-yosemite-r7-0063', 11:43:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:43:00 INFO - 'use_talos_json': True, 11:43:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:43:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:43:00 INFO - 'work_dir': 'build'} 11:43:00 INFO - ##### 11:43:00 INFO - ##### Running clobber step. 11:43:00 INFO - ##### 11:43:00 INFO - Running pre-action listener: _resource_record_pre_action 11:43:00 INFO - Running main action method: clobber 11:43:00 INFO - rmtree: /builds/slave/test/build 11:43:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:43:02 INFO - Running post-action listener: _resource_record_post_action 11:43:02 INFO - ##### 11:43:02 INFO - ##### Running read-buildbot-config step. 11:43:02 INFO - ##### 11:43:02 INFO - Running pre-action listener: _resource_record_pre_action 11:43:02 INFO - Running main action method: read_buildbot_config 11:43:02 INFO - Using buildbot properties: 11:43:02 INFO - { 11:43:02 INFO - "project": "", 11:43:02 INFO - "product": "firefox", 11:43:02 INFO - "script_repo_revision": "production", 11:43:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:43:02 INFO - "repository": "", 11:43:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:43:02 INFO - "buildid": "20160319104635", 11:43:02 INFO - "pgo_build": "False", 11:43:02 INFO - "basedir": "/builds/slave/test", 11:43:02 INFO - "buildnumber": 228, 11:43:02 INFO - "slavename": "t-yosemite-r7-0063", 11:43:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:43:02 INFO - "platform": "yosemite_r7", 11:43:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:43:02 INFO - "branch": "mozilla-aurora", 11:43:02 INFO - "repo_path": "releases/mozilla-aurora", 11:43:02 INFO - "revision": "332ce77a41c79b38bcb280655f6323bb8f70ec5d", 11:43:02 INFO - "stage_platform": "macosx64", 11:43:02 INFO - "builduid": "bc91c34a1c364e5f88b6cd432cb569ac", 11:43:02 INFO - "slavebuilddir": "test" 11:43:02 INFO - } 11:43:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 11:43:02 INFO - Running post-action listener: _resource_record_post_action 11:43:02 INFO - ##### 11:43:02 INFO - ##### Running download-and-extract step. 11:43:02 INFO - ##### 11:43:02 INFO - Running pre-action listener: _resource_record_pre_action 11:43:02 INFO - Running main action method: download_and_extract 11:43:02 INFO - mkdir: /builds/slave/test/build/tests 11:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:02 INFO - https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:43:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 11:43:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 11:43:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 11:43:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 11:43:12 INFO - Downloaded 1277 bytes. 11:43:12 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 11:43:12 INFO - Using the following test package requirements: 11:43:12 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:43:12 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:43:12 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 11:43:12 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:43:12 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 11:43:12 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:43:12 INFO - u'jsshell-mac.zip'], 11:43:12 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:43:12 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 11:43:12 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:43:12 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:43:12 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 11:43:12 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:43:12 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 11:43:12 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:43:12 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 11:43:12 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:43:12 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:43:12 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 11:43:12 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:43: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')]} 11:43:12 INFO - https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:43:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:43:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:43:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:43:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:43:14 INFO - Downloaded 17868967 bytes. 11:43:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:43:18 INFO - Return code: 0 11:43:18 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:18 INFO - https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:43:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:43:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:43:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:43:20 INFO - Downloaded 17868967 bytes. 11:43:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:43:23 INFO - Return code: 0 11:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:23 INFO - https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:43:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:43:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:43:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:43:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:43:24 INFO - Downloaded 10845161 bytes. 11:43:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:43:25 INFO - Return code: 0 11:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:25 INFO - https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 11:43:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:43:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:43:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 11:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 11:43:30 INFO - Downloaded 114984274 bytes. 11:43:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:43:30 INFO - mkdir: /builds/slave/test/properties 11:43:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:43:30 INFO - Writing to file /builds/slave/test/properties/build_url 11:43:30 INFO - Contents: 11:43:30 INFO - build_url:https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:43:31 INFO - Running post-action listener: _resource_record_post_action 11:43:31 INFO - Running post-action listener: set_extra_try_arguments 11:43:31 INFO - ##### 11:43:31 INFO - ##### Running populate-webroot step. 11:43:31 INFO - ##### 11:43:31 INFO - Running pre-action listener: _resource_record_pre_action 11:43:31 INFO - Running main action method: populate_webroot 11:43:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:43:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:43:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:43:31 INFO - '--tppagecycles', 11:43:31 INFO - '7'], 11:43:31 INFO - 'tests': ['tsvgm']}}, 11:43:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:43:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:43:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:43:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:43:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:43:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:43:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:43:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:31 INFO - 'talos_options': ['--e10s'], 11:43:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:43:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:31 INFO - 'tests': ['damp', 'tps']}, 11:43:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:31 INFO - 'talos_options': ['--e10s'], 11:43:31 INFO - 'tests': ['damp', 'tps']}, 11:43:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:43:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:43:31 INFO - 'other': {'tests': ['a11yr', 11:43:31 INFO - 'ts_paint', 11:43:31 INFO - 'tpaint', 11:43:31 INFO - 'sessionrestore', 11:43:31 INFO - 'sessionrestore_no_auto_restore', 11:43:31 INFO - 'tabpaint']}, 11:43:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:43:31 INFO - 'tests': ['a11yr', 11:43:31 INFO - 'ts_paint', 11:43:31 INFO - 'tpaint', 11:43:31 INFO - 'sessionrestore', 11:43:31 INFO - 'sessionrestore_no_auto_restore', 11:43:31 INFO - 'tabpaint']}, 11:43:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:43:31 INFO - 'tests': ['a11yr', 11:43:31 INFO - 'ts_paint', 11:43:31 INFO - 'tpaint', 11:43:31 INFO - 'sessionrestore', 11:43:31 INFO - 'sessionrestore_no_auto_restore', 11:43:31 INFO - 'tabpaint']}, 11:43:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:43:31 INFO - 'tests': ['a11yr', 11:43:31 INFO - 'ts_paint', 11:43:31 INFO - 'tpaint', 11:43:31 INFO - 'sessionrestore', 11:43:31 INFO - 'sessionrestore_no_auto_restore', 11:43:31 INFO - 'tabpaint']}, 11:43:31 INFO - 'other_l64': {'tests': ['a11yr', 11:43:31 INFO - 'ts_paint', 11:43:31 INFO - 'tpaint', 11:43:31 INFO - 'sessionrestore', 11:43:31 INFO - 'sessionrestore_no_auto_restore', 11:43:31 INFO - 'tabpaint']}, 11:43:31 INFO - 'other_nol64': {'tests': ['a11yr', 11:43:31 INFO - 'ts_paint', 11:43:31 INFO - 'tpaint', 11:43:31 INFO - 'sessionrestore', 11:43:31 INFO - 'sessionrestore_no_auto_restore', 11:43:31 INFO - 'tabpaint']}, 11:43:31 INFO - 'svgr': {'tests': ['tsvgx', 11:43:31 INFO - 'tsvgr_opacity', 11:43:31 INFO - 'tart', 11:43:31 INFO - 'tscrollx', 11:43:31 INFO - 'cart']}, 11:43:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:43:31 INFO - 'tests': ['tsvgx', 11:43:31 INFO - 'tsvgr_opacity', 11:43:31 INFO - 'tart', 11:43:31 INFO - 'tscrollx', 11:43:31 INFO - 'cart']}, 11:43:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:31 INFO - 'tests': ['tp5o']}, 11:43:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:31 INFO - 'talos_options': ['--e10s'], 11:43:31 INFO - 'tests': ['tp5o']}, 11:43:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:31 INFO - 'talos_options': ['--xperf_path', 11:43:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:43:31 INFO - 'tests': ['tp5n']}, 11:43:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:31 INFO - 'talos_options': ['--e10s', 11:43:31 INFO - '--xperf_path', 11:43:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:43:31 INFO - 'tests': ['tp5n']}}, 11:43:31 INFO - 'talos.zip': {'path': '', 11:43:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:43:31 INFO - Running post-action listener: _resource_record_post_action 11:43:31 INFO - ##### 11:43:31 INFO - ##### Running create-virtualenv step. 11:43:31 INFO - ##### 11:43:31 INFO - Running pre-action listener: _resource_record_pre_action 11:43:31 INFO - Running main action method: create_virtualenv 11:43:31 INFO - Creating virtualenv /builds/slave/test/build/venv 11:43:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:43:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:43:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:43:31 INFO - Using real prefix '/tools/python27' 11:43:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:43:32 INFO - Installing distribute.............................................................................................................................................................................................done. 11:43:35 INFO - Installing pip.................done. 11:43:35 INFO - Return code: 0 11:43:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:35 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 0x1011d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9bcae870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:43:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:35 INFO - 'HOME': '/Users/cltbld', 11:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:35 INFO - 'LOGNAME': 'cltbld', 11:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:35 INFO - 'MOZ_NO_REMOTE': '1', 11:43:35 INFO - 'NO_EM_RESTART': '1', 11:43:35 INFO - 'PAGER': '/bin/cat', 11:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:35 INFO - 'PWD': '/builds/slave/test', 11:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:35 INFO - 'SHELL': '/bin/bash', 11:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:43:35 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:35 INFO - 'USER': 'cltbld', 11:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:35 INFO - 'XPC_FLAGS': '0x0', 11:43:35 INFO - 'XPC_SERVICE_NAME': '0', 11:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:43:35 INFO - Cleaning up... 11:43:35 INFO - Return code: 0 11:43:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:35 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 0x1011d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9bcae870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:43:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:35 INFO - 'HOME': '/Users/cltbld', 11:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:35 INFO - 'LOGNAME': 'cltbld', 11:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:35 INFO - 'MOZ_NO_REMOTE': '1', 11:43:35 INFO - 'NO_EM_RESTART': '1', 11:43:35 INFO - 'PAGER': '/bin/cat', 11:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:35 INFO - 'PWD': '/builds/slave/test', 11:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:35 INFO - 'SHELL': '/bin/bash', 11:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:43:35 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:35 INFO - 'USER': 'cltbld', 11:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:35 INFO - 'XPC_FLAGS': '0x0', 11:43:35 INFO - 'XPC_SERVICE_NAME': '0', 11:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:35 INFO - Downloading/unpacking psutil>=0.7.1 11:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:43:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:39 INFO - Installing collected packages: psutil 11:43:39 INFO - Running setup.py install for psutil 11:43:39 INFO - building 'psutil._psutil_osx' extension 11:43:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:43:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:43:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:43:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:43:39 INFO - building 'psutil._psutil_posix' extension 11:43:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:43:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:43:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:43:39 INFO - ^ 11:43:39 INFO - 1 warning generated. 11:43:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:43:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:39 INFO - Successfully installed psutil 11:43:39 INFO - Cleaning up... 11:43:39 INFO - Return code: 0 11:43:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:39 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 0x1011d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9bcae870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:43:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:43:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:39 INFO - 'HOME': '/Users/cltbld', 11:43:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:39 INFO - 'LOGNAME': 'cltbld', 11:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:39 INFO - 'MOZ_NO_REMOTE': '1', 11:43:39 INFO - 'NO_EM_RESTART': '1', 11:43:39 INFO - 'PAGER': '/bin/cat', 11:43:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:39 INFO - 'PWD': '/builds/slave/test', 11:43:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:39 INFO - 'SHELL': '/bin/bash', 11:43:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:43:39 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:43:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:39 INFO - 'USER': 'cltbld', 11:43:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:39 INFO - 'XPC_FLAGS': '0x0', 11:43:39 INFO - 'XPC_SERVICE_NAME': '0', 11:43:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:43:42 INFO - Installing collected packages: mozsystemmonitor 11:43:42 INFO - Running setup.py install for mozsystemmonitor 11:43:42 INFO - Successfully installed mozsystemmonitor 11:43:42 INFO - Cleaning up... 11:43:42 INFO - Return code: 0 11:43:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:42 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 0x1011d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9bcae870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:43:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:43:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:42 INFO - 'HOME': '/Users/cltbld', 11:43:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:42 INFO - 'LOGNAME': 'cltbld', 11:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:42 INFO - 'MOZ_NO_REMOTE': '1', 11:43:42 INFO - 'NO_EM_RESTART': '1', 11:43:42 INFO - 'PAGER': '/bin/cat', 11:43:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:42 INFO - 'PWD': '/builds/slave/test', 11:43:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:42 INFO - 'SHELL': '/bin/bash', 11:43:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:43:42 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:43:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:42 INFO - 'USER': 'cltbld', 11:43:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:42 INFO - 'XPC_FLAGS': '0x0', 11:43:42 INFO - 'XPC_SERVICE_NAME': '0', 11:43:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:43:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:43:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:46 INFO - Downloading docopt-0.6.1.tar.gz 11:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:43:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:43:46 INFO - Running setup.py install for blobuploader 11:43:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:43:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:43:46 INFO - Running setup.py install for requests 11:43:47 INFO - Running setup.py install for docopt 11:43:47 INFO - Successfully installed blobuploader requests docopt 11:43:47 INFO - Cleaning up... 11:43:47 INFO - Return code: 0 11:43:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:47 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 0x1011d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9bcae870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:43:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:43:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:47 INFO - 'HOME': '/Users/cltbld', 11:43:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:47 INFO - 'LOGNAME': 'cltbld', 11:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:47 INFO - 'MOZ_NO_REMOTE': '1', 11:43:47 INFO - 'NO_EM_RESTART': '1', 11:43:47 INFO - 'PAGER': '/bin/cat', 11:43:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:47 INFO - 'PWD': '/builds/slave/test', 11:43:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:47 INFO - 'SHELL': '/bin/bash', 11:43:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:43:47 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:43:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:47 INFO - 'USER': 'cltbld', 11:43:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:47 INFO - 'XPC_FLAGS': '0x0', 11:43:47 INFO - 'XPC_SERVICE_NAME': '0', 11:43:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:43:47 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-QI2DyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-aqQFBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-GxfOjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-EH1Xdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-4nvhZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-va5d3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-aCONuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-5Srlxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-bdyqFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-grld4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:43:48 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-YYc8ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:43:49 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-paXQ5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:43:49 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-9hzFv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:43:49 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-6LxGkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:43:49 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-j8Jlc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:43:49 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-cgA5pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:43:49 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-oJb6qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:43:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:43:49 INFO - Running setup.py install for manifestparser 11:43:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:43:49 INFO - Running setup.py install for mozcrash 11:43:49 INFO - Running setup.py install for mozdebug 11:43:50 INFO - Running setup.py install for mozdevice 11:43:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:43:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:43:50 INFO - Running setup.py install for mozfile 11:43:50 INFO - Running setup.py install for mozhttpd 11:43:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:43:50 INFO - Running setup.py install for mozinfo 11:43:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:43:50 INFO - Running setup.py install for mozInstall 11:43:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:43:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:43:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:43:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:43:50 INFO - Running setup.py install for mozleak 11:43:50 INFO - Running setup.py install for mozlog 11:43:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:43:51 INFO - Running setup.py install for moznetwork 11:43:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:43:51 INFO - Running setup.py install for mozprocess 11:43:51 INFO - Running setup.py install for mozprofile 11:43:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:43:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:43:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:43:51 INFO - Running setup.py install for mozrunner 11:43:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:43:51 INFO - Running setup.py install for mozscreenshot 11:43:51 INFO - Running setup.py install for moztest 11:43:52 INFO - Running setup.py install for mozversion 11:43:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:43:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:43:52 INFO - Cleaning up... 11:43:52 INFO - Return code: 0 11:43:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:52 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 0x1011d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9bcae870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:43:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:43:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:52 INFO - 'HOME': '/Users/cltbld', 11:43:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:52 INFO - 'LOGNAME': 'cltbld', 11:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:52 INFO - 'MOZ_NO_REMOTE': '1', 11:43:52 INFO - 'NO_EM_RESTART': '1', 11:43:52 INFO - 'PAGER': '/bin/cat', 11:43:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:52 INFO - 'PWD': '/builds/slave/test', 11:43:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:52 INFO - 'SHELL': '/bin/bash', 11:43:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:43:52 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:43:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:52 INFO - 'USER': 'cltbld', 11:43:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:52 INFO - 'XPC_FLAGS': '0x0', 11:43:52 INFO - 'XPC_SERVICE_NAME': '0', 11:43:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:43:52 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Hsdu0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:43:52 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-OJqeaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:43:52 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-a8oOLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:43:52 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-fdYVMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:43:52 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-tJLpfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-vbY1Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-s1tJHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-jUx_Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-XY8B9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-vv_a84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-3VTiwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-d03fNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-JtpvMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-V9nWQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:43:53 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-LUyR3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:43:54 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-LXylxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:43:54 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-d5ezpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:43:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:56 INFO - Downloading blessings-1.6.tar.gz 11:43:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:43:56 INFO - Installing collected packages: blessings 11:43:56 INFO - Running setup.py install for blessings 11:43:56 INFO - Successfully installed blessings 11:43:56 INFO - Cleaning up... 11:43:56 INFO - Return code: 0 11:43:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:43:57 INFO - Reading from file tmpfile_stdout 11:43:57 INFO - Current package versions: 11:43:57 INFO - blessings == 1.6 11:43:57 INFO - blobuploader == 1.2.4 11:43:57 INFO - docopt == 0.6.1 11:43:57 INFO - manifestparser == 1.1 11:43:57 INFO - mozInstall == 1.12 11:43:57 INFO - mozcrash == 0.17 11:43:57 INFO - mozdebug == 0.1 11:43:57 INFO - mozdevice == 0.48 11:43:57 INFO - mozfile == 1.2 11:43:57 INFO - mozhttpd == 0.7 11:43:57 INFO - mozinfo == 0.9 11:43:57 INFO - mozleak == 0.1 11:43:57 INFO - mozlog == 3.1 11:43:57 INFO - moznetwork == 0.27 11:43:57 INFO - mozprocess == 0.22 11:43:57 INFO - mozprofile == 0.28 11:43:57 INFO - mozrunner == 6.11 11:43:57 INFO - mozscreenshot == 0.1 11:43:57 INFO - mozsystemmonitor == 0.0 11:43:57 INFO - moztest == 0.7 11:43:57 INFO - mozversion == 1.4 11:43:57 INFO - psutil == 3.1.1 11:43:57 INFO - requests == 1.2.3 11:43:57 INFO - wsgiref == 0.1.2 11:43:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:43: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')]} 11:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43: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')]} 11:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:57 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 0x1011d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9bcae870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:43:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:43:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:57 INFO - 'HOME': '/Users/cltbld', 11:43:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:57 INFO - 'LOGNAME': 'cltbld', 11:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:57 INFO - 'MOZ_NO_REMOTE': '1', 11:43:57 INFO - 'NO_EM_RESTART': '1', 11:43:57 INFO - 'PAGER': '/bin/cat', 11:43:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:57 INFO - 'PWD': '/builds/slave/test', 11:43:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:57 INFO - 'SHELL': '/bin/bash', 11:43:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:43:57 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:43:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:57 INFO - 'USER': 'cltbld', 11:43:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:57 INFO - 'XPC_FLAGS': '0x0', 11:43:57 INFO - 'XPC_SERVICE_NAME': '0', 11:43:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:43:57 INFO - Cleaning up... 11:43:57 INFO - Return code: 0 11:43:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:43: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')]} 11:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43: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')]} 11:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:57 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 0x1011d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9bcae870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:43:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:43:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:57 INFO - 'HOME': '/Users/cltbld', 11:43:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:57 INFO - 'LOGNAME': 'cltbld', 11:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:57 INFO - 'MOZ_NO_REMOTE': '1', 11:43:57 INFO - 'NO_EM_RESTART': '1', 11:43:57 INFO - 'PAGER': '/bin/cat', 11:43:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:57 INFO - 'PWD': '/builds/slave/test', 11:43:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:57 INFO - 'SHELL': '/bin/bash', 11:43:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:43:57 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:43:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:57 INFO - 'USER': 'cltbld', 11:43:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:57 INFO - 'XPC_FLAGS': '0x0', 11:43:57 INFO - 'XPC_SERVICE_NAME': '0', 11:43:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:57 INFO - Downloading/unpacking jsonschema 11:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:00 INFO - Downloading/unpacking functools32 (from jsonschema) 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:00 INFO - warning: no files found matching '*.txt' 11:44:00 INFO - no previously-included directories found matching 'build' 11:44:00 INFO - no previously-included directories found matching 'dist' 11:44:00 INFO - no previously-included directories found matching '.git*' 11:44:00 INFO - Installing collected packages: jsonschema, functools32 11:44:00 INFO - Running setup.py install for functools32 11:44:00 INFO - warning: no files found matching '*.txt' 11:44:00 INFO - no previously-included directories found matching 'build' 11:44:00 INFO - no previously-included directories found matching 'dist' 11:44:00 INFO - no previously-included directories found matching '.git*' 11:44:00 INFO - Successfully installed jsonschema functools32 11:44:00 INFO - Cleaning up... 11:44:00 INFO - Return code: 0 11:44:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:00 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 0x1011d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9bcae870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:44:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:44:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:00 INFO - 'HOME': '/Users/cltbld', 11:44:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:00 INFO - 'LOGNAME': 'cltbld', 11:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:00 INFO - 'MOZ_NO_REMOTE': '1', 11:44:00 INFO - 'NO_EM_RESTART': '1', 11:44:00 INFO - 'PAGER': '/bin/cat', 11:44:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:00 INFO - 'PWD': '/builds/slave/test', 11:44:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:00 INFO - 'SHELL': '/bin/bash', 11:44:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:44:00 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:44:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:00 INFO - 'USER': 'cltbld', 11:44:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:00 INFO - 'XPC_FLAGS': '0x0', 11:44:00 INFO - 'XPC_SERVICE_NAME': '0', 11:44:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:01 INFO - Downloading/unpacking flake8 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:44:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:44:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:44:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:05 INFO - no previously-included directories found matching 'docs/_build' 11:44:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:44:05 INFO - Running setup.py install for pep8 11:44:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:05 INFO - no previously-included directories found matching 'docs/_build' 11:44:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:44:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:44:05 INFO - Cleaning up... 11:44:05 INFO - Return code: 0 11:44:05 INFO - Running post-action listener: _resource_record_post_action 11:44:05 INFO - Running post-action listener: _start_resource_monitoring 11:44:05 INFO - Starting resource monitoring. 11:44:05 INFO - ##### 11:44:05 INFO - ##### Running install step. 11:44:05 INFO - ##### 11:44:05 INFO - Running pre-action listener: _resource_record_pre_action 11:44:05 INFO - Running main action method: install 11:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:05 INFO - Reading from file tmpfile_stdout 11:44:05 INFO - Detecting whether we're running mozinstall >=1.0... 11:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:44:05 INFO - Reading from file tmpfile_stdout 11:44:05 INFO - Output received: 11:44:05 INFO - Usage: mozinstall [options] installer 11:44:05 INFO - Options: 11:44:05 INFO - -h, --help show this help message and exit 11:44:05 INFO - -d DEST, --destination=DEST 11:44:05 INFO - Directory to install application into. [default: 11:44:05 INFO - "/builds/slave/test"] 11:44:05 INFO - --app=APP Application being installed. [default: firefox] 11:44:05 INFO - mkdir: /builds/slave/test/build/application 11:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:44:37 INFO - Reading from file tmpfile_stdout 11:44:37 INFO - Output received: 11:44:37 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:44:37 INFO - Running post-action listener: _resource_record_post_action 11:44:37 INFO - ##### 11:44:37 INFO - ##### Running run-tests step. 11:44:37 INFO - ##### 11:44:37 INFO - Running pre-action listener: _resource_record_pre_action 11:44:37 INFO - Running main action method: run_tests 11:44:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:44:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:44:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:44:37 INFO - 2016-03-19 11:44:37.272 screenresolution[2154:61270] starting screenresolution argv=screenresolution get 11:44:37 INFO - 2016-03-19 11:44:37.275 screenresolution[2154:61270] Display 0: 1600x1200x32@60 11:44:37 INFO - 2016-03-19 11:44:37.281 screenresolution[2155:61272] starting screenresolution argv=screenresolution list 11:44:37 INFO - Available Modes on Display 0 11:44:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:44:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:44:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:44:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:44:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:44:37 INFO - Intel Iris: 11:44:37 INFO - Chipset Model: Intel Iris 11:44:37 INFO - Type: GPU 11:44:37 INFO - Bus: Built-In 11:44:37 INFO - VRAM (Dynamic, Max): 1536 MB 11:44:37 INFO - Vendor: Intel (0x8086) 11:44:37 INFO - Device ID: 0x0a2e 11:44:37 INFO - Revision ID: 0x0009 11:44:37 INFO - Displays: 11:44:37 INFO - Display: 11:44:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:44:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:44:37 INFO - Display Serial Number: 1600x1200 60 11:44:37 INFO - Main Display: Yes 11:44:37 INFO - Mirror: Off 11:44:37 INFO - Online: Yes 11:44:37 INFO - Rotation: Supported 11:44:37 INFO - Return code: 0 11:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:44:37 INFO - Python 2.7.3 11:44:37 INFO - Return code: 0 11:44:37 INFO - grabbing minidump binary from tooltool 11:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:37 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 0x101077d30>, '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 0x100edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:44:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:44:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:44:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:44:37 INFO - Return code: 0 11:44:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:44:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:44:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:44:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:44:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:44:38 INFO - Return code: 0 11:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PL17Pf8Oma/Render', 11:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:38 INFO - 'HOME': '/Users/cltbld', 11:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:38 INFO - 'LOGNAME': 'cltbld', 11:44:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:38 INFO - 'MOZ_NO_REMOTE': '1', 11:44:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:38 INFO - 'NO_EM_RESTART': '1', 11:44:38 INFO - 'PAGER': '/bin/cat', 11:44:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:38 INFO - 'PWD': '/builds/slave/test', 11:44:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:38 INFO - 'SHELL': '/bin/bash', 11:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWFpXyqmNS/Listeners', 11:44:38 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:38 INFO - 'USER': 'cltbld', 11:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:38 INFO - 'XPC_FLAGS': '0x0', 11:44:38 INFO - 'XPC_SERVICE_NAME': '0', 11:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:44:38 INFO - mozversion application_buildid: 20160319104635 11:44:38 INFO - mozversion application_changeset: 332ce77a41c79b38bcb280655f6323bb8f70ec5d 11:44:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:44:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:44:38 INFO - mozversion application_name: Firefox 11:44:38 INFO - mozversion application_remotingname: firefox-dev 11:44:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:44:38 INFO - mozversion application_vendor: Mozilla 11:44:38 INFO - mozversion application_version: 47.0a2 11:44:38 INFO - mozversion platform_buildid: 20160319104635 11:44:38 INFO - mozversion platform_changeset: 332ce77a41c79b38bcb280655f6323bb8f70ec5d 11:44:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:44:38 INFO - mozversion platform_version: 47.0a2 11:44:38 INFO - using testdate: 1458413078 11:44:38 INFO - actual date: 1458413078 11:44:38 INFO - starting webserver on 'localhost:50523' 11:44:38 INFO - SUITE-START | Running 2 tests 11:44:38 INFO - TEST-START | dromaeo_css 11:44:38 INFO - operating with platform_type : mac_ 11:44:38 INFO - Initialising browser for dromaeo_css test... 11:44:39 INFO - TEST-INFO | started process 2173 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpcjIRMl/profile http://localhost:50523/getInfo.html) 11:44:41 INFO - PROCESS | 2173 | __metrics Screen width/height:1600/1200 11:44:41 INFO - PROCESS | 2173 | colorDepth:24 11:44:41 INFO - PROCESS | 2173 | Browser inner width/height: 1024/689 11:44:41 INFO - PROCESS | 2173 | __metrics 11:44:41 INFO - PROCESS | 2173 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:44:41 INFO - PROCESS | 2173 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:44:41 INFO - TEST-INFO | 2173: exit 0 11:44:41 INFO - Browser initialized. 11:44:41 INFO - Running cycle 1/1 for dromaeo_css test... 11:44:41 INFO - TEST-INFO | started process 2176 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpcjIRMl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:53 INFO - PROCESS | 2176 | RSS: Main: 210792448 11:44:53 INFO - PROCESS | 2176 | 11:45:44 INFO - PROCESS | 2176 | 1458413144931 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:47:54 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50523/tests/dromaeo/cssquery-ext.html) 11:47:56 INFO - PROCESS | 2176 | RSS: Main: 329707520 11:47:56 INFO - PROCESS | 2176 | 11:50:58 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-ext.html (next: http://localhost:50523/tests/dromaeo/cssquery-jquery.html) 11:50:59 INFO - PROCESS | 2176 | RSS: Main: 341213184 11:50:59 INFO - PROCESS | 2176 | 11:54:01 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50523/tests/dromaeo/cssquery-mootools.html) 11:54:01 INFO - PROCESS | 2176 | RSS: Main: 346771456 11:54:01 INFO - PROCESS | 2176 | 11:57:04 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50523/tests/dromaeo/cssquery-prototype.html) 11:57:04 INFO - PROCESS | 2176 | RSS: Main: 307142656 11:57:04 INFO - PROCESS | 2176 | 12:00:07 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50523/tests/dromaeo/cssquery-yui.html) 12:00:08 INFO - PROCESS | 2176 | RSS: Main: 305696768 12:00:08 INFO - PROCESS | 2176 | 12:03:10 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-yui.html (next: http://localhost:50523/tests/dromaeo/cssquery-dojo.html) 12:03:11 INFO - PROCESS | 2176 | RSS: Main: 354439168 12:03:11 INFO - PROCESS | 2176 | 12:03:11 INFO - PROCESS | 2176 | __start_tp_report 12:03:11 INFO - PROCESS | 2176 | _x_x_mozilla_page_load 12:03:11 INFO - PROCESS | 2176 | _x_x_mozilla_page_load_details 12:03:11 INFO - PROCESS | 2176 | |i|pagename|runs| 12:03:11 INFO - PROCESS | 2176 | |0;dojo.html;3408.3864904317225;3450.2581944881863;3471.947920781188;3484.45990871415;3521.1549228185245;5750.769969201232;5756.856078598037;5762.308522977238;5765.3369862465825;5787.334456537495;5758.452946970042;5774.82675519735;5790.971045144779;5796.07262837946;5801.970990145043;4474.440694913136;5112.590992720592;5145.151050076733;5157.071727089123;5188.4811518848;5255.86860328491;5263.76313065911;5266.210068489719;5266.289050978126;5271;5197.818076367328;5238.869028274305;5258.605604579653;5273.920891186635;5284.788608455658;4657.301404789308;5229.764660590283;5262.605304602132;5265.473452654742;5304.973475132619;5061.038402703512;5191.428942816287;5205.063088644042;5213.452587478336;5215.217717342391;5630.971845140789;5646.830595082154;5676.744546495418;5694.487496125327;5722.027255366597;6118.862843290023;6132.722655450943;6226.190595222637;6239.532035097386;6250.499960003234;6179.81460556184;6207.81376558704;6211.627302361828;6222.937770622327;6236.376362363772;5897.144913987448;5906.468417842415;5908.763649454017;5915.171875937286;5937.079752638348;6184.536159788034;6221.626702397871;6287.371262873676;6313.305536390993;6313.715882785285;6124.816255512342;6183.350748171467;6192.628442293477;6196.287426945869;6200;6200.255969283715;6206.937930620727;6208.192934918432;6210.813675589739;6231.22109736283;6042.728077236535;6138.199401565478;6186;6224.284207316126;6227.9377206227355;6184.752609895644;6203.348648391944;6216.160818289473;6222.439980401786;6227.782027629011;4928.186849169847;4929.531694489017;4937.259411088366;4945.4807245238735;4956.231784073474;4340.631046361032;4372.759498227628;4482.641388688897;4486.842960496367;4531.161735079021;5730.914036289459;5731.398203188689;5743.8564035899435;5744.971275143681;5760.36635970043;6192;6217.813465596039;6221.62670239778;6230.719617617218;6257.43683068526;5543.307086614173;5656.943430565724;5739.7704091836695;5754.712264386764;5781.277340332458;5348.598855085884;5395.190721391744;5396.136618141157;5408.242846001563;5420.214068959979;6197.659128747782;6370.267419246846;6380.904286435707;6382.553221274559;6405.231372235362;6119.694015299307;6141.2098563120835;6157.353477884758;6176.722047507783;6179.752809887555;6277.654728989949;6281.748730050746;6293.779717709858;6300.086487459384;6307.180066591313;6094.390560944047;6161;6169.321374648875;6176.81469555914;6179.412955769195;6146.938530614637;6150.015997440567;6155.538334624832;6179.5056395489155;6228.190335256388;5945.019071853096;5989.221401217814;6014.458698716961;6014.699265036643;6034.969825150846;5870.442307980735;6018.51851851842;6021.458068773832;6025.367336429612;6025.397460253939;4913.582345500672;5703.116017017369;5848.590598658053;5908.7045647718305;5967.4629283362965;6062.363451837494;6101.590487878725;6104.661280298322;6116.853194528166;6120.510359171167;5858.9121163181735;5975.282966043928;5976.462118409364;5995.070764031582;6002.459778619946 12:03:11 INFO - PROCESS | 2176 | |1;ext.html;551.341147328942;561.5703986450364;598.6976576828704;615.3907631444871;661.5237029338875;32065.19837004076;32486.512702309454;32579.185520362003;41130.97172570687;41734;44354.89112772182;44406.7779661102;44527;44706.552934470645;44755.88110297244;9570.952145239264;9810.607575696999;9818.410895346266;9820.263480238975;9825.852612210823;9537.237021038334;9665;9669;9683.322167448281;9723.90276097237;9658.613655453773;9706.272029597772;9772.609095636202;9796.755081122994;9824.115829575338;9751.26865485088;9795.461249631267;9799.951000245024;9809.656662016867;9817.50912454378;9741.756456088584;9866.309358344919;9872.703818885446;9877.111060004563;9886.90113098867;43318.783406082766;43753.90615234613;43758.56241437577;43764;43896.56103438957;3267;3321.3523362944234;3410.215650400397;3435.7423193260606;3921.392184211452;24479.87760061206;28516.857415712788;28997.275068123465;29008.27479313013;29872.55191172134;2839.488891999439;2855.571664250379;2911.228524441025;2954.0547024952025;2961.304093538017;503310.4834475841;504742;505922;506712;507007;47878.28182577264;49013.019739605006;63633.68183159055;64957.675211624584;65293;48180.5181948183;48192;48478.5152148474;48558;48568.51431485711;17246.396376126777;17430.215640296217;17442.47672569825;17452.738208926876;17505.64988700219;13982.720345593234;14062.507812226522;14065.507707230197;14077.436902523785;14082.788758168635;15686.76469852953;15785.447509337118;15790.526284211492;15793.68412631741;15813.209339532978;6604.537682362285;6738.663066846638;6785.830354241183;6804.21751498584;6829.863402731918;922.1850524623042;1018.8675472188717;1042.1813934684026;1116.6370929447962;1165.2949965270889;27300;30000.699993000228;30323.393532129674;30648.60373829016;30913.227169320948;1095.5562996986234;1146.0659562456572;1148.4487446025955;1150.9366984815915;1154.2439701995038;15178.31697573612;15559.611009724847;15584.220788960507;15809.841901581067;15908;549563;551634;554570;554677;554924;63366.41583960438;63692.04461933075;63791.68104159449;63871;63888;1407.619942615488;1509.4037855047195;1549.7752825840416;1560.5006397952773;1569.8744100471936;29264.122076337742;29829;30268.24329391695;30819.69180308258;31422.214444639067;50655;50759.49240507548;51215.48784512256;51241.7437912808;51385.229221562455;372198;372993;373460;375240;375308;30065.3986920256;34549.827250863586;34751.65248347484;35021.64978350286;35392.29215415729;42877.3568396468;43714.56285437105;44280;44299.557004429545;44744.77627611841;35151.12122196965;35911.92264232077;38659.6134038656;38673.613263867;38727.6127238724;36302;36458;36669.63330366662;36979.630203698696;37174.44238336481;36261.27477450489;36293.81853090718;36633.08417289589;37128.62133244061;37616;31937.36125277435;34679;35178.120546985505;35942.460863086555;36149.63850361568;21670.6749398756;25231.621525677496;25405.364865878502;25581.3604659885;25906.48187036211 12:03:11 INFO - PROCESS | 2176 | |2;jquery.html;387.94568760373545;388.9124946886949;392.5544506984572;393.6378531750789;397.14019148543406;17558.946463212185;19700.802991970093;20973.47566310843;20979.37061888142;21037.68443473349;12234.93882530586;12646.241225526475;21479.92600369983;22103.557928841452;22206.222782202625;4987.3017777510995;5460.372057213432;5617.494425501704;5655.830325090254;5667;4236.9576304237025;4282.102050282039;4429.512753597101;4485.170243504962;6935.618540980244;6562.770303039395;6722.764703235388;6740.797776066725;6742.797716068501;6844.589324640538;5805.071188609844;6061.878762424771;6064.96967515164;6655.168103987002;6712.160979877515;4031.133306339151;5623.522000629951;5836.124581312794;5845.269341332333;5866.501347385477;13808.585742427744;13812.654683632889;13875.889928805773;14012.22932738699;14016.929915350358;2085.655866781979;2160.5678864227216;2204.360735386736;2505.3235626380956;2899.347646779479;8851.46891186531;9552.713418597454;10301.433421161833;12658.873411265862;15490.50949050949;1821.0257512230894;1825.1148193126323;1838.4117082533594;1886.981130188708;1906.5710215201607;76533;89345.55327223387;95169;102323;107849.38225926696;11483.827742583868;11881.88118118825;11945.402729863472;11980.700482487833;12009.579664711868;14726.558203253919;14772.926135369255;14775.482858099915;14803.62990925214;14815.259237038104;9189.494577798152;9300.90699093014;9327.486988215713;9393.483358415353;9413.717588472357;9507.286953478517;9541.093596108358;9561.808763824823;9656.22750179984;9680.46757428334;4658.3711198988385;4730.053989202173;4733.95266047342;4753.429588449409;4792.329073929653;1950.414875537333;1981.0986001369342;1984.295575070858;1989.19437627761;2015.516276093727;907.668700924158;1005.0201053972319;1009.4397609326747;1060.7083052160563;1080.2114456446682;20736.688949665768;21045.36863894055;21090.683639745417;21122.894385527972;21146.471338216666;979.8922118566952;981.16600889245;994.651871844863;1022.0801278848946;1028.93311934724;11062;11560.479778409992;11562.421878906189;11592.536298548132;11621.941890290494;600198;618669;628299;630104;631142;88369.55815220883;95854;121206;123495;123609;1047.5076713944434;1067.2475904487317;1098.2970898624887;1128.3230061962756;1129.3393364881472;18253.45239642813;18337.358192463198;19125.330613428465;19186.232550698373;19187.32844350441;52526.949461009805;53053.46946530485;54445.72777136089;54510.727446362514;61982;78924;80203.79694304707;80436.98907527358;82160;82353.58823205845;7773.261540153676;8236.917630823615;8306.293965013041;8366.83266334682;8577.914220857961;7707.884381734167;10315.071643551817;12536.874631253571;13012.739745205232;13850.722985540031;11661.825072624088;11744.295342279149;11940.582079627171;11974.700632484257;12027.45876435545;11427.828582571101;11637.06903447739;11652;11766.294022358687;12026.699332516408;11790.764184716087;11799.410029498318;11970;12113.576024839089;12221.083418743452;8305.875411868949;8621.396502244783;8771.824563508822;11859.466324015613;11881.405929703307;10956.526942524584;11593.304401735923;11838.328052208855;11864.584739534075;11947.641570752892 12:03:11 INFO - PROCESS | 2176 | |3;mootools.html;1370.1231212024313;1625.6179797747527;1643.4740882917467;1973.3389314579615;2078.096028227721;8492.405531612781;9131.954340228298;9298.488583127924;9304.627814887413;9323.440593564383;8914.95542522288;9126.361154719172;9145.993940666522;9159.175674189322;9164.541772911345;2317.9072837086496;2541.136013755323;2573.3052075939486;2602.401447667028;2609.191150743266;2624.855632940197;2628.789696824259;2632.828866123705;2632.8420294782372;2635.0382110529613;2494.463690306584;2589.249117755858;2594.3125071855975;2595.0917178987393;2598.142612937726;2308.6998690170253;2526.12848567244;2569.5503286924713;2578.046122934526;2594.377349436141;2550.477152183798;2584.4572639745675;2623.9475210495875;2627.041129987541;2629.815912886099;9089.181973622406;9152.954235228848;9160.129787670227;9166.991630920593;9202.907970920272;5676.176954341598;5841.766329346821;5843.883122337529;5849.151872978395;5854.5023672987845;3666.4500324951205;3770.2082562661876;3794.051487128218;3799.734018618698;3842.4236364545263;894.552723638181;1003.2926786615419;1062.3625824505311;1085.3921803789904;1114.1254115519278;12487.31319777412;12537.498500059986;12552.81170782439;12555.183913045714;12564.560240391542;4424.469063712375;4708.8116475341285;5143.996920600522;5149.356330458692;5175.353080864892;10266.691999240034;10781.299215550964;10783.245172837984;10784.946075269574;10801.405922674328;5773.3072031356505;5774.826755197267;5780.046292361797;5780.942190578125;5785.190073389729;4265.829366825292;4632.397788287569;4794.496577859344;5081.568066714297;5088.516590923857;4145.233131870614;4198.748075115503;4212.136512015029;4249.426327445817;4254.3831144483875;1343.43575698207;1367.7332920080687;1375.5116933488669;1384.2455861555477;1385.819843420349;1425.0452197028017;1453.6729235922044;1455.083297522554;1467.875230605389;1478.3051965576162;8479.279261262738;8489.235968762841;8545.401821872534;8556.40105192643;8558.657653693906;531.3013387395563;542.7937383794211;545.6398776807367;550.2489102375229;557.1086261980879;6451.774187903401;6469.611823290524;6479.514036447191;6518.250401203827;6553.017047442826;10959.780804383867;11431.314121152758;11432.542698292142;11452;11466.827997580043;11039.944800275947;11131.276467029616;11216.990470857661;11239.83140252897;11305.886941130484;7339.339459448675;8786.560671966376;8805.647774089093;8885.111488851193;8888.822223555493;8153.306968907472;8334.458260213067;8364.66541338364;8389.370797190357;8404.789880253042;8484.703035393732;9923.55344009507;10058.446785426579;10176.694699159038;10233.795324093626;10350;10411.791764164826;10515.73710657209;10546.894531054899;10571.735706607089;6468.870622587616;7212.89180662301;7398.11222653285;7739.806504837424;7934.801629959297;8585.785355366166;8586.184312490554;8638;8642.827143457222;8648.091950345375;7449.739259125905;7587.734429294948;7615.7334493292465;7676.232376762279;7683.0780306363595;7446.180920098893;7473.51422157558;7501.474896757175;7614.543127412373;7635.389168866366;7929.048514178336;8080;8095.676172953016;8103.1491693371345;8106;7255.709771609077;7265.818354541178;7297.379722723628;7317;7326.084239470067;7384.076990376203;7394.704211831467;7414.777556673308;7427.925720742724;7430.888536672062 12:03:11 INFO - PROCESS | 2176 | |4;prototype.html;336.4851776781524;343.23287452543576;348.9441689329707;349.4321727193311;355.4064711931075;6570.540062195648;6588.637624930633;6599.472042236622;6606.867862642756;6641.435477984371;6535.54251202416;6550.475961923046;6554.147960765094;6564.901526477095;6571.3100124486955;4605.608523275526;4657.161710892038;4672.929906051412;4786.56920877121;4871.683340582859;4769.093872164278;4774.188387974035;4796.3764710587575;4804.783784729696;4810.446798618152;4246.766427846467;4561.498235194126;4773.665843390964;4782.545658162469;4798.160321943664;4536.455625324949;4719.244920812654;4724.834630787906;4726.952730472685;4775.3553270308585;4011.578784227643;4089.1003979124544;4095.058136628592;4114.218298523271;4117.691173161995;6160.5687601867885;6277.2153480814895;6282.403171698681;6291.559590828644;6293.181886354744;5694.544436445074;5696.515796157331;5699.059655156894;5718.456746609107;5732.111522713986;6973.755918542877;6978.685959131852;6979.9181126925405;6982.720691172347;6986.951957206409;4522.909541809146;4679.064187162547;4716.622670186377;4721.527847215285;4729.243321068647;7275.199048366364;7305.1233851938105;7342.302481264324;7343.926560734378;7346.926530734678;4048.2308361411237;4741.905161896742;4766.95233047672;4773.665843390999;4776.14029474691;4838.685485443505;4839;4849.2726091086615;4857.927131093036;4858.514148585184;5651.237082993825;5656.632318899258;5657.519110875622;5673.461021202979;5677.83604361105;6670.966645166744;6960.798032904921;7029.26192749754;7040.295970403021;7083;1456.4247122386598;1573.3942432163471;1639;1640.097946129624;1640.409452597064;1048.4024106259512;1050.3592808386877;1062.219268837404;1065.63235683689;1078.940658263803;6271.7804876830005;6458.773942911976;6469.870602587922;6491.610503369813;6510.674466276667;6443.613383197023;7043.542169758949;7050.823729406703;7219.711211551479;7224.711011559479;5852.619579727304;6100.664463454464;6519.348065193442;6555.278919318871;6572.934270657232;3808.9525380520577;3842.4620553122586;3843.404272337792;3844.231153769257;3856.2287542491613;6802.319768023158;6851.760188393382;7286.453515986323;7559.433042521833;7603.65783539742;7490.250974902466;7490.925090749023;7541.208173141851;7541.886871696929;7552.320291173821;7585.2035536267895;7593.202713715202;7596.278353556403;7602.961985190039;7605.809854753676;6155.738073694972;7151.284871513015;7282.12614486265;7306.7077316906725;7329.74345897891;6899.965500172467;7147.213806481179;7166.175889772743;7176.102987126609;7179.1026121734785;7465.813354666177;7533.1336896257635;7535.585542795199;7539.434542409451;7555.848883022419;4579.290210017452;4653.906921861611;4664.253719404879;4667.299905014139;4673.392458980311;7227.530210536509;7231.566106033655;7239.095113110861;7253.3834624055435;7259.491835571459;6691.899621505584;6945.409640180439;6950.513464057467;6987.231404545394;7003.649817509002;6892.862142757217;6918.169819621678;6939.132608423947;7004.929950700428;7022.1924478685605;6825.419839313516;6837.726490940506;6844.726210951506;6857.142857142857;6871.175458944958;6973.4072603829245;6988.301169882971;6991.510594258353;6996.510244282851;7002.054722612382;5607.934492446422;5741.052726300114;6500.577462464925;6601.801945941629;6727.360900714424 12:03:11 INFO - PROCESS | 2176 | |5;yui.html;770.1720650300928;781.6052893288888;787.3976408047848;793.920607939206;818.9754307370778;15636.983596066248;15737.60655983601;15841.28714207862;15843.445479408223;15867.127307998055;14762.778558321634;14971.77542336863;14985.625359366022;15001.174935378549;15012.249387530634;838.0362583029504;843.3716880923721;978.4178413843752;999.8800143982733;1021.7139201023688;1001.0790073132699;1001.3841487485217;1002.8896821349682;1007.0231875081159;1010.0202803280806;1058.8782290036668;1062.4900047976976;1065.4725910674226;1066.386827574144;1070.9825665617655;857.4298091768966;1037.8131936251473;1049.1868801678684;1059.1262208677795;1063.3035361838008;800.2397722163968;800.6917336825306;800.9439339246255;802.06959926485;804.4288555125868;15648.061116333056;15702.822288328422;15765.448209312619;15767.763483547757;15772.71295662134;13492.662683432894;13501.32493375337;13516.594502164951;13775.035747497679;13968.580942571638;10364.067233948905;10448.843267350996;10547.314424562379;10752.247342686014;10877.07544858688;3604.153024039375;3647.2340808430263;3651.361011822947;3683.3554128027754;3811.942820857689;86511;89745.55127224387;91343.08656913412;91514;91634.08365916323;9804.264680148875;9831.31180817336;9960.352577082467;10097.526106104051;10521.84217236742;24246.636300455506;24273.635895461583;24279.63580546293;24334.756652433603;24367.390815229406;7633.618319084024;7767.72812951544;7839.6472158752995;8081.353491720766;8194.754157375288;4129.834806607762;4136.234796562646;4177.811998460076;4260.211860805761;4480.439945006874;3540.8937731868086;3789.4505296732373;3792.7534710243744;3794.2790869734663;3795.9430608540893;692.3007762160255;705.3299365602595;707.1764023268381;715.7995761186876;721.2787212787213;582.1820342418908;614.2983934501406;625.7027911741886;630.338144947803;631.3434028610194;8307.252347288773;8497.022842373206;8536.786580335418;8544.957275213585;8617.396782225183;582.9300483941954;610.215872603711;636.2746469025315;641.1920979565781;641.5701480008405;3422.0418282880337;3960.20795840833;4050.5139383274195;4057.89855253621;4151.896202594899;85157.57421212854;85314.57342713246;86305.56847215723;86306;86561;81035.18964810277;81804.18195818085;82597.58701206456;83220.16779832245;84623;56277.71861140668;76066;76702.84945725818;76834;77448.22551774523;6822.420094292041;7998.720204767209;8006.359491240803;8188.426810123234;8250.298724608476;53142.46857531375;53390.73304633452;53491.73254133704;53818.46181538134;55800;73318;75264.49471010659;75298.8705169412;75535.24464755283;76725.61637192001;9059.547022648972;10418.062374386342;10480.266381353536;10576.101031412416;10689.51897164614;10193.84709229377;11436.485358158736;11490.195686301879;11530.192886497865;11993.980511656608;10067.244956628429;10616;10629.627963021258;10638.340335086217;10858.402787846744;10331.276810623183;10407.635732749317;10514.842277365999;10557.894421055691;10709.036186743231;10565.471726413802;10568.207384446043;10615.31000484966;10618.510606587388;10717.732056698645;9129.49787761653;9140.954295228481;9260.953695231481;9414.293927955294;9418.10527999839;8992.46045237288;9088.454692718193;9156.58795354224;9250.121238482334;9300.348975571645 12:03:11 INFO - PROCESS | 2176 | __end_tp_report 12:03:11 INFO - PROCESS | 2176 | __start_cc_report 12:03:11 INFO - PROCESS | 2176 | _x_x_mozilla_cycle_collect,1093 12:03:11 INFO - PROCESS | 2176 | __end_cc_report 12:03:11 INFO - PROCESS | 2176 | __startTimestamp1458414191123__endTimestamp 12:03:11 INFO - PROCESS | 2176 | 12:03:11 INFO - PROCESS | 2176 | ------- Summary: start ------- 12:03:11 INFO - PROCESS | 2176 | Number of tests: 6 12:03:11 INFO - PROCESS | 2176 | 12:03:11 INFO - PROCESS | 2176 | [#0] dojo.html Cycles:165 Average:5732.53 Median:5967.46 stddev:627.54 (10.5%) stddev-sans-first:602.40 12:03:11 INFO - PROCESS | 2176 | Values: 3408.4 3450.3 3471.9 3484.5 3521.2 5750.8 5756.9 5762.3 5765.3 5787.3 5758.5 5774.8 5791.0 5796.1 5802.0 4474.4 5112.6 5145.2 5157.1 5188.5 5255.9 5263.8 5266.2 5266.3 5271.0 5197.8 5238.9 5258.6 5273.9 5284.8 4657.3 5229.8 5262.6 5265.5 5305.0 5061.0 5191.4 5205.1 5213.5 5215.2 5631.0 5646.8 5676.7 5694.5 5722.0 6118.9 6132.7 6226.2 6239.5 6250.5 6179.8 6207.8 6211.6 6222.9 6236.4 5897.1 5906.5 5908.8 5915.2 5937.1 6184.5 6221.6 6287.4 6313.3 6313.7 6124.8 6183.4 6192.6 6196.3 6200.0 6200.3 6206.9 6208.2 6210.8 6231.2 6042.7 6138.2 6186.0 6224.3 6227.9 6184.8 6203.3 6216.2 6222.4 6227.8 4928.2 4929.5 4937.3 4945.5 4956.2 4340.6 4372.8 4482.6 4486.8 4531.2 5730.9 5731.4 5743.9 5745.0 5760.4 6192.0 6217.8 6221.6 6230.7 6257.4 5543.3 5656.9 5739.8 5754.7 5781.3 5348.6 5395.2 5396.1 5408.2 5420.2 6197.7 6370.3 6380.9 6382.6 6405.2 6119.7 6141.2 6157.4 6176.7 6179.8 6277.7 6281.7 6293.8 6300.1 6307.2 6094.4 6161.0 6169.3 6176.8 6179.4 6146.9 6150.0 6155.5 6179.5 6228.2 5945.0 5989.2 6014.5 6014.7 6035.0 5870.4 6018.5 6021.5 6025.4 6025.4 4913.6 5703.1 5848.6 5908.7 5967.5 6062.4 6101.6 6104.7 6116.9 6120.5 5858.9 5975.3 5976.5 5995.1 6002.5 12:03:11 INFO - PROCESS | 2176 | 12:03:11 INFO - PROCESS | 2176 | [#1] ext.html Cycles:180 Average:62329.71 Median:375274.00 stddev:128615.63 (34.3%) stddev-sans-first:128892.79 12:03:11 INFO - PROCESS | 2176 | Values: 551.3 561.6 598.7 615.4 661.5 32065.2 32486.5 32579.2 41131.0 41734.0 44354.9 44406.8 44527.0 44706.6 44755.9 9571.0 9810.6 9818.4 9820.3 9825.9 9537.2 9665.0 9669.0 9683.3 9723.9 9658.6 9706.3 9772.6 9796.8 9824.1 9751.3 9795.5 9800.0 9809.7 9817.5 9741.8 9866.3 9872.7 9877.1 9886.9 43318.8 43753.9 43758.6 43764.0 43896.6 3267.0 3321.4 3410.2 3435.7 3921.4 24479.9 28516.9 28997.3 29008.3 29872.6 2839.5 2855.6 2911.2 2954.1 2961.3 503310.5 504742.0 505922.0 506712.0 507007.0 47878.3 49013.0 63633.7 64957.7 65293.0 48180.5 48192.0 48478.5 48558.0 48568.5 17246.4 17430.2 17442.5 17452.7 17505.6 13982.7 14062.5 14065.5 14077.4 14082.8 15686.8 15785.4 15790.5 15793.7 15813.2 6604.5 6738.7 6785.8 6804.2 6829.9 922.2 1018.9 1042.2 1116.6 1165.3 27300.0 30000.7 30323.4 30648.6 30913.2 1095.6 1146.1 1148.4 1150.9 1154.2 15178.3 15559.6 15584.2 15809.8 15908.0 549563.0 551634.0 554570.0 554677.0 554924.0 63366.4 63692.0 63791.7 63871.0 63888.0 1407.6 1509.4 1549.8 1560.5 1569.9 29264.1 29829.0 30268.2 30819.7 31422.2 50655.0 50759.5 51215.5 51241.7 51385.2 372198.0 372993.0 373460.0 375240.0 375308.0 30065.4 34549.8 34751.7 35021.6 35392.3 42877.4 43714.6 44280.0 44299.6 44744.8 35151.1 35911.9 38659.6 38673.6 38727.6 36302.0 36458.0 36669.6 36979.6 37174.4 36261.3 36293.8 36633.1 37128.6 37616.0 31937.4 34679.0 35178.1 35942.5 36149.6 21670.7 25231.6 25405.4 25581.4 25906.5 12:03:11 INFO - PROCESS | 2176 | 12:03:11 INFO - PROCESS | 2176 | [#2] jquery.html Cycles:180 Average:34525.76 Median:21106.79 stddev:102806.64 (487.1%) stddev-sans-first:103063.08 12:03:11 INFO - PROCESS | 2176 | Values: 387.9 388.9 392.6 393.6 397.1 17558.9 19700.8 20973.5 20979.4 21037.7 12234.9 12646.2 21479.9 22103.6 22206.2 4987.3 5460.4 5617.5 5655.8 5667.0 4237.0 4282.1 4429.5 4485.2 6935.6 6562.8 6722.8 6740.8 6742.8 6844.6 5805.1 6061.9 6065.0 6655.2 6712.2 4031.1 5623.5 5836.1 5845.3 5866.5 13808.6 13812.7 13875.9 14012.2 14016.9 2085.7 2160.6 2204.4 2505.3 2899.3 8851.5 9552.7 10301.4 12658.9 15490.5 1821.0 1825.1 1838.4 1887.0 1906.6 76533.0 89345.6 95169.0 102323.0 107849.4 11483.8 11881.9 11945.4 11980.7 12009.6 14726.6 14772.9 14775.5 14803.6 14815.3 9189.5 9300.9 9327.5 9393.5 9413.7 9507.3 9541.1 9561.8 9656.2 9680.5 4658.4 4730.1 4734.0 4753.4 4792.3 1950.4 1981.1 1984.3 1989.2 2015.5 907.7 1005.0 1009.4 1060.7 1080.2 20736.7 21045.4 21090.7 21122.9 21146.5 979.9 981.2 994.7 1022.1 1028.9 11062.0 11560.5 11562.4 11592.5 11621.9 600198.0 618669.0 628299.0 630104.0 631142.0 88369.6 95854.0 121206.0 123495.0 123609.0 1047.5 1067.2 1098.3 1128.3 1129.3 18253.5 18337.4 19125.3 19186.2 19187.3 52526.9 53053.5 54445.7 54510.7 61982.0 78924.0 80203.8 80437.0 82160.0 82353.6 7773.3 8236.9 8306.3 8366.8 8577.9 7707.9 10315.1 12536.9 13012.7 13850.7 11661.8 11744.3 11940.6 11974.7 12027.5 11427.8 11637.1 11652.0 11766.3 12026.7 11790.8 11799.4 11970.0 12113.6 12221.1 8305.9 8621.4 8771.8 11859.5 11881.4 10956.5 11593.3 11838.3 11864.6 11947.6 12:03:11 INFO - PROCESS | 2176 | 12:03:11 INFO - PROCESS | 2176 | [#3] mootools.html Cycles:180 Average:6316.96 Median:5162.35 stddev:3368.29 (65.2%) stddev-sans-first:3357.21 12:03:11 INFO - PROCESS | 2176 | Values: 1370.1 1625.6 1643.5 1973.3 2078.1 8492.4 9132.0 9298.5 9304.6 9323.4 8915.0 9126.4 9146.0 9159.2 9164.5 2317.9 2541.1 2573.3 2602.4 2609.2 2624.9 2628.8 2632.8 2632.8 2635.0 2494.5 2589.2 2594.3 2595.1 2598.1 2308.7 2526.1 2569.6 2578.0 2594.4 2550.5 2584.5 2623.9 2627.0 2629.8 9089.2 9153.0 9160.1 9167.0 9202.9 5676.2 5841.8 5843.9 5849.2 5854.5 3666.5 3770.2 3794.1 3799.7 3842.4 894.6 1003.3 1062.4 1085.4 1114.1 12487.3 12537.5 12552.8 12555.2 12564.6 4424.5 4708.8 5144.0 5149.4 5175.4 10266.7 10781.3 10783.2 10784.9 10801.4 5773.3 5774.8 5780.0 5780.9 5785.2 4265.8 4632.4 4794.5 5081.6 5088.5 4145.2 4198.7 4212.1 4249.4 4254.4 1343.4 1367.7 1375.5 1384.2 1385.8 1425.0 1453.7 1455.1 1467.9 1478.3 8479.3 8489.2 8545.4 8556.4 8558.7 531.3 542.8 545.6 550.2 557.1 6451.8 6469.6 6479.5 6518.3 6553.0 10959.8 11431.3 11432.5 11452.0 11466.8 11039.9 11131.3 11217.0 11239.8 11305.9 7339.3 8786.6 8805.6 8885.1 8888.8 8153.3 8334.5 8364.7 8389.4 8404.8 8484.7 9923.6 10058.4 10176.7 10233.8 10350.0 10411.8 10515.7 10546.9 10571.7 6468.9 7212.9 7398.1 7739.8 7934.8 8585.8 8586.2 8638.0 8642.8 8648.1 7449.7 7587.7 7615.7 7676.2 7683.1 7446.2 7473.5 7501.5 7614.5 7635.4 7929.0 8080.0 8095.7 8103.1 8106.0 7255.7 7265.8 7297.4 7317.0 7326.1 7384.1 7394.7 7414.8 7427.9 7430.9 12:03:11 INFO - PROCESS | 2176 | 12:03:11 INFO - PROCESS | 2176 | [#4] prototype.html Cycles:180 Average:5710.31 Median:6505.63 stddev:1811.25 (27.8%) stddev-sans-first:1770.85 12:03:11 INFO - PROCESS | 2176 | Values: 336.5 343.2 348.9 349.4 355.4 6570.5 6588.6 6599.5 6606.9 6641.4 6535.5 6550.5 6554.1 6564.9 6571.3 4605.6 4657.2 4672.9 4786.6 4871.7 4769.1 4774.2 4796.4 4804.8 4810.4 4246.8 4561.5 4773.7 4782.5 4798.2 4536.5 4719.2 4724.8 4727.0 4775.4 4011.6 4089.1 4095.1 4114.2 4117.7 6160.6 6277.2 6282.4 6291.6 6293.2 5694.5 5696.5 5699.1 5718.5 5732.1 6973.8 6978.7 6979.9 6982.7 6987.0 4522.9 4679.1 4716.6 4721.5 4729.2 7275.2 7305.1 7342.3 7343.9 7346.9 4048.2 4741.9 4767.0 4773.7 4776.1 4838.7 4839.0 4849.3 4857.9 4858.5 5651.2 5656.6 5657.5 5673.5 5677.8 6671.0 6960.8 7029.3 7040.3 7083.0 1456.4 1573.4 1639.0 1640.1 1640.4 1048.4 1050.4 1062.2 1065.6 1078.9 6271.8 6458.8 6469.9 6491.6 6510.7 6443.6 7043.5 7050.8 7219.7 7224.7 5852.6 6100.7 6519.3 6555.3 6572.9 3809.0 3842.5 3843.4 3844.2 3856.2 6802.3 6851.8 7286.5 7559.4 7603.7 7490.3 7490.9 7541.2 7541.9 7552.3 7585.2 7593.2 7596.3 7603.0 7605.8 6155.7 7151.3 7282.1 7306.7 7329.7 6900.0 7147.2 7166.2 7176.1 7179.1 7465.8 7533.1 7535.6 7539.4 7555.8 4579.3 4653.9 4664.3 4667.3 4673.4 7227.5 7231.6 7239.1 7253.4 7259.5 6691.9 6945.4 6950.5 6987.2 7003.6 6892.9 6918.2 6939.1 7004.9 7022.2 6825.4 6837.7 6844.7 6857.1 6871.2 6973.4 6988.3 6991.5 6996.5 7002.1 5607.9 5741.1 6500.6 6601.8 6727.4 12:03:11 INFO - PROCESS | 2176 | 12:03:11 INFO - PROCESS | 2176 | [#5] yui.html Cycles:180 Average:19019.55 Median:28811.45 stddev:26926.44 (93.5%) stddev-sans-first:26967.11 12:03:11 INFO - PROCESS | 2176 | Values: 770.2 781.6 787.4 793.9 819.0 15637.0 15737.6 15841.3 15843.4 15867.1 14762.8 14971.8 14985.6 15001.2 15012.2 838.0 843.4 978.4 999.9 1021.7 1001.1 1001.4 1002.9 1007.0 1010.0 1058.9 1062.5 1065.5 1066.4 1071.0 857.4 1037.8 1049.2 1059.1 1063.3 800.2 800.7 800.9 802.1 804.4 15648.1 15702.8 15765.4 15767.8 15772.7 13492.7 13501.3 13516.6 13775.0 13968.6 10364.1 10448.8 10547.3 10752.2 10877.1 3604.2 3647.2 3651.4 3683.4 3811.9 86511.0 89745.6 91343.1 91514.0 91634.1 9804.3 9831.3 9960.4 10097.5 10521.8 24246.6 24273.6 24279.6 24334.8 24367.4 7633.6 7767.7 7839.6 8081.4 8194.8 4129.8 4136.2 4177.8 4260.2 4480.4 3540.9 3789.5 3792.8 3794.3 3795.9 692.3 705.3 707.2 715.8 721.3 582.2 614.3 625.7 630.3 631.3 8307.3 8497.0 8536.8 8545.0 8617.4 582.9 610.2 636.3 641.2 641.6 3422.0 3960.2 4050.5 4057.9 4151.9 85157.6 85314.6 86305.6 86306.0 86561.0 81035.2 81804.2 82597.6 83220.2 84623.0 56277.7 76066.0 76702.8 76834.0 77448.2 6822.4 7998.7 8006.4 8188.4 8250.3 53142.5 53390.7 53491.7 53818.5 55800.0 73318.0 75264.5 75298.9 75535.2 76725.6 9059.5 10418.1 10480.3 10576.1 10689.5 10193.8 11436.5 11490.2 11530.2 11994.0 10067.2 10616.0 10629.6 10638.3 10858.4 10331.3 10407.6 10514.8 10557.9 10709.0 10565.5 10568.2 10615.3 10618.5 10717.7 9129.5 9141.0 9261.0 9414.3 9418.1 8992.5 9088.5 9156.6 9250.1 9300.3 12:03:11 INFO - PROCESS | 2176 | -------- Summary: end -------- 12:03:11 INFO - PROCESS | 2176 | 12:03:11 INFO - TEST-INFO | 2176: exit 0 12:03:11 INFO - TEST-OK | dromaeo_css | took 1112643ms 12:03:11 INFO - TEST-START | kraken 12:03:11 INFO - operating with platform_type : mac_ 12:03:11 INFO - Initialising browser for kraken test... 12:03:11 INFO - TEST-INFO | started process 2289 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpzOYbX8/profile http://localhost:50523/getInfo.html) 12:03:13 INFO - PROCESS | 2289 | __metrics Screen width/height:1600/1200 12:03:13 INFO - PROCESS | 2289 | colorDepth:24 12:03:13 INFO - PROCESS | 2289 | Browser inner width/height: 1024/689 12:03:13 INFO - PROCESS | 2289 | __metrics 12:03:13 INFO - PROCESS | 2289 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:03:13 INFO - PROCESS | 2289 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:03:14 INFO - TEST-INFO | 2289: exit 0 12:03:14 INFO - Browser initialized. 12:03:14 INFO - Running cycle 1/1 for kraken test... 12:03:14 INFO - TEST-INFO | started process 2292 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpzOYbX8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:26 INFO - PROCESS | 2292 | RSS: Main: 210366464 12:03:26 INFO - PROCESS | 2292 | 12:03:28 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50523/tests/kraken/driver.html?testName=audio-beat-detection) 12:03:29 INFO - PROCESS | 2292 | RSS: Main: 265936896 12:03:29 INFO - PROCESS | 2292 | 12:03:32 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50523/tests/kraken/driver.html?testName=audio-dft) 12:03:32 INFO - PROCESS | 2292 | RSS: Main: 274890752 12:03:32 INFO - PROCESS | 2292 | 12:03:35 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50523/tests/kraken/driver.html?testName=audio-fft) 12:03:36 INFO - PROCESS | 2292 | RSS: Main: 264957952 12:03:36 INFO - PROCESS | 2292 | 12:03:38 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50523/tests/kraken/driver.html?testName=audio-oscillator) 12:03:39 INFO - PROCESS | 2292 | RSS: Main: 266588160 12:03:39 INFO - PROCESS | 2292 | 12:03:41 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50523/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:03:41 INFO - PROCESS | 2292 | RSS: Main: 266428416 12:03:41 INFO - PROCESS | 2292 | 12:03:44 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50523/tests/kraken/driver.html?testName=imaging-darkroom) 12:03:45 INFO - PROCESS | 2292 | RSS: Main: 266928128 12:03:45 INFO - PROCESS | 2292 | 12:03:48 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50523/tests/kraken/driver.html?testName=imaging-desaturate) 12:03:48 INFO - PROCESS | 2292 | RSS: Main: 267116544 12:03:48 INFO - PROCESS | 2292 | 12:03:51 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50523/tests/kraken/driver.html?testName=json-parse-financial) 12:03:51 INFO - PROCESS | 2292 | RSS: Main: 268296192 12:03:51 INFO - PROCESS | 2292 | 12:03:53 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50523/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:03:53 INFO - PROCESS | 2292 | RSS: Main: 302399488 12:03:53 INFO - PROCESS | 2292 | 12:03:55 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:03:56 INFO - PROCESS | 2292 | RSS: Main: 303153152 12:03:56 INFO - PROCESS | 2292 | 12:03:58 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:03:59 INFO - PROCESS | 2292 | RSS: Main: 307957760 12:03:59 INFO - PROCESS | 2292 | 12:04:01 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:04:02 INFO - PROCESS | 2292 | RSS: Main: 310272000 12:04:02 INFO - PROCESS | 2292 | 12:04:04 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:05 INFO - PROCESS | 2292 | RSS: Main: 310145024 12:04:05 INFO - PROCESS | 2292 | 12:04:06 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50523/tests/kraken/driver.html?testName=ai-astar) 12:04:07 INFO - PROCESS | 2292 | RSS: Main: 369639424 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | __start_tp_report 12:04:07 INFO - PROCESS | 2292 | _x_x_mozilla_page_load 12:04:07 INFO - PROCESS | 2292 | _x_x_mozilla_page_load_details 12:04:07 INFO - PROCESS | 2292 | |i|pagename|runs| 12:04:07 INFO - PROCESS | 2292 | |0;ai-astar;112;110;111;111;160;160;119;112;109;111 12:04:07 INFO - PROCESS | 2292 | |1;audio-beat-detection;154;119;142;153;116;139;116;151;177;107 12:04:07 INFO - PROCESS | 2292 | |2;audio-dft;183;182;184;187;185;217;185;187;183;186 12:04:07 INFO - PROCESS | 2292 | |3;audio-fft;74;72;77;118;54;51;57;66;142;81 12:04:07 INFO - PROCESS | 2292 | |4;audio-oscillator;91;132;172;105;77;88;117;75;77;123 12:04:07 INFO - PROCESS | 2292 | |5;imaging-gaussian-blur;91;85;88;85;87;84;89;84;87;84 12:04:07 INFO - PROCESS | 2292 | |6;imaging-darkroom;92;92;92;94;92;93;92;94;93;92 12:04:07 INFO - PROCESS | 2292 | |7;imaging-desaturate;87;87;85;85;87;85;84;84;85;84 12:04:07 INFO - PROCESS | 2292 | |8;json-parse-financial;56;57;57;56;55;56;57;66;49;50 12:04:07 INFO - PROCESS | 2292 | |9;json-stringify-tinderbox;62;62;76;73;68;66;66;67;67;71 12:04:07 INFO - PROCESS | 2292 | |10;stanford-crypto-aes;79;78;81;80;81;79;78;79;79;83 12:04:07 INFO - PROCESS | 2292 | |11;stanford-crypto-ccm;118;127;116;131;121;130;119;113;121;116 12:04:07 INFO - PROCESS | 2292 | |12;stanford-crypto-pbkdf2;128;120;132;133;132;132;131;131;125;131 12:04:07 INFO - PROCESS | 2292 | |13;stanford-crypto-sha256-iterative;68;64;67;65;66;66;66;65;66;65 12:04:07 INFO - PROCESS | 2292 | __end_tp_report 12:04:07 INFO - PROCESS | 2292 | __start_cc_report 12:04:07 INFO - PROCESS | 2292 | _x_x_mozilla_cycle_collect,1261 12:04:07 INFO - PROCESS | 2292 | __end_cc_report 12:04:07 INFO - PROCESS | 2292 | __startTimestamp1458414247121__endTimestamp 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | ------- Summary: start ------- 12:04:07 INFO - PROCESS | 2292 | Number of tests: 14 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#0] ai-astar Cycles:10 Average:121.50 Median:112.00 stddev:20.47 (18.3%) stddev-sans-first:21.42 12:04:07 INFO - PROCESS | 2292 | Values: 112.0 110.0 111.0 111.0 160.0 160.0 119.0 112.0 109.0 111.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:146.50 stddev:22.30 (15.2%) stddev-sans-first:22.83 12:04:07 INFO - PROCESS | 2292 | Values: 154.0 119.0 142.0 153.0 116.0 139.0 116.0 151.0 177.0 107.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#2] audio-dft Cycles:10 Average:187.90 Median:185.50 stddev:10.37 (5.6%) stddev-sans-first:10.84 12:04:07 INFO - PROCESS | 2292 | Values: 183.0 182.0 184.0 187.0 185.0 217.0 185.0 187.0 183.0 186.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#3] audio-fft Cycles:10 Average:79.20 Median:69.00 stddev:29.12 (42.2%) stddev-sans-first:30.83 12:04:07 INFO - PROCESS | 2292 | Values: 74.0 72.0 77.0 118.0 54.0 51.0 57.0 66.0 142.0 81.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#4] audio-oscillator Cycles:10 Average:105.70 Median:76.00 stddev:30.97 (40.8%) stddev-sans-first:32.39 12:04:07 INFO - PROCESS | 2292 | Values: 91.0 132.0 172.0 105.0 77.0 88.0 117.0 75.0 77.0 123.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.00 stddev:2.41 (2.8%) stddev-sans-first:1.90 12:04:07 INFO - PROCESS | 2292 | Values: 91.0 85.0 88.0 85.0 87.0 84.0 89.0 84.0 87.0 84.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:92.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 12:04:07 INFO - PROCESS | 2292 | Values: 92.0 92.0 92.0 94.0 92.0 93.0 92.0 94.0 93.0 92.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:1.25 (1.5%) stddev-sans-first:1.17 12:04:07 INFO - PROCESS | 2292 | Values: 87.0 87.0 85.0 85.0 87.0 85.0 84.0 84.0 85.0 84.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.50 stddev:4.58 (8.1%) stddev-sans-first:4.86 12:04:07 INFO - PROCESS | 2292 | Values: 56.0 57.0 57.0 56.0 55.0 56.0 57.0 66.0 49.0 50.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:4.47 (6.6%) stddev-sans-first:4.22 12:04:07 INFO - PROCESS | 2292 | Values: 62.0 62.0 76.0 73.0 68.0 66.0 66.0 67.0 67.0 71.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:1.57 (2.0%) stddev-sans-first:1.64 12:04:07 INFO - PROCESS | 2292 | Values: 79.0 78.0 81.0 80.0 81.0 79.0 78.0 79.0 79.0 83.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:121.00 stddev:6.18 (5.1%) stddev-sans-first:6.44 12:04:07 INFO - PROCESS | 2292 | Values: 118.0 127.0 116.0 131.0 121.0 130.0 119.0 113.0 121.0 116.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:129.50 Median:131.50 stddev:4.09 (3.1%) stddev-sans-first:4.30 12:04:07 INFO - PROCESS | 2292 | Values: 128.0 120.0 132.0 133.0 132.0 132.0 131.0 131.0 125.0 131.0 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - PROCESS | 2292 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:0.88 12:04:07 INFO - PROCESS | 2292 | Values: 68.0 64.0 67.0 65.0 66.0 66.0 66.0 65.0 66.0 65.0 12:04:07 INFO - PROCESS | 2292 | -------- Summary: end -------- 12:04:07 INFO - PROCESS | 2292 | 12:04:07 INFO - TEST-INFO | 2292: exit 0 12:04:07 INFO - TEST-OK | kraken | took 56294ms 12:04:07 INFO - SUITE-END | took 1168s 12:04:08 INFO - Completed test suite (00:19:29) 12:04:08 INFO - javascript benchmark 12:04:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3408.3864904317225, 3450.2581944881863, 3471.947920781188, 3484.45990871415, 3521.1549228185245, 5750.769969201232, 5756.856078598037, 5762.308522977238, 5765.3369862465825, 5787.334456537495, 5758.452946970042, 5774.82675519735, 5790.971045144779, 5796.07262837946, 5801.970990145043, 4474.440694913136, 5112.590992720592, 5145.151050076733, 5157.071727089123, 5188.4811518848, 5255.86860328491, 5263.76313065911, 5266.210068489719, 5266.289050978126, 5271.0, 5197.818076367328, 5238.869028274305, 5258.605604579653, 5273.920891186635, 5284.788608455658, 4657.301404789308, 5229.764660590283, 5262.605304602132, 5265.473452654742, 5304.973475132619, 5061.038402703512, 5191.428942816287, 5205.063088644042, 5213.452587478336, 5215.217717342391, 5630.971845140789, 5646.830595082154, 5676.744546495418, 5694.487496125327, 5722.027255366597, 6118.862843290023, 6132.722655450943, 6226.190595222637, 6239.532035097386, 6250.499960003234, 6179.81460556184, 6207.81376558704, 6211.627302361828, 6222.937770622327, 6236.376362363772, 5897.144913987448, 5906.468417842415, 5908.763649454017, 5915.171875937286, 5937.079752638348, 6184.536159788034, 6221.626702397871, 6287.371262873676, 6313.305536390993, 6313.715882785285, 6124.816255512342, 6183.350748171467, 6192.628442293477, 6196.287426945869, 6200.0, 6200.255969283715, 6206.937930620727, 6208.192934918432, 6210.813675589739, 6231.22109736283, 6042.728077236535, 6138.199401565478, 6186.0, 6224.284207316126, 6227.9377206227355, 6184.752609895644, 6203.348648391944, 6216.160818289473, 6222.439980401786, 6227.782027629011, 4928.186849169847, 4929.531694489017, 4937.259411088366, 4945.4807245238735, 4956.231784073474, 4340.631046361032, 4372.759498227628, 4482.641388688897, 4486.842960496367, 4531.161735079021, 5730.914036289459, 5731.398203188689, 5743.8564035899435, 5744.971275143681, 5760.36635970043, 6192.0, 6217.813465596039, 6221.62670239778, 6230.719617617218, 6257.43683068526, 5543.307086614173, 5656.943430565724, 5739.7704091836695, 5754.712264386764, 5781.277340332458, 5348.598855085884, 5395.190721391744, 5396.136618141157, 5408.242846001563, 5420.214068959979, 6197.659128747782, 6370.267419246846, 6380.904286435707, 6382.553221274559, 6405.231372235362, 6119.694015299307, 6141.2098563120835, 6157.353477884758, 6176.722047507783, 6179.752809887555, 6277.654728989949, 6281.748730050746, 6293.779717709858, 6300.086487459384, 6307.180066591313, 6094.390560944047, 6161.0, 6169.321374648875, 6176.81469555914, 6179.412955769195, 6146.938530614637, 6150.015997440567, 6155.538334624832, 6179.5056395489155, 6228.190335256388, 5945.019071853096, 5989.221401217814, 6014.458698716961, 6014.699265036643, 6034.969825150846, 5870.442307980735, 6018.51851851842, 6021.458068773832, 6025.367336429612, 6025.397460253939, 4913.582345500672, 5703.116017017369, 5848.590598658053, 5908.7045647718305, 5967.4629283362965, 6062.363451837494, 6101.590487878725, 6104.661280298322, 6116.853194528166, 6120.510359171167, 5858.9121163181735, 5975.282966043928, 5976.462118409364, 5995.070764031582, 6002.459778619946], "unit": "score", "name": "dojo.html", "value": 5693.445445277994}, {"lowerIsBetter": false, "replicates": [551.341147328942, 561.5703986450364, 598.6976576828704, 615.3907631444871, 661.5237029338875, 32065.19837004076, 32486.512702309454, 32579.185520362003, 41130.97172570687, 41734.0, 44354.89112772182, 44406.7779661102, 44527.0, 44706.552934470645, 44755.88110297244, 9570.952145239264, 9810.607575696999, 9818.410895346266, 9820.263480238975, 9825.852612210823, 9537.237021038334, 9665.0, 9669.0, 9683.322167448281, 9723.90276097237, 9658.613655453773, 9706.272029597772, 9772.609095636202, 9796.755081122994, 9824.115829575338, 9751.26865485088, 9795.461249631267, 9799.951000245024, 9809.656662016867, 9817.50912454378, 9741.756456088584, 9866.309358344919, 9872.703818885446, 9877.111060004563, 9886.90113098867, 43318.783406082766, 43753.90615234613, 43758.56241437577, 43764.0, 43896.56103438957, 3267.0, 3321.3523362944234, 3410.215650400397, 3435.7423193260606, 3921.392184211452, 24479.87760061206, 28516.857415712788, 28997.275068123465, 29008.27479313013, 29872.55191172134, 2839.488891999439, 2855.571664250379, 2911.228524441025, 2954.0547024952025, 2961.304093538017, 503310.4834475841, 504742.0, 505922.0, 506712.0, 507007.0, 47878.28182577264, 49013.019739605006, 63633.68183159055, 64957.675211624584, 65293.0, 48180.5181948183, 48192.0, 48478.5152148474, 48558.0, 48568.51431485711, 17246.396376126777, 17430.215640296217, 17442.47672569825, 17452.738208926876, 17505.64988700219, 13982.720345593234, 14062.507812226522, 14065.507707230197, 14077.436902523785, 14082.788758168635, 15686.76469852953, 15785.447509337118, 15790.526284211492, 15793.68412631741, 15813.209339532978, 6604.537682362285, 6738.663066846638, 6785.830354241183, 6804.21751498584, 6829.863402731918, 922.1850524623042, 1018.8675472188717, 1042.1813934684026, 1116.6370929447962, 1165.2949965270889, 27300.0, 30000.699993000228, 30323.393532129674, 30648.60373829016, 30913.227169320948, 1095.5562996986234, 1146.0659562456572, 1148.4487446025955, 1150.9366984815915, 1154.2439701995038, 15178.31697573612, 15559.611009724847, 15584.220788960507, 15809.841901581067, 15908.0, 549563.0, 551634.0, 554570.0, 554677.0, 554924.0, 63366.41583960438, 63692.04461933075, 63791.68104159449, 63871.0, 63888.0, 1407.619942615488, 1509.4037855047195, 1549.7752825840416, 1560.5006397952773, 1569.8744100471936, 29264.122076337742, 29829.0, 30268.24329391695, 30819.69180308258, 31422.214444639067, 50655.0, 50759.49240507548, 51215.48784512256, 51241.7437912808, 51385.229221562455, 372198.0, 372993.0, 373460.0, 375240.0, 375308.0, 30065.3986920256, 34549.827250863586, 34751.65248347484, 35021.64978350286, 35392.29215415729, 42877.3568396468, 43714.56285437105, 44280.0, 44299.557004429545, 44744.77627611841, 35151.12122196965, 35911.92264232077, 38659.6134038656, 38673.613263867, 38727.6127238724, 36302.0, 36458.0, 36669.63330366662, 36979.630203698696, 37174.44238336481, 36261.27477450489, 36293.81853090718, 36633.08417289589, 37128.62133244061, 37616.0, 31937.36125277435, 34679.0, 35178.120546985505, 35942.460863086555, 36149.63850361568, 21670.6749398756, 25231.621525677496, 25405.364865878502, 25581.3604659885, 25906.48187036211], "unit": "score", "name": "ext.html", "value": 19757.04696871629}, {"lowerIsBetter": false, "replicates": [387.94568760373545, 388.9124946886949, 392.5544506984572, 393.6378531750789, 397.14019148543406, 17558.946463212185, 19700.802991970093, 20973.47566310843, 20979.37061888142, 21037.68443473349, 12234.93882530586, 12646.241225526475, 21479.92600369983, 22103.557928841452, 22206.222782202625, 4987.3017777510995, 5460.372057213432, 5617.494425501704, 5655.830325090254, 5667.0, 4236.9576304237025, 4282.102050282039, 4429.512753597101, 4485.170243504962, 6935.618540980244, 6562.770303039395, 6722.764703235388, 6740.797776066725, 6742.797716068501, 6844.589324640538, 5805.071188609844, 6061.878762424771, 6064.96967515164, 6655.168103987002, 6712.160979877515, 4031.133306339151, 5623.522000629951, 5836.124581312794, 5845.269341332333, 5866.501347385477, 13808.585742427744, 13812.654683632889, 13875.889928805773, 14012.22932738699, 14016.929915350358, 2085.655866781979, 2160.5678864227216, 2204.360735386736, 2505.3235626380956, 2899.347646779479, 8851.46891186531, 9552.713418597454, 10301.433421161833, 12658.873411265862, 15490.50949050949, 1821.0257512230894, 1825.1148193126323, 1838.4117082533594, 1886.981130188708, 1906.5710215201607, 76533.0, 89345.55327223387, 95169.0, 102323.0, 107849.38225926696, 11483.827742583868, 11881.88118118825, 11945.402729863472, 11980.700482487833, 12009.579664711868, 14726.558203253919, 14772.926135369255, 14775.482858099915, 14803.62990925214, 14815.259237038104, 9189.494577798152, 9300.90699093014, 9327.486988215713, 9393.483358415353, 9413.717588472357, 9507.286953478517, 9541.093596108358, 9561.808763824823, 9656.22750179984, 9680.46757428334, 4658.3711198988385, 4730.053989202173, 4733.95266047342, 4753.429588449409, 4792.329073929653, 1950.414875537333, 1981.0986001369342, 1984.295575070858, 1989.19437627761, 2015.516276093727, 907.668700924158, 1005.0201053972319, 1009.4397609326747, 1060.7083052160563, 1080.2114456446682, 20736.688949665768, 21045.36863894055, 21090.683639745417, 21122.894385527972, 21146.471338216666, 979.8922118566952, 981.16600889245, 994.651871844863, 1022.0801278848946, 1028.93311934724, 11062.0, 11560.479778409992, 11562.421878906189, 11592.536298548132, 11621.941890290494, 600198.0, 618669.0, 628299.0, 630104.0, 631142.0, 88369.55815220883, 95854.0, 121206.0, 123495.0, 123609.0, 1047.5076713944434, 1067.2475904487317, 1098.2970898624887, 1128.3230061962756, 1129.3393364881472, 18253.45239642813, 18337.358192463198, 19125.330613428465, 19186.232550698373, 19187.32844350441, 52526.949461009805, 53053.46946530485, 54445.72777136089, 54510.727446362514, 61982.0, 78924.0, 80203.79694304707, 80436.98907527358, 82160.0, 82353.58823205845, 7773.261540153676, 8236.917630823615, 8306.293965013041, 8366.83266334682, 8577.914220857961, 7707.884381734167, 10315.071643551817, 12536.874631253571, 13012.739745205232, 13850.722985540031, 11661.825072624088, 11744.295342279149, 11940.582079627171, 11974.700632484257, 12027.45876435545, 11427.828582571101, 11637.06903447739, 11652.0, 11766.294022358687, 12026.699332516408, 11790.764184716087, 11799.410029498318, 11970.0, 12113.576024839089, 12221.083418743452, 8305.875411868949, 8621.396502244783, 8771.824563508822, 11859.466324015613, 11881.405929703307, 10956.526942524584, 11593.304401735923, 11838.328052208855, 11864.584739534075, 11947.641570752892], "unit": "score", "name": "jquery.html", "value": 9608.59420151838}, {"lowerIsBetter": false, "replicates": [1370.1231212024313, 1625.6179797747527, 1643.4740882917467, 1973.3389314579615, 2078.096028227721, 8492.405531612781, 9131.954340228298, 9298.488583127924, 9304.627814887413, 9323.440593564383, 8914.95542522288, 9126.361154719172, 9145.993940666522, 9159.175674189322, 9164.541772911345, 2317.9072837086496, 2541.136013755323, 2573.3052075939486, 2602.401447667028, 2609.191150743266, 2624.855632940197, 2628.789696824259, 2632.828866123705, 2632.8420294782372, 2635.0382110529613, 2494.463690306584, 2589.249117755858, 2594.3125071855975, 2595.0917178987393, 2598.142612937726, 2308.6998690170253, 2526.12848567244, 2569.5503286924713, 2578.046122934526, 2594.377349436141, 2550.477152183798, 2584.4572639745675, 2623.9475210495875, 2627.041129987541, 2629.815912886099, 9089.181973622406, 9152.954235228848, 9160.129787670227, 9166.991630920593, 9202.907970920272, 5676.176954341598, 5841.766329346821, 5843.883122337529, 5849.151872978395, 5854.5023672987845, 3666.4500324951205, 3770.2082562661876, 3794.051487128218, 3799.734018618698, 3842.4236364545263, 894.552723638181, 1003.2926786615419, 1062.3625824505311, 1085.3921803789904, 1114.1254115519278, 12487.31319777412, 12537.498500059986, 12552.81170782439, 12555.183913045714, 12564.560240391542, 4424.469063712375, 4708.8116475341285, 5143.996920600522, 5149.356330458692, 5175.353080864892, 10266.691999240034, 10781.299215550964, 10783.245172837984, 10784.946075269574, 10801.405922674328, 5773.3072031356505, 5774.826755197267, 5780.046292361797, 5780.942190578125, 5785.190073389729, 4265.829366825292, 4632.397788287569, 4794.496577859344, 5081.568066714297, 5088.516590923857, 4145.233131870614, 4198.748075115503, 4212.136512015029, 4249.426327445817, 4254.3831144483875, 1343.43575698207, 1367.7332920080687, 1375.5116933488669, 1384.2455861555477, 1385.819843420349, 1425.0452197028017, 1453.6729235922044, 1455.083297522554, 1467.875230605389, 1478.3051965576162, 8479.279261262738, 8489.235968762841, 8545.401821872534, 8556.40105192643, 8558.657653693906, 531.3013387395563, 542.7937383794211, 545.6398776807367, 550.2489102375229, 557.1086261980879, 6451.774187903401, 6469.611823290524, 6479.514036447191, 6518.250401203827, 6553.017047442826, 10959.780804383867, 11431.314121152758, 11432.542698292142, 11452.0, 11466.827997580043, 11039.944800275947, 11131.276467029616, 11216.990470857661, 11239.83140252897, 11305.886941130484, 7339.339459448675, 8786.560671966376, 8805.647774089093, 8885.111488851193, 8888.822223555493, 8153.306968907472, 8334.458260213067, 8364.66541338364, 8389.370797190357, 8404.789880253042, 8484.703035393732, 9923.55344009507, 10058.446785426579, 10176.694699159038, 10233.795324093626, 10350.0, 10411.791764164826, 10515.73710657209, 10546.894531054899, 10571.735706607089, 6468.870622587616, 7212.89180662301, 7398.11222653285, 7739.806504837424, 7934.801629959297, 8585.785355366166, 8586.184312490554, 8638.0, 8642.827143457222, 8648.091950345375, 7449.739259125905, 7587.734429294948, 7615.7334493292465, 7676.232376762279, 7683.0780306363595, 7446.180920098893, 7473.51422157558, 7501.474896757175, 7614.543127412373, 7635.389168866366, 7929.048514178336, 8080.0, 8095.676172953016, 8103.1491693371345, 8106.0, 7255.709771609077, 7265.818354541178, 7297.379722723628, 7317.0, 7326.084239470067, 7384.076990376203, 7394.704211831467, 7414.777556673308, 7427.925720742724, 7430.888536672062], "unit": "score", "name": "mootools.html", "value": 5062.175099683944}, {"lowerIsBetter": false, "replicates": [336.4851776781524, 343.23287452543576, 348.9441689329707, 349.4321727193311, 355.4064711931075, 6570.540062195648, 6588.637624930633, 6599.472042236622, 6606.867862642756, 6641.435477984371, 6535.54251202416, 6550.475961923046, 6554.147960765094, 6564.901526477095, 6571.3100124486955, 4605.608523275526, 4657.161710892038, 4672.929906051412, 4786.56920877121, 4871.683340582859, 4769.093872164278, 4774.188387974035, 4796.3764710587575, 4804.783784729696, 4810.446798618152, 4246.766427846467, 4561.498235194126, 4773.665843390964, 4782.545658162469, 4798.160321943664, 4536.455625324949, 4719.244920812654, 4724.834630787906, 4726.952730472685, 4775.3553270308585, 4011.578784227643, 4089.1003979124544, 4095.058136628592, 4114.218298523271, 4117.691173161995, 6160.5687601867885, 6277.2153480814895, 6282.403171698681, 6291.559590828644, 6293.181886354744, 5694.544436445074, 5696.515796157331, 5699.059655156894, 5718.456746609107, 5732.111522713986, 6973.755918542877, 6978.685959131852, 6979.9181126925405, 6982.720691172347, 6986.951957206409, 4522.909541809146, 4679.064187162547, 4716.622670186377, 4721.527847215285, 4729.243321068647, 7275.199048366364, 7305.1233851938105, 7342.302481264324, 7343.926560734378, 7346.926530734678, 4048.2308361411237, 4741.905161896742, 4766.95233047672, 4773.665843390999, 4776.14029474691, 4838.685485443505, 4839.0, 4849.2726091086615, 4857.927131093036, 4858.514148585184, 5651.237082993825, 5656.632318899258, 5657.519110875622, 5673.461021202979, 5677.83604361105, 6670.966645166744, 6960.798032904921, 7029.26192749754, 7040.295970403021, 7083.0, 1456.4247122386598, 1573.3942432163471, 1639.0, 1640.097946129624, 1640.409452597064, 1048.4024106259512, 1050.3592808386877, 1062.219268837404, 1065.63235683689, 1078.940658263803, 6271.7804876830005, 6458.773942911976, 6469.870602587922, 6491.610503369813, 6510.674466276667, 6443.613383197023, 7043.542169758949, 7050.823729406703, 7219.711211551479, 7224.711011559479, 5852.619579727304, 6100.664463454464, 6519.348065193442, 6555.278919318871, 6572.934270657232, 3808.9525380520577, 3842.4620553122586, 3843.404272337792, 3844.231153769257, 3856.2287542491613, 6802.319768023158, 6851.760188393382, 7286.453515986323, 7559.433042521833, 7603.65783539742, 7490.250974902466, 7490.925090749023, 7541.208173141851, 7541.886871696929, 7552.320291173821, 7585.2035536267895, 7593.202713715202, 7596.278353556403, 7602.961985190039, 7605.809854753676, 6155.738073694972, 7151.284871513015, 7282.12614486265, 7306.7077316906725, 7329.74345897891, 6899.965500172467, 7147.213806481179, 7166.175889772743, 7176.102987126609, 7179.1026121734785, 7465.813354666177, 7533.1336896257635, 7535.585542795199, 7539.434542409451, 7555.848883022419, 4579.290210017452, 4653.906921861611, 4664.253719404879, 4667.299905014139, 4673.392458980311, 7227.530210536509, 7231.566106033655, 7239.095113110861, 7253.3834624055435, 7259.491835571459, 6691.899621505584, 6945.409640180439, 6950.513464057467, 6987.231404545394, 7003.649817509002, 6892.862142757217, 6918.169819621678, 6939.132608423947, 7004.929950700428, 7022.1924478685605, 6825.419839313516, 6837.726490940506, 6844.726210951506, 6857.142857142857, 6871.175458944958, 6973.4072603829245, 6988.301169882971, 6991.510594258353, 6996.510244282851, 7002.054722612382, 5607.934492446422, 5741.052726300114, 6500.577462464925, 6601.801945941629, 6727.360900714424], "unit": "score", "name": "prototype.html", "value": 5108.982994591048}, {"lowerIsBetter": false, "replicates": [770.1720650300928, 781.6052893288888, 787.3976408047848, 793.920607939206, 818.9754307370778, 15636.983596066248, 15737.60655983601, 15841.28714207862, 15843.445479408223, 15867.127307998055, 14762.778558321634, 14971.77542336863, 14985.625359366022, 15001.174935378549, 15012.249387530634, 838.0362583029504, 843.3716880923721, 978.4178413843752, 999.8800143982733, 1021.7139201023688, 1001.0790073132699, 1001.3841487485217, 1002.8896821349682, 1007.0231875081159, 1010.0202803280806, 1058.8782290036668, 1062.4900047976976, 1065.4725910674226, 1066.386827574144, 1070.9825665617655, 857.4298091768966, 1037.8131936251473, 1049.1868801678684, 1059.1262208677795, 1063.3035361838008, 800.2397722163968, 800.6917336825306, 800.9439339246255, 802.06959926485, 804.4288555125868, 15648.061116333056, 15702.822288328422, 15765.448209312619, 15767.763483547757, 15772.71295662134, 13492.662683432894, 13501.32493375337, 13516.594502164951, 13775.035747497679, 13968.580942571638, 10364.067233948905, 10448.843267350996, 10547.314424562379, 10752.247342686014, 10877.07544858688, 3604.153024039375, 3647.2340808430263, 3651.361011822947, 3683.3554128027754, 3811.942820857689, 86511.0, 89745.55127224387, 91343.08656913412, 91514.0, 91634.08365916323, 9804.264680148875, 9831.31180817336, 9960.352577082467, 10097.526106104051, 10521.84217236742, 24246.636300455506, 24273.635895461583, 24279.63580546293, 24334.756652433603, 24367.390815229406, 7633.618319084024, 7767.72812951544, 7839.6472158752995, 8081.353491720766, 8194.754157375288, 4129.834806607762, 4136.234796562646, 4177.811998460076, 4260.211860805761, 4480.439945006874, 3540.8937731868086, 3789.4505296732373, 3792.7534710243744, 3794.2790869734663, 3795.9430608540893, 692.3007762160255, 705.3299365602595, 707.1764023268381, 715.7995761186876, 721.2787212787213, 582.1820342418908, 614.2983934501406, 625.7027911741886, 630.338144947803, 631.3434028610194, 8307.252347288773, 8497.022842373206, 8536.786580335418, 8544.957275213585, 8617.396782225183, 582.9300483941954, 610.215872603711, 636.2746469025315, 641.1920979565781, 641.5701480008405, 3422.0418282880337, 3960.20795840833, 4050.5139383274195, 4057.89855253621, 4151.896202594899, 85157.57421212854, 85314.57342713246, 86305.56847215723, 86306.0, 86561.0, 81035.18964810277, 81804.18195818085, 82597.58701206456, 83220.16779832245, 84623.0, 56277.71861140668, 76066.0, 76702.84945725818, 76834.0, 77448.22551774523, 6822.420094292041, 7998.720204767209, 8006.359491240803, 8188.426810123234, 8250.298724608476, 53142.46857531375, 53390.73304633452, 53491.73254133704, 53818.46181538134, 55800.0, 73318.0, 75264.49471010659, 75298.8705169412, 75535.24464755283, 76725.61637192001, 9059.547022648972, 10418.062374386342, 10480.266381353536, 10576.101031412416, 10689.51897164614, 10193.84709229377, 11436.485358158736, 11490.195686301879, 11530.192886497865, 11993.980511656608, 10067.244956628429, 10616.0, 10629.627963021258, 10638.340335086217, 10858.402787846744, 10331.276810623183, 10407.635732749317, 10514.842277365999, 10557.894421055691, 10709.036186743231, 10565.471726413802, 10568.207384446043, 10615.31000484966, 10618.510606587388, 10717.732056698645, 9129.49787761653, 9140.954295228481, 9260.953695231481, 9414.293927955294, 9418.10527999839, 8992.46045237288, 9088.454692718193, 9156.58795354224, 9250.121238482334, 9300.348975571645], "unit": "score", "name": "yui.html", "value": 7164.756076253984}], "name": "dromaeo_css", "value": 7649.106599414633}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 111.0, 111.0, 160.0, 160.0, 119.0, 112.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 121.5}, {"lowerIsBetter": true, "replicates": [154.0, 119.0, 142.0, 153.0, 116.0, 139.0, 116.0, 151.0, 177.0, 107.0], "unit": "score", "name": "audio-beat-detection", "value": 137.4}, {"lowerIsBetter": true, "replicates": [183.0, 182.0, 184.0, 187.0, 185.0, 217.0, 185.0, 187.0, 183.0, 186.0], "unit": "score", "name": "audio-dft", "value": 187.9}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 77.0, 118.0, 54.0, 51.0, 57.0, 66.0, 142.0, 81.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [91.0, 132.0, 172.0, 105.0, 77.0, 88.0, 117.0, 75.0, 77.0, 123.0], "unit": "score", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [91.0, 85.0, 88.0, 85.0, 87.0, 84.0, 89.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.4}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 92.0, 94.0, 92.0, 93.0, 92.0, 94.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.6}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 85.0, 85.0, 87.0, 85.0, 84.0, 84.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 56.0, 55.0, 56.0, 57.0, 66.0, 49.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 76.0, 73.0, 68.0, 66.0, 66.0, 67.0, 67.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 81.0, 80.0, 81.0, 79.0, 78.0, 79.0, 79.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [118.0, 127.0, 116.0, 131.0, 121.0, 130.0, 119.0, 113.0, 121.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [128.0, 120.0, 132.0, 133.0, 132.0, 132.0, 131.0, 131.0, 125.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 129.5}, {"lowerIsBetter": true, "replicates": [68.0, 64.0, 67.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1415.8999999999999}]} 12:04:08 INFO - Return code: 0 12:04:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:04:08 INFO - # TBPL SUCCESS # 12:04:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:04:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:04:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:04:08 INFO - 2016-03-19 12:04:08.420 screenresolution[2301:63371] starting screenresolution argv=screenresolution get 12:04:08 INFO - 2016-03-19 12:04:08.422 screenresolution[2301:63371] Display 0: 1600x1200x32@60 12:04:08 INFO - 2016-03-19 12:04:08.428 screenresolution[2302:63374] starting screenresolution argv=screenresolution list 12:04:08 INFO - Available Modes on Display 0 12:04:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:04:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:04:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:04:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:04:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:04:08 INFO - Intel Iris: 12:04:08 INFO - Chipset Model: Intel Iris 12:04:08 INFO - Type: GPU 12:04:08 INFO - Bus: Built-In 12:04:08 INFO - VRAM (Dynamic, Max): 1536 MB 12:04:08 INFO - Vendor: Intel (0x8086) 12:04:08 INFO - Device ID: 0x0a2e 12:04:08 INFO - Revision ID: 0x0009 12:04:08 INFO - Displays: 12:04:08 INFO - Display: 12:04:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:04:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:04:08 INFO - Display Serial Number: 1600x1200 60 12:04:08 INFO - Main Display: Yes 12:04:08 INFO - Mirror: Off 12:04:08 INFO - Online: Yes 12:04:08 INFO - Rotation: Supported 12:04:08 INFO - Return code: 0 12:04:08 INFO - Running post-action listener: _resource_record_post_action 12:04:08 INFO - Running post-run listener: _resource_record_post_run 12:04:09 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 118784; Write bytes: 665520640; Read time: 2; Write time: 1838 12:04:09 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 352631296; Write bytes: 353179648; Read time: 27126; Write time: 666 12:04:09 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 118784; Write bytes: 300563456; Read time: 2; Write time: 1131 12:04:09 INFO - Running post-run listener: _upload_blobber_files 12:04:09 INFO - Blob upload gear active. 12:04:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:04:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:04:10 INFO - (blobuploader) - INFO - Open directory for files ... 12:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:10 INFO - (blobuploader) - INFO - Done attempting. 12:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:04:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:11 INFO - (blobuploader) - INFO - Done attempting. 12:04:11 INFO - (blobuploader) - INFO - Iteration through files over. 12:04:11 INFO - Return code: 0 12:04:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:04:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:04:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9094e685788c102841760b6d61a1f9fa6e02bc4a57b095032ab9e6593317e2d2bc7792d29ef37e18903a299e4c58c3454f879d332ba2492272bf2237941f5fb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bd12e422cee6830d302d10990b4f7e267e7ed815fb364ce6875e6d7acf31d8c462ef7c6ba5105450b3505e0d6b2da46e4b1f5ac13ee7e9a0aadf6a2b33f95fa"} 12:04:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:04:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:04:11 INFO - Contents: 12:04:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9094e685788c102841760b6d61a1f9fa6e02bc4a57b095032ab9e6593317e2d2bc7792d29ef37e18903a299e4c58c3454f879d332ba2492272bf2237941f5fb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bd12e422cee6830d302d10990b4f7e267e7ed815fb364ce6875e6d7acf31d8c462ef7c6ba5105450b3505e0d6b2da46e4b1f5ac13ee7e9a0aadf6a2b33f95fa"} 12:04:11 INFO - Running post-run listener: copy_logs_to_upload_dir 12:04:11 INFO - Copying logs to upload dir... 12:04:11 INFO - mkdir: /builds/slave/test/build/upload/logs 12:04:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.926479 ========= master_lag: 21.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-03-19 12:04:33.791377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 12:04:33.795243) ========= 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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9094e685788c102841760b6d61a1f9fa6e02bc4a57b095032ab9e6593317e2d2bc7792d29ef37e18903a299e4c58c3454f879d332ba2492272bf2237941f5fb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bd12e422cee6830d302d10990b4f7e267e7ed815fb364ce6875e6d7acf31d8c462ef7c6ba5105450b3505e0d6b2da46e4b1f5ac13ee7e9a0aadf6a2b33f95fa"} build_url:https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/dQQshNeBRv6p4Ea-LArGcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9094e685788c102841760b6d61a1f9fa6e02bc4a57b095032ab9e6593317e2d2bc7792d29ef37e18903a299e4c58c3454f879d332ba2492272bf2237941f5fb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bd12e422cee6830d302d10990b4f7e267e7ed815fb364ce6875e6d7acf31d8c462ef7c6ba5105450b3505e0d6b2da46e4b1f5ac13ee7e9a0aadf6a2b33f95fa"}' ========= master_lag: 0.56 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 12:04:34.367399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 33 secs) (at 2016-03-19 12:04:34.367792) ========= 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.PL17Pf8Oma/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.gWFpXyqmNS/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005427 ========= master_lag: 33.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 33 secs) (at 2016-03-19 12:05:07.433856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 12:05:07.434152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 12:05:07.474162) ========= ========= Total master_lag: 55.80 =========