builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0051 starttime: 1457922078.9 results: success (0) buildid: 20160313180626 builduid: 0105a0b2ac1f4f7c911a6c1e4d62ee6b revision: 34a219cbd67d2bf0c555321ef8308a6aefcef23d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:18.901408) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:18.901799) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:18.902374) ========= 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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005398 basedir: '/builds/slave/test' ========= master_lag: 0.20 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:19.112394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-03-13 19:21:19.112690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-03-13 19:21:37.196257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-13 19:21:37.196506) ========= 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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005334 ========= master_lag: 1.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-13 19:21:38.269280) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:38.269594) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:38.271973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-13 19:21:38.272251) ========= 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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-13 19:21:39-- 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% 8.10M=0.001s 2016-03-13 19:21:39 (8.10 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129016 ========= master_lag: 1.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-13 19:21:39.515578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:39.519890) ========= 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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.018921 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:39.681979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-13 19:21:39.682310) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 34a219cbd67d2bf0c555321ef8308a6aefcef23d --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 34a219cbd67d2bf0c555321ef8308a6aefcef23d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aVfXKpcDV8/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.2QExHyA8Ng/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-13 19:21:39,786 truncating revision to first 12 chars 2016-03-13 19:21:39,786 Setting DEBUG logging. 2016-03-13 19:21:39,786 attempt 1/10 2016-03-13 19:21:39,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/34a219cbd67d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-13 19:21:41,107 unpacking tar archive at: mozilla-aurora-34a219cbd67d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.556411 ========= master_lag: 4.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-13 19:21:45.558120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:45.558420) ========= echo 34a219cbd67d2bf0c555321ef8308a6aefcef23d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'34a219cbd67d2bf0c555321ef8308a6aefcef23d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aVfXKpcDV8/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.2QExHyA8Ng/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 34a219cbd67d2bf0c555321ef8308a6aefcef23d program finished with exit code 0 elapsedTime=0.005157 script_repo_revision: '34a219cbd67d2bf0c555321ef8308a6aefcef23d' ========= master_lag: 0.17 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 19:21:45.734099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-03-13 19:21:45.734375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-03-13 19:21:55.079684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-13 19:21:55.087986) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:21:55 INFO - MultiFileLogger online at 20160313 19:21:55 in /builds/slave/test 19:21:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:21:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:21:55 INFO - {'append_to_log': False, 19:21:55 INFO - 'base_work_dir': '/builds/slave/test', 19:21:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:21:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:21:55 INFO - 'branch': 'Mozilla-Aurora', 19:21:55 INFO - 'buildbot_json_path': 'buildprops.json', 19:21:55 INFO - 'config_files': ('talos/mac_config.py',), 19:21:55 INFO - 'default_actions': ('clobber', 19:21:55 INFO - 'read-buildbot-config', 19:21:55 INFO - 'download-and-extract', 19:21:55 INFO - 'populate-webroot', 19:21:55 INFO - 'create-virtualenv', 19:21:55 INFO - 'install', 19:21:55 INFO - 'run-tests'), 19:21:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:21:55 INFO - 'download_minidump_stackwalk': True, 19:21:55 INFO - 'download_symbols': 'ondemand', 19:21:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:21:55 INFO - 'tooltool.py': '/tools/tooltool.py', 19:21:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:21:55 INFO - '/tools/misc-python/virtualenv.py')}, 19:21:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:21:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:21:55 INFO - 'installer_path': 'installer.exe', 19:21:55 INFO - 'log_level': 'info', 19:21:55 INFO - 'log_name': 'talos', 19:21:55 INFO - 'log_to_console': True, 19:21:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:21:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:21:55 INFO - 'opt_config_files': (), 19:21:55 INFO - 'pip_index': False, 19:21:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:21:55 INFO - 'cmd': ('bash', 19:21:55 INFO - '-c', 19:21:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:21:55 INFO - 'enabled': True, 19:21:55 INFO - 'halt_on_failure': False, 19:21:55 INFO - 'name': 'check_screen_resolution'},), 19:21:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:21:55 INFO - 'cmd': ('bash', 19:21:55 INFO - '-c', 19:21:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:21:55 INFO - 'enabled': True, 19:21:55 INFO - 'halt_on_failure': False, 19:21:55 INFO - 'name': 'check_screen_resolution'},), 19:21:55 INFO - 'run_cmd_checks_enabled': True, 19:21:55 INFO - 'sps_profile': False, 19:21:55 INFO - 'sps_profile_interval': 0, 19:21:55 INFO - 'suite': 'dromaeojs-e10s', 19:21:55 INFO - 'system_bits': '32', 19:21:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:21:55 INFO - 'title': 't-yosemite-r7-0051', 19:21:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:21:55 INFO - 'use_talos_json': True, 19:21:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:21:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:21:55 INFO - 'work_dir': 'build'} 19:21:55 INFO - ##### 19:21:55 INFO - ##### Running clobber step. 19:21:55 INFO - ##### 19:21:55 INFO - Running pre-action listener: _resource_record_pre_action 19:21:55 INFO - Running main action method: clobber 19:21:55 INFO - rmtree: /builds/slave/test/build 19:21:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:21:56 INFO - Running post-action listener: _resource_record_post_action 19:21:56 INFO - ##### 19:21:56 INFO - ##### Running read-buildbot-config step. 19:21:56 INFO - ##### 19:21:56 INFO - Running pre-action listener: _resource_record_pre_action 19:21:56 INFO - Running main action method: read_buildbot_config 19:21:56 INFO - Using buildbot properties: 19:21:56 INFO - { 19:21:56 INFO - "project": "", 19:21:56 INFO - "product": "firefox", 19:21:56 INFO - "script_repo_revision": "production", 19:21:56 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:21:56 INFO - "repository": "", 19:21:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:21:56 INFO - "buildid": "20160313180626", 19:21:56 INFO - "pgo_build": "False", 19:21:56 INFO - "basedir": "/builds/slave/test", 19:21:56 INFO - "buildnumber": 192, 19:21:56 INFO - "slavename": "t-yosemite-r7-0051", 19:21:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:21:56 INFO - "platform": "yosemite_r7", 19:21:56 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:21:56 INFO - "branch": "mozilla-aurora", 19:21:56 INFO - "repo_path": "releases/mozilla-aurora", 19:21:56 INFO - "revision": "34a219cbd67d2bf0c555321ef8308a6aefcef23d", 19:21:56 INFO - "stage_platform": "macosx64", 19:21:56 INFO - "builduid": "0105a0b2ac1f4f7c911a6c1e4d62ee6b", 19:21:56 INFO - "slavebuilddir": "test" 19:21:56 INFO - } 19:21:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 19:21:56 INFO - Running post-action listener: _resource_record_post_action 19:21:56 INFO - ##### 19:21:56 INFO - ##### Running download-and-extract step. 19:21:56 INFO - ##### 19:21:56 INFO - Running pre-action listener: _resource_record_pre_action 19:21:56 INFO - Running main action method: download_and_extract 19:21:56 INFO - mkdir: /builds/slave/test/build/tests 19:21:56 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')]} 19:21:56 INFO - https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:21:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 19:21:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 19:21:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/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 19:21:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/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 19:21:57 INFO - Downloaded 1277 bytes. 19:21:57 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 19:21:57 INFO - Using the following test package requirements: 19:21:57 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 19:21:57 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:21:57 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 19:21:57 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:21:57 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 19:21:57 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:21:57 INFO - u'jsshell-mac.zip'], 19:21:57 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:21:57 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 19:21:57 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 19:21:57 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:21:57 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 19:21:57 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:21:57 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 19:21:57 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:21:57 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 19:21:57 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 19:21:57 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:21:57 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 19:21:57 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:21: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')]} 19:21:57 INFO - https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:21:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:21:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:21:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/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 19:21:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/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 19:21:59 INFO - Downloaded 17864943 bytes. 19:21:59 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'] 19:21:59 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 19:22:02 INFO - Return code: 0 19:22:02 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 19:22: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')]} 19:22:02 INFO - https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:22:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:22:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:22:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/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 19:22:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/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 19:22:03 INFO - Downloaded 17864943 bytes. 19:22:03 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'] 19:22:03 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 19:22:07 INFO - Return code: 0 19:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:07 INFO - https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:22:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 19:22:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 19:22:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/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 19:22:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/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 19:22:08 INFO - Downloaded 10845161 bytes. 19:22:08 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'] 19:22:08 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 19:22:08 INFO - Return code: 0 19:22:08 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')]} 19:22:08 INFO - https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 19:22:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:22:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:22:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 19:22:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWqD2XYFRtunrbQgiqpGmg/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 19:22:11 INFO - Downloaded 115014395 bytes. 19:22:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:22:11 INFO - mkdir: /builds/slave/test/properties 19:22:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:22:11 INFO - Writing to file /builds/slave/test/properties/build_url 19:22:11 INFO - Contents: 19:22:11 INFO - build_url:https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:22:12 INFO - Running post-action listener: _resource_record_post_action 19:22:12 INFO - Running post-action listener: set_extra_try_arguments 19:22:12 INFO - ##### 19:22:12 INFO - ##### Running populate-webroot step. 19:22:12 INFO - ##### 19:22:12 INFO - Running pre-action listener: _resource_record_pre_action 19:22:12 INFO - Running main action method: populate_webroot 19:22:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:22:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:22:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:22:12 INFO - '--tppagecycles', 19:22:12 INFO - '7'], 19:22:12 INFO - 'tests': ['tsvgm']}}, 19:22:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:22:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:22:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:22:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:22:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:22:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:22:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:12 INFO - 'talos_options': ['--e10s'], 19:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:12 INFO - 'tests': ['damp', 'tps']}, 19:22:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:12 INFO - 'talos_options': ['--e10s'], 19:22:12 INFO - 'tests': ['damp', 'tps']}, 19:22:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:22:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:22:12 INFO - 'other': {'tests': ['a11yr', 19:22:12 INFO - 'ts_paint', 19:22:12 INFO - 'tpaint', 19:22:12 INFO - 'sessionrestore', 19:22:12 INFO - 'sessionrestore_no_auto_restore', 19:22:12 INFO - 'tabpaint']}, 19:22:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:22:12 INFO - 'tests': ['a11yr', 19:22:12 INFO - 'ts_paint', 19:22:12 INFO - 'tpaint', 19:22:12 INFO - 'sessionrestore', 19:22:12 INFO - 'sessionrestore_no_auto_restore', 19:22:12 INFO - 'tabpaint']}, 19:22:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:22:12 INFO - 'tests': ['a11yr', 19:22:12 INFO - 'ts_paint', 19:22:12 INFO - 'tpaint', 19:22:12 INFO - 'sessionrestore', 19:22:12 INFO - 'sessionrestore_no_auto_restore', 19:22:12 INFO - 'tabpaint']}, 19:22:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:22:12 INFO - 'tests': ['a11yr', 19:22:12 INFO - 'ts_paint', 19:22:12 INFO - 'tpaint', 19:22:12 INFO - 'sessionrestore', 19:22:12 INFO - 'sessionrestore_no_auto_restore', 19:22:12 INFO - 'tabpaint']}, 19:22:12 INFO - 'other_l64': {'tests': ['a11yr', 19:22:12 INFO - 'ts_paint', 19:22:12 INFO - 'tpaint', 19:22:12 INFO - 'sessionrestore', 19:22:12 INFO - 'sessionrestore_no_auto_restore', 19:22:12 INFO - 'tabpaint']}, 19:22:12 INFO - 'other_nol64': {'tests': ['a11yr', 19:22:12 INFO - 'ts_paint', 19:22:12 INFO - 'tpaint', 19:22:12 INFO - 'sessionrestore', 19:22:12 INFO - 'sessionrestore_no_auto_restore', 19:22:12 INFO - 'tabpaint']}, 19:22:12 INFO - 'svgr': {'tests': ['tsvgx', 19:22:12 INFO - 'tsvgr_opacity', 19:22:12 INFO - 'tart', 19:22:12 INFO - 'tscrollx', 19:22:12 INFO - 'cart']}, 19:22:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:22:12 INFO - 'tests': ['tsvgx', 19:22:12 INFO - 'tsvgr_opacity', 19:22:12 INFO - 'tart', 19:22:12 INFO - 'tscrollx', 19:22:12 INFO - 'cart']}, 19:22:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:12 INFO - 'tests': ['tp5o']}, 19:22:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:12 INFO - 'talos_options': ['--e10s'], 19:22:12 INFO - 'tests': ['tp5o']}, 19:22:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:12 INFO - 'talos_options': ['--xperf_path', 19:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:12 INFO - 'tests': ['tp5n']}, 19:22:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:12 INFO - 'talos_options': ['--e10s', 19:22:12 INFO - '--xperf_path', 19:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:12 INFO - 'tests': ['tp5n']}}, 19:22:12 INFO - 'talos.zip': {'path': '', 19:22:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:22:12 INFO - Running post-action listener: _resource_record_post_action 19:22:12 INFO - ##### 19:22:12 INFO - ##### Running create-virtualenv step. 19:22:12 INFO - ##### 19:22:12 INFO - Running pre-action listener: _resource_record_pre_action 19:22:12 INFO - Running main action method: create_virtualenv 19:22:12 INFO - Creating virtualenv /builds/slave/test/build/venv 19:22:12 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 19:22:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:22:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:22:12 INFO - Using real prefix '/tools/python27' 19:22:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:22:13 INFO - Installing distribute.............................................................................................................................................................................................done. 19:22:16 INFO - Installing pip.................done. 19:22:16 INFO - Return code: 0 19:22:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d3580b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, '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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:16 INFO - 'HOME': '/Users/cltbld', 19:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:16 INFO - 'LOGNAME': 'cltbld', 19:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:16 INFO - 'MOZ_NO_REMOTE': '1', 19:22:16 INFO - 'NO_EM_RESTART': '1', 19:22:16 INFO - 'PAGER': '/bin/cat', 19:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:16 INFO - 'PWD': '/builds/slave/test', 19:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:16 INFO - 'SHELL': '/bin/bash', 19:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:22:16 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:16 INFO - 'USER': 'cltbld', 19:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:16 INFO - 'XPC_FLAGS': '0x0', 19:22:16 INFO - 'XPC_SERVICE_NAME': '0', 19:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:16 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 19:22:16 INFO - Cleaning up... 19:22:16 INFO - Return code: 0 19:22:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d3580b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, '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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:16 INFO - 'HOME': '/Users/cltbld', 19:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:16 INFO - 'LOGNAME': 'cltbld', 19:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:16 INFO - 'MOZ_NO_REMOTE': '1', 19:22:16 INFO - 'NO_EM_RESTART': '1', 19:22:16 INFO - 'PAGER': '/bin/cat', 19:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:16 INFO - 'PWD': '/builds/slave/test', 19:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:16 INFO - 'SHELL': '/bin/bash', 19:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:22:16 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:16 INFO - 'USER': 'cltbld', 19:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:16 INFO - 'XPC_FLAGS': '0x0', 19:22:16 INFO - 'XPC_SERVICE_NAME': '0', 19:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:16 INFO - Downloading/unpacking psutil>=0.7.1 19:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:22:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:19 INFO - Installing collected packages: psutil 19:22:19 INFO - Running setup.py install for psutil 19:22:19 INFO - building 'psutil._psutil_osx' extension 19:22:19 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 INFO - building 'psutil._psutil_posix' extension 19:22:20 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 19:22:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:22:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:22:20 INFO - ^ 19:22:20 INFO - 1 warning generated. 19:22:20 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 19:22:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:20 INFO - Successfully installed psutil 19:22:20 INFO - Cleaning up... 19:22:20 INFO - Return code: 0 19:22:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:22:20 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')]} 19:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:20 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')]} 19:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:20 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 0x109cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d3580b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, '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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:22:20 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 19:22:20 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 19:22:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:22:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:20 INFO - 'HOME': '/Users/cltbld', 19:22:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:20 INFO - 'LOGNAME': 'cltbld', 19:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:20 INFO - 'MOZ_NO_REMOTE': '1', 19:22:20 INFO - 'NO_EM_RESTART': '1', 19:22:20 INFO - 'PAGER': '/bin/cat', 19:22:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:20 INFO - 'PWD': '/builds/slave/test', 19:22:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:20 INFO - 'SHELL': '/bin/bash', 19:22:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:22:20 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:22:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:20 INFO - 'USER': 'cltbld', 19:22:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:20 INFO - 'XPC_FLAGS': '0x0', 19:22:20 INFO - 'XPC_SERVICE_NAME': '0', 19:22:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:22:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:22:23 INFO - Installing collected packages: mozsystemmonitor 19:22:23 INFO - Running setup.py install for mozsystemmonitor 19:22:23 INFO - Successfully installed mozsystemmonitor 19:22:23 INFO - Cleaning up... 19:22:23 INFO - Return code: 0 19:22:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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')]} 19:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d3580b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, '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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:22:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:22:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:23 INFO - 'HOME': '/Users/cltbld', 19:22:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:23 INFO - 'LOGNAME': 'cltbld', 19:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:23 INFO - 'MOZ_NO_REMOTE': '1', 19:22:23 INFO - 'NO_EM_RESTART': '1', 19:22:23 INFO - 'PAGER': '/bin/cat', 19:22:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:23 INFO - 'PWD': '/builds/slave/test', 19:22:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:23 INFO - 'SHELL': '/bin/bash', 19:22:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:22:23 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:22:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:23 INFO - 'USER': 'cltbld', 19:22:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:23 INFO - 'XPC_FLAGS': '0x0', 19:22:23 INFO - 'XPC_SERVICE_NAME': '0', 19:22:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:23 INFO - Downloading/unpacking blobuploader==1.2.4 19:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:26 INFO - Downloading blobuploader-1.2.4.tar.gz 19:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:22:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:22:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:27 INFO - Downloading docopt-0.6.1.tar.gz 19:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:22:27 INFO - Installing collected packages: blobuploader, requests, docopt 19:22:27 INFO - Running setup.py install for blobuploader 19:22:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:22:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:22:27 INFO - Running setup.py install for requests 19:22:28 INFO - Running setup.py install for docopt 19:22:28 INFO - Successfully installed blobuploader requests docopt 19:22:28 INFO - Cleaning up... 19:22:28 INFO - Return code: 0 19:22:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:28 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')]} 19:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:28 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')]} 19:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:28 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 0x109cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d3580b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, '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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:22:28 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 19:22:28 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 19:22:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:22:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:28 INFO - 'HOME': '/Users/cltbld', 19:22:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:28 INFO - 'LOGNAME': 'cltbld', 19:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:28 INFO - 'MOZ_NO_REMOTE': '1', 19:22:28 INFO - 'NO_EM_RESTART': '1', 19:22:28 INFO - 'PAGER': '/bin/cat', 19:22:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:28 INFO - 'PWD': '/builds/slave/test', 19:22:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:28 INFO - 'SHELL': '/bin/bash', 19:22:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:22:28 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:22:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:28 INFO - 'USER': 'cltbld', 19:22:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:28 INFO - 'XPC_FLAGS': '0x0', 19:22:28 INFO - 'XPC_SERVICE_NAME': '0', 19:22:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-poa0fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-iFlZ_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Te_Wmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-SQE1_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-7LowZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-tOT3lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-z0dLij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2EIyp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-3NYrq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-beiT41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-w2tREp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-EWOJQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-dDPjIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-R_5GJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ZbXjNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-J16Sz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:30 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-fKeeZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:22:30 INFO - Running setup.py install for manifestparser 19:22:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:22:30 INFO - Running setup.py install for mozcrash 19:22:30 INFO - Running setup.py install for mozdebug 19:22:30 INFO - Running setup.py install for mozdevice 19:22:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:22:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:22:30 INFO - Running setup.py install for mozfile 19:22:30 INFO - Running setup.py install for mozhttpd 19:22:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:22:31 INFO - Running setup.py install for mozinfo 19:22:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:22:31 INFO - Running setup.py install for mozInstall 19:22:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:22:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:22:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:22:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:22:31 INFO - Running setup.py install for mozleak 19:22:31 INFO - Running setup.py install for mozlog 19:22:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:22:31 INFO - Running setup.py install for moznetwork 19:22:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:22:31 INFO - Running setup.py install for mozprocess 19:22:32 INFO - Running setup.py install for mozprofile 19:22:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:22:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:22:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:22:32 INFO - Running setup.py install for mozrunner 19:22:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:22:32 INFO - Running setup.py install for mozscreenshot 19:22:32 INFO - Running setup.py install for moztest 19:22:32 INFO - Running setup.py install for mozversion 19:22:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:22:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:22:32 INFO - Cleaning up... 19:22:32 INFO - Return code: 0 19:22:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:32 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')]} 19:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:32 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')]} 19:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:32 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 0x109cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d3580b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, '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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:22:32 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 19:22:32 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 19:22:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:22:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:32 INFO - 'HOME': '/Users/cltbld', 19:22:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:32 INFO - 'LOGNAME': 'cltbld', 19:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:32 INFO - 'MOZ_NO_REMOTE': '1', 19:22:32 INFO - 'NO_EM_RESTART': '1', 19:22:32 INFO - 'PAGER': '/bin/cat', 19:22:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:32 INFO - 'PWD': '/builds/slave/test', 19:22:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:32 INFO - 'SHELL': '/bin/bash', 19:22:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:22:32 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:22:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:32 INFO - 'USER': 'cltbld', 19:22:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:32 INFO - 'XPC_FLAGS': '0x0', 19:22:32 INFO - 'XPC_SERVICE_NAME': '0', 19:22:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2oKfOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:33 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)) 19:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-YS4RXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:33 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)) 19:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-UNPCx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:33 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)) 19:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-H91jej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:33 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)) 19:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-xLaY_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:33 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)) 19:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-bIxP7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:33 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)) 19:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Kw8Fji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:33 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)) 19:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-TMG1Qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:33 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)) 19:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-qXwI4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:34 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)) 19:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-jq5KK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:34 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)) 19:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-nCA0WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:34 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)) 19:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-nRbsvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:34 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)) 19:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-7tq9hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:34 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)) 19:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-a_QxTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:34 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)) 19:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-DcX_hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:34 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)) 19:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-RsWQyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22:34 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)) 19:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-uRO6Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22:34 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)) 19:22:34 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)) 19:22:34 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)) 19:22:34 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)) 19:22:34 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)) 19:22:34 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)) 19:22:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:22:34 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 19:22:34 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 19:22:34 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 19:22:34 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 19:22:34 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 19:22:34 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 19:22:37 INFO - Downloading blessings-1.6.tar.gz 19:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:22:37 INFO - Installing collected packages: blessings 19:22:37 INFO - Running setup.py install for blessings 19:22:37 INFO - Successfully installed blessings 19:22:37 INFO - Cleaning up... 19:22:37 INFO - Return code: 0 19:22:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:22:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:37 INFO - Reading from file tmpfile_stdout 19:22:37 INFO - Current package versions: 19:22:37 INFO - blessings == 1.6 19:22:37 INFO - blobuploader == 1.2.4 19:22:37 INFO - docopt == 0.6.1 19:22:37 INFO - manifestparser == 1.1 19:22:37 INFO - mozInstall == 1.12 19:22:37 INFO - mozcrash == 0.17 19:22:37 INFO - mozdebug == 0.1 19:22:37 INFO - mozdevice == 0.48 19:22:37 INFO - mozfile == 1.2 19:22:37 INFO - mozhttpd == 0.7 19:22:37 INFO - mozinfo == 0.9 19:22:37 INFO - mozleak == 0.1 19:22:37 INFO - mozlog == 3.1 19:22:37 INFO - moznetwork == 0.27 19:22:37 INFO - mozprocess == 0.22 19:22:37 INFO - mozprofile == 0.28 19:22:37 INFO - mozrunner == 6.11 19:22:37 INFO - mozscreenshot == 0.1 19:22:37 INFO - mozsystemmonitor == 0.0 19:22:37 INFO - moztest == 0.7 19:22:37 INFO - mozversion == 1.4 19:22:37 INFO - psutil == 3.1.1 19:22:37 INFO - requests == 1.2.3 19:22:37 INFO - wsgiref == 0.1.2 19:22:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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')]} 19:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:37 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 0x109cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d3580b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, '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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:22:37 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 19:22:37 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 19:22:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:22:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:37 INFO - 'HOME': '/Users/cltbld', 19:22:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:37 INFO - 'LOGNAME': 'cltbld', 19:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:37 INFO - 'MOZ_NO_REMOTE': '1', 19:22:37 INFO - 'NO_EM_RESTART': '1', 19:22:37 INFO - 'PAGER': '/bin/cat', 19:22:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:37 INFO - 'PWD': '/builds/slave/test', 19:22:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:37 INFO - 'SHELL': '/bin/bash', 19:22:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:22:37 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:22:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:37 INFO - 'USER': 'cltbld', 19:22:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:37 INFO - 'XPC_FLAGS': '0x0', 19:22:37 INFO - 'XPC_SERVICE_NAME': '0', 19:22:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:38 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)) 19:22:38 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)) 19:22:38 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)) 19:22:38 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)) 19:22:38 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)) 19:22:38 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)) 19:22:38 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)) 19:22:38 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)) 19:22:38 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)) 19:22:38 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)) 19:22:38 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)) 19:22:38 INFO - Cleaning up... 19:22:38 INFO - Return code: 0 19:22:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:38 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 0x109cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d3580b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, '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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:22:38 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 19:22:38 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 19:22:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:22:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:38 INFO - 'HOME': '/Users/cltbld', 19:22:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:38 INFO - 'LOGNAME': 'cltbld', 19:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:38 INFO - 'MOZ_NO_REMOTE': '1', 19:22:38 INFO - 'NO_EM_RESTART': '1', 19:22:38 INFO - 'PAGER': '/bin/cat', 19:22:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:38 INFO - 'PWD': '/builds/slave/test', 19:22:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:38 INFO - 'SHELL': '/bin/bash', 19:22:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:22:38 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:22:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:38 INFO - 'USER': 'cltbld', 19:22:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:38 INFO - 'XPC_FLAGS': '0x0', 19:22:38 INFO - 'XPC_SERVICE_NAME': '0', 19:22:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:38 INFO - Downloading/unpacking jsonschema 19:22:38 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 19:22:38 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 19:22:38 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 19:22:38 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 19:22:38 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 19:22:38 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 19:22:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:22:40 INFO - Downloading/unpacking functools32 (from jsonschema) 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:22:41 INFO - Downloading functools32-3.2.3-2.tar.gz 19:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:22:41 INFO - warning: no files found matching '*.txt' 19:22:41 INFO - no previously-included directories found matching 'build' 19:22:41 INFO - no previously-included directories found matching 'dist' 19:22:41 INFO - no previously-included directories found matching '.git*' 19:22:41 INFO - Installing collected packages: jsonschema, functools32 19:22:41 INFO - Running setup.py install for functools32 19:22:41 INFO - warning: no files found matching '*.txt' 19:22:41 INFO - no previously-included directories found matching 'build' 19:22:41 INFO - no previously-included directories found matching 'dist' 19:22:41 INFO - no previously-included directories found matching '.git*' 19:22:41 INFO - Successfully installed jsonschema functools32 19:22:41 INFO - Cleaning up... 19:22:41 INFO - Return code: 0 19:22:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:22:41 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')]} 19:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:41 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')]} 19:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:41 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 0x109cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d3580b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, '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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 19:22:41 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 19:22:41 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 19:22:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:22:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:41 INFO - 'HOME': '/Users/cltbld', 19:22:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:41 INFO - 'LOGNAME': 'cltbld', 19:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:41 INFO - 'MOZ_NO_REMOTE': '1', 19:22:41 INFO - 'NO_EM_RESTART': '1', 19:22:41 INFO - 'PAGER': '/bin/cat', 19:22:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:41 INFO - 'PWD': '/builds/slave/test', 19:22:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:41 INFO - 'SHELL': '/bin/bash', 19:22:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:22:41 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:22:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:41 INFO - 'USER': 'cltbld', 19:22:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:41 INFO - 'XPC_FLAGS': '0x0', 19:22:41 INFO - 'XPC_SERVICE_NAME': '0', 19:22:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:41 INFO - Downloading/unpacking flake8 19:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:22:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:22:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:22:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:22:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:22:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:22:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:22:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:22:45 INFO - no previously-included directories found matching 'docs/_build' 19:22:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:22:45 INFO - Running setup.py install for pep8 19:22:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:22:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:22:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:22:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:22:45 INFO - no previously-included directories found matching 'docs/_build' 19:22:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:22:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:22:45 INFO - Cleaning up... 19:22:45 INFO - Return code: 0 19:22:45 INFO - Running post-action listener: _resource_record_post_action 19:22:45 INFO - Running post-action listener: _start_resource_monitoring 19:22:45 INFO - Starting resource monitoring. 19:22:45 INFO - ##### 19:22:45 INFO - ##### Running install step. 19:22:45 INFO - ##### 19:22:45 INFO - Running pre-action listener: _resource_record_pre_action 19:22:45 INFO - Running main action method: install 19:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:45 INFO - Reading from file tmpfile_stdout 19:22:45 INFO - Detecting whether we're running mozinstall >=1.0... 19:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:22:46 INFO - Reading from file tmpfile_stdout 19:22:46 INFO - Output received: 19:22:46 INFO - Usage: mozinstall [options] installer 19:22:46 INFO - Options: 19:22:46 INFO - -h, --help show this help message and exit 19:22:46 INFO - -d DEST, --destination=DEST 19:22:46 INFO - Directory to install application into. [default: 19:22:46 INFO - "/builds/slave/test"] 19:22:46 INFO - --app=APP Application being installed. [default: firefox] 19:22:46 INFO - mkdir: /builds/slave/test/build/application 19:22:46 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'] 19:22:46 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 19:23:17 INFO - Reading from file tmpfile_stdout 19:23:17 INFO - Output received: 19:23:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:23:17 INFO - Running post-action listener: _resource_record_post_action 19:23:17 INFO - ##### 19:23:17 INFO - ##### Running run-tests step. 19:23:17 INFO - ##### 19:23:17 INFO - Running pre-action listener: _resource_record_pre_action 19:23:17 INFO - Running main action method: run_tests 19:23:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:23:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:23:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:23:18 INFO - 2016-03-13 19:23:17.999 screenresolution[1959:26983] starting screenresolution argv=screenresolution get 19:23:18 INFO - 2016-03-13 19:23:18.001 screenresolution[1959:26983] Display 0: 1600x1200x32@60 19:23:18 INFO - 2016-03-13 19:23:18.007 screenresolution[1960:26985] starting screenresolution argv=screenresolution list 19:23:18 INFO - Available Modes on Display 0 19:23:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:23:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:23:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:23:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:23:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:23:18 INFO - Intel Iris: 19:23:18 INFO - Chipset Model: Intel Iris 19:23:18 INFO - Type: GPU 19:23:18 INFO - Bus: Built-In 19:23:18 INFO - VRAM (Dynamic, Max): 1536 MB 19:23:18 INFO - Vendor: Intel (0x8086) 19:23:18 INFO - Device ID: 0x0a2e 19:23:18 INFO - Revision ID: 0x0009 19:23:18 INFO - Displays: 19:23:18 INFO - Display: 19:23:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:23:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:23:18 INFO - Display Serial Number: 1600x1200 60 19:23:18 INFO - Main Display: Yes 19:23:18 INFO - Mirror: Off 19:23:18 INFO - Online: Yes 19:23:18 INFO - Rotation: Supported 19:23:18 INFO - Return code: 0 19:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:23:18 INFO - Python 2.7.3 19:23:18 INFO - Return code: 0 19:23:18 INFO - grabbing minidump binary from tooltool 19:23: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')]} 19:23:18 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 0x109b62d30>, '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 0x1099c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b59b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:23:18 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 19:23:18 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 19:23:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:23:18 INFO - Return code: 0 19:23:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:23:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:23:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:23:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:23:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:23:19 INFO - Return code: 0 19:23:19 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:23:19 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aVfXKpcDV8/Render', 19:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:23:19 INFO - 'HOME': '/Users/cltbld', 19:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:23:19 INFO - 'LOGNAME': 'cltbld', 19:23:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:23:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:19 INFO - 'MOZ_NO_REMOTE': '1', 19:23:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:23:19 INFO - 'NO_EM_RESTART': '1', 19:23:19 INFO - 'PAGER': '/bin/cat', 19:23:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:19 INFO - 'PWD': '/builds/slave/test', 19:23:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:23:19 INFO - 'SHELL': '/bin/bash', 19:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2QExHyA8Ng/Listeners', 19:23:19 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 19:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:23:19 INFO - 'USER': 'cltbld', 19:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:19 INFO - 'XPC_FLAGS': '0x0', 19:23:19 INFO - 'XPC_SERVICE_NAME': '0', 19:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:23:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:23:19 INFO - mozversion application_buildid: 20160313180626 19:23:19 INFO - mozversion application_changeset: 34a219cbd67d2bf0c555321ef8308a6aefcef23d 19:23:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:23:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:23:19 INFO - mozversion application_name: Firefox 19:23:19 INFO - mozversion application_remotingname: firefox-dev 19:23:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:23:19 INFO - mozversion application_vendor: Mozilla 19:23:19 INFO - mozversion application_version: 47.0a2 19:23:19 INFO - mozversion platform_buildid: 20160313180626 19:23:19 INFO - mozversion platform_changeset: 34a219cbd67d2bf0c555321ef8308a6aefcef23d 19:23:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:23:19 INFO - mozversion platform_version: 47.0a2 19:23:19 INFO - using testdate: 1457922199 19:23:19 INFO - actual date: 1457922199 19:23:19 INFO - starting webserver on 'localhost:51922' 19:23:19 INFO - SUITE-START | Running 2 tests 19:23:19 INFO - TEST-START | dromaeo_css 19:23:19 INFO - operating with platform_type : mac_ 19:23:19 INFO - Initialising browser for dromaeo_css test... 19:23:19 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpitMS3T/profile http://localhost:51922/getInfo.html) 19:23:22 INFO - PROCESS | 1978 | __metrics Screen width/height:1600/1200 19:23:22 INFO - PROCESS | 1978 | colorDepth:24 19:23:22 INFO - PROCESS | 1978 | Browser inner width/height: 1024/689 19:23:22 INFO - PROCESS | 1978 | __metrics 19:23:22 ERROR - PROCESS | 1978 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:23:23 INFO - TEST-INFO | 1978: exit 0 19:23:23 INFO - Browser initialized. 19:23:23 INFO - Running cycle 1/1 for dromaeo_css test... 19:23:23 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpitMS3T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:23:35 INFO - PROCESS | 1981 | RSS: Main: 219422720 19:23:35 INFO - PROCESS | 1981 | 19:24:24 INFO - PROCESS | 1981 | 1457922264889 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] 19:26:35 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:51922/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51922/tests/dromaeo/cssquery-ext.html) 19:26:36 INFO - PROCESS | 1981 | RSS: Main: 236969984 19:26:36 INFO - PROCESS | 1981 | 19:29:38 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:51922/tests/dromaeo/cssquery-ext.html (next: http://localhost:51922/tests/dromaeo/cssquery-jquery.html) 19:29:39 INFO - PROCESS | 1981 | RSS: Main: 248664064 19:29:39 INFO - PROCESS | 1981 | 19:32:41 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:51922/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51922/tests/dromaeo/cssquery-mootools.html) 19:32:41 INFO - PROCESS | 1981 | RSS: Main: 249495552 19:32:41 INFO - PROCESS | 1981 | 19:35:43 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:51922/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51922/tests/dromaeo/cssquery-prototype.html) 19:35:44 INFO - PROCESS | 1981 | RSS: Main: 251740160 19:35:44 INFO - PROCESS | 1981 | 19:38:46 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:51922/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51922/tests/dromaeo/cssquery-yui.html) 19:38:47 INFO - PROCESS | 1981 | RSS: Main: 254464000 19:38:47 INFO - PROCESS | 1981 | 19:41:49 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:51922/tests/dromaeo/cssquery-yui.html (next: http://localhost:51922/tests/dromaeo/cssquery-dojo.html) 19:41:49 INFO - PROCESS | 1981 | RSS: Main: 255934464 19:41:49 INFO - PROCESS | 1981 | 19:41:49 INFO - PROCESS | 1981 | __start_tp_report 19:41:49 INFO - PROCESS | 1981 | _x_x_mozilla_page_load 19:41:49 INFO - PROCESS | 1981 | _x_x_mozilla_page_load_details 19:41:49 INFO - PROCESS | 1981 | |i|pagename|runs| 19:41:49 INFO - PROCESS | 1981 | |0;dojo.html;3487.9536139158254;3528.4707293905913;3580.319739249541;3588.802615856127;3600.945985810215;4725.799854345202;5809.796657117002;5830.154627578999;5864.706764661766;5866;4916.80332786689;5696.458836410535;5812.709364531777;5844.649321040741;5854.151148083536;5278.973605131969;5286.207068939651;5339.652922560041;5377.247185394048;5442.482964118402;4387.2541667916375;5239.580833533328;5373.435789242132;5390.8921821563545;5397.514223719864;4344.283193273122;5347.0909945309195;5445.455454454563;5484.588655850807;5489.862753431156;5395.352557693062;5413.810516631918;5431.103867861798;5433.4566543345745;5434.2935418395355;5217.2695822584865;5248.71132087735;5346.759395827197;5382.6232163748555;5413.079776438015;4936.925946110775;5129.435762066169;5611.2144299798065;5753.88492230153;5781.335146458169;6197.721102550396;6200.379962003809;6251.937480625181;6280;6280.591761535531;6187.288461826857;6272.717727702265;6292.087647291117;6313.652749098797;6325.082862984841;5961.195238642815;6049.8487537811025;6054.031354983225;6054.152418661391;6090.299615544181;6434.233741706164;6491.091247225392;6499.772507962293;6510.381513756186;6525.902111468332;6171.321154672983;6171.413715697002;6227.159333490012;6259.4679452246155;6291.9685401573615;6292.653904035322;6311.0217916223055;6311.116443697886;6337.683115844189;6339.809805705836;6188.350223226586;6242.1261023455845;6266.436020758154;6270.435660790551;6287.056941458726;6151.9384806151365;6191.133241346215;6214.067889816563;6262.968685156637;6270.7805226816845;3820.2741479118877;5007.724575148329;5009.949900500948;5018.824341148043;5055.949440505621;4484.264598594855;4496.775161241925;4507.88730281739;4530.207213737583;4534.911621210886;4890.877728056756;5149.433562308143;5902.468777810018;5909.054551271776;5934.821955341346;5343.812966546152;6091.786787462417;6240.937590624127;6266.060090986389;6274.058891166362;5931.673757943355;5979.342272350038;5983.311919129269;5998.190244316961;6005.879882402328;5349.438308977579;5410.675359478444;5478.233047373371;5483.533899618577;5527.032769265443;6518.860692703607;6562.606243625398;6599.307072757291;6599.53803233769;6620.768273110418;6156.846078848064;6307.432331090224;6329.968350158219;6338.746450141943;6341.365863413622;6228.56400051992;6506.219253689587;6511.511636627367;6563.967180164069;6604.537682362188;6176.629402235881;6177.073438984188;6182.69086545662;6185.84535386619;6206.138158552507;5242.275578801421;5403.270558474713;6118.162361256354;6273.498120150468;6282.560220784501;6137.622145770902;6181.979973304355;6198.256209254918;6233.937660623335;6264.310925798068;6192.876142477216;6229.626222426669;6251.593646412968;6280.780172693934;6305.1172835803945;5657.4908258256955;6045.727942242697;6157.568970172045;6160.599561028519;6163.476104531165;6176.197094377702;6239.0953311768635;6273.309935906956;6278.183836101278;6289.622622642656;6118.051701986199;6124.908126378197;6152.846178845386;6167.105769663463;6176.66028368444 19:41:49 INFO - PROCESS | 1981 | |1;ext.html;570.2216474512289;574.6753084507253;577.7688924430224;610.9663968481733;669.6651674162919;39278.41082383763;40022;40198;40273.19453610926;40278.59721402785;39219.41170882439;39684.40473392894;40020.799376018695;41964.79017604908;42669;9507.71476855692;9713.854292185622;9730.902690973071;9739.977302383253;9754.853677194847;9392.906070939305;9623.133917947383;9642.373245739005;9669.95165024174;9695.030496950283;9640.276979226552;9655.951720241424;9681.419114853095;9721.736174297332;9732.2214222862;9593;9655.275854310885;9675.516224188763;9676.129148376645;9705.514724263794;9684.353659877837;9772.560234789451;9802.313838031341;9811.166050885684;9846;38476;38711.61288387108;38718.419223711666;38801.22397552062;38820.805895970625;3373.4939759036097;3397.9490307645406;3493.650634936486;3542.769719968194;3568.411212150018;27120.45759084827;29509.557356639452;29584.964526241478;29863.402731945458;29900.401991960258;2798.678152012524;2807.7332653397893;2818;2836.9007084751934;2843.6587609486787;523159;532569;537095;537687;537857.3107134479;75931;76199;76234.23765762382;76281;76649.61675191588;80134.59932700415;80380.59809701031;80738.59630701809;80881.19118808855;80977.59511202406;18209.7268540972;18386.448406547825;18498.81501184971;18500.444986650422;18543.072846357627;13630.454781808616;13637.795433068512;13686.247256400795;13714.657133571542;13758.518451854337;18493;23034.848257587055;23220.7677923222;23425.41436464102;24224.273271801874;7834.569098699512;8202.794930126794;9920.851187232198;9952.751181220527;10002;858.553552152877;978.8531720241879;1068.71144790906;1148.8391625172483;1183.5679976808576;30258.99309219029;30679.2330191747;30844.691553084183;30970.380592388025;31762.364752704816;1071.287593750163;1190.458341454636;1224.8530176378893;1268.8033354829831;1276.1513593460431;13613.455461781417;14013;15810.60473488149;15907.443239486794;16089.678206435805;563269;565466;568820;569448;571699.1415042898;47948;53867.730661347225;62986.110416687574;63928.041079383845;64068;1498.5654160293393;1515.212089713343;1535.4625880941805;1537.4618883390947;1540.0836502281124;25248.62127068132;26686.86656566705;30024.498775061595;30441.84779076179;31188.68811311858;56000.15999760088;56159;56540.43459565352;56705.432945670014;56775.71612141913;529196;531547;531857;532651;534740;35166;35741.82129089338;35981.28037439289;36373.636263637025;36403.817980909924;47366;47493.76253118712;48442.273365898836;48746.53760387194;49539.51381458562;38814.80592597019;39203.62787302545;39537.011574710865;39732.801335993136;40573;31329.686703132676;37250.25499490049;38724.6127538721;39042.21915561616;39316.80341598274;38164;38989.41515877208;39195.608043919194;39213.8039309813;39549.40675889922;32688.50967235541;33968;34221.31557368789;34368.65631343654;34600.9619711409;25972.870135649202;26207.73792262129;26290.948362065305;26431.867840660674;26564.937402503685 19:41:49 INFO - PROCESS | 1981 | |2;jquery.html;382.40345061703727;387.6995328620319;388.947492088568;390.48846011724623;394.63693402070095;16589.66820663586;19175.61648767024;20097.49268804838;21208.939553022363;21230.15079396824;20052.29816956403;20360.592788144266;20597;20603.587928241424;20704.689429658567;5139.486051394868;5661.745221465023;5955.70221488926;5958.910616340759;5964.821055368346;4414.22751018572;6342.904856427157;6547.345265473438;6578.703958321863;6583.539152259344;5515.448455154473;6495.382938620847;6521.347865213488;6534.509911756613;7303.598302093383;6284.497240220771;6361.6183029018175;6473.255575608819;7654.464187506876;7745.264199901;6111.755529778803;7346.889796653055;7357.153927298322;7361.079865016873;7368.963155184243;26626.93492260307;26769.330766730793;26941.73058269412;27359.726402736116;27585;2113;2437.770468237606;2508.059477695864;2687.0192379781433;2966.821990680566;12367.319797411139;12945.96432285415;15042.924785376112;15553.377864885391;15889.682206355808;1779.5373202967191;1815.5370380553006;1823.6535058338873;1849.1031849552955;1868.0753027251596;120058.79941200564;122267.388663057;128104.07843882349;133428;133856;19691.40925772229;20582.485437864172;20713;20812.895935520224;20817.375478735663;30313.545296820565;31185.532217016764;31466.213344666565;31475;31493.055208343787;11724.531018759155;11734.647960561197;11769.117316201318;11775.442285850264;11810.822837657443;9763.463009534544;9774.609015639295;9861.457619830979;9907.80184396308;10101.595936162617;7510.9484672145945;9080.31897607682;9253.629854805733;9299.72100836976;9312.813743725088;1678.9496315110566;1907.8950657713958;1998.6702194138095;2004.8997550122435;2011.3865271092166;894.4230971023784;921.6958403726754;1006.2101250518308;1114.4873358255131;1115.7824224276187;20470.078846451946;20895.477613059797;21136.577268454854;21288.148474060865;21460.57078858414;1012.549415510091;1016.832222683249;1047.61238341814;1075.1345167140528;1135.7501349703052;10860.294080884718;11332.660020199408;11425.371604561662;11429.59996400122;11453.885461145448;564737;579306;584439;584749;722519;127538;130883;133150;136194.63805362018;139560.30219848835;1062.888396718349;1089.128697042363;1105.7512059786645;1106.3030290916831;1110.8889111088988;17630.94214347092;17736.733948990517;17931.641367172844;18065.72901406454;18369.448916532525;31035;50516;51520.22719659283;53206;53357.19964200618;74187;77505.61247193727;77572.61213693896;77732;78284;7857.096433910174;8139.837203255784;8296;8407.265315909255;8506.872396913928;12174;13522.323883805968;13642.181469111885;13669.521566745116;13798.862011379757;11677.824832627348;11706.063514918957;11774.175807693378;12029.398530073637;12275.956543693886;8008.719694810887;11180.832287515856;11629.76740465169;11639.941800290944;11643.825342619699;5738.68437235956;6880.69036893351;11722.88277117252;11942.820857686967;12306;8317.750467485985;8412.411131220755;8447.704330348653;8514.914850851412;8532.658693652184;11289.37908415045;12002.819957700467;12156.75686486283;12203.572874949334;12212 19:41:49 INFO - PROCESS | 1981 | |3;mootools.html;1580.9920950395247;1626.5689592258054;1641;1715.7597936288914;2025.159558783105;8455.746327610166;9079.046700096495;9418.293627977904;9587.712368628934;9646.517674116292;9265.073492650732;9317.208037316836;9415.764605884857;9416.952915235432;9433.339666223366;2193.74771901231;2613.986930065347;2614.0720044384257;2614.398688301692;2615.725348838373;2523.079076137206;2588.7670109690125;2592.5981472871736;2595.896164153441;2607.70011448683;2591.300348905794;2593.572060609997;2606.387498937748;2642.920712378632;2646.3781011462293;2181.6182168120595;2561.871906404682;2596.389848385628;2600.4019075612528;2605.2054123492326;2017.9192832286692;2554.9105781297753;2562.2441379793004;2580.148550978173;2586.3534116470883;9490.145886870216;9500.144986951207;9557.474338911357;9571.042895710443;9610.95194524023;4880.780364883589;5846.5322774178385;5867.647941123546;5937.762489500415;5985.221921150222;3674.9632503675157;3724.3854763963914;3726.850925962958;3839.155385815144;3842.385218365076;1059.5602824827688;1072.935623862563;1083.7724077943642;1086.5925278020743;1091.9617813376574;12682.175658582162;12755.42600582976;12794.808077878839;12817.295048772314;12837.293948832717;5137.17805151174;5148.485151484896;5254.3169387979315;5278.709670968057;5287.154055351125;10854.294470859526;10859;10865.40240286776;10896.61861834832;10897.346159230472;5736.569757268222;5757.740901659436;5762.2509073820975;5802.361740208574;5821.650700957872;4637.118947399983;5047;5169.327987361619;5182.53357197854;5227.9805437939995;4192.392103145027;4235.301175306102;4254.617084462413;4257.40396344512;4301.65586753059;1206.6018213989362;1370.4792178972127;1408.2747385096684;1414.8231471066117;1418.1491105336715;1160.1762748448527;1184.2657552317446;1188.8395066666062;1404.4382247101241;1469.2286549561566;8698;8797.69208077727;8870.379073464796;8875.201231889161;8908.777280567909;533.2694208933708;540.3434826685595;541.1260813785708;545.2148905576037;550.2351731093783;6460.806175814733;6462.289148193695;6480.125183100221;6482.675866206765;6509.02364645307;11213.327200368005;11588.94205528967;11590.594329198437;11712.824307635392;11749.353785541707;11144.275622084539;11262.943685281685;11314.547418103348;11415.885841141648;11508.59719909799;8716.564171791386;8805;8825.823483530294;8852;8908.975467821154;8162.877556836534;8258.463199891989;8338.541380224146;8448.662053518035;8458.534780587126;9957.701268961942;9984.950075249577;10143.239257055899;10227.539760710637;10270.794584108426;10192.796144077225;10342.069213770797;10410.73973150647;10613.416262105658;10648.733781655521;7131.322524360177;7583.886241706268;7747.612619368896;7812.296893279632;7990.8002299940645;8566.614502347535;8623.180797824196;8646.265067469336;8646.43798153118;8675;7530.962345188239;7698.499597526143;7761.68953241864;7793.883091753742;7893.447458678067;7454.180040195466;7543.321101100927;7550.093988721389;7626.733064342721;7644.847103058019;8114.391420643594;8122.959385203036;8175.1007389188335;8191.590420479071;8199.467034642728;7298.708051677873;7408.703651853865;7452.850942981218;7485.47601667878;7506.962465187639;7502.624868756431;7539.246075392417;7552.509086909334;7585.772426827204;7588.203238660082 19:41:49 INFO - PROCESS | 1981 | |4;prototype.html;335.5921907597629;339.7248228934563;340.4722679846238;347.27766246207875;347.65234765234766;6354.428101470867;6963.860722785541;6965.5124141310125;7034;7039.929600703991;5565.359983601887;5957.731902064406;6971.477139214554;6980.860382792341;7007.194172670144;4790.658615587641;4866.951330486685;4943.604511639061;5130.179171332587;5187.766550505227;5110.233464980264;5119.360079990001;5123.487651234884;5141.177411614142;5158.638895277332;4389.561043895601;4626.149540183937;5055.797768089272;5072.112380333445;5177.275181474578;5146.665466744668;5156.432792392852;5167.9224811627855;5178.17149256121;5202.921956170622;4421.9115617687785;4444.28891377378;4444.533324000966;4446.911061778746;4451.132029254297;6487.93512064878;6547.476201903836;6657.400833924921;6662.533622646417;6678.732850685967;4848.539388758062;5961.254843144607;5971.462568368825;6021.63870167787;6039.63762174271;7395.297446742551;7408.7036518539735;7411.147718012444;7419.554826710415;7429.9257007430315;4918.975405122951;4933.038057578774;4943.703377797307;4945.61522773624;4952.90094198114;7102.60935648534;7870.370370370357;7888.881666775003;7901.170377110436;7904.486208396494;4890.364252647204;4963.230699241623;4964.180910149785;4972.378452693413;4973.303737476756;5046;5056.898862022739;5057.8735531612;5066;5066.949330506722;4954.628402869799;5924.14099955504;5944.64332140073;5947.542852001201;6031.517478601701;7404.481686281909;7414;7425.480216384801;7448.9627551861895;7455.179930207672;1692.6614677064636;1737.7740893683992;1754.7718796556621;1760.515858139022;1787.4816303272166;1084.7505073833063;1088.1892989722708;1165.1901928160016;1180.7107258721496;1187.8990285825628;5271.973640131775;6220.129181914535;6851.623160726108;6952.270011648805;6954.826129346807;6405.391487808651;7237.493375463667;7254.419646428273;7666.8849967250535;7685.423593230418;5505.834824955257;6938.653067346612;6965.373116419547;6968.233494315621;7001.894971575431;3720.1443667956523;4034.7377420467574;4071.4096456013713;4091.754494730326;4102.179564087194;7889.132195458495;7981.72063977758;7998.520088794691;8003.359731221488;8031.277185053374;7901.209879012168;7928.405369597303;7994.5203287802915;8036.276735093753;8050;6354.759072872868;8100.756977290691;8102.918970810334;8117.594120293962;8128.471649342774;7472.8879066815125;7724.150343462103;7727.961360193163;7746.612669366622;7813.202963318355;7549.358304544176;7586.734464293944;7588.582627955516;7595.620218989139;7596.962015189889;8090.919090809017;8104.675812967415;8107.351411887153;8181.059178194584;8347.624356903832;5030.346055012825;5036.773345199402;5037.445880953019;5047.747612619428;5061.063703214917;7341.3392794648735;7703.730369437043;7721.536707797325;7728.613569321624;7774.922250777646;7355.190928997913;7407.777766667009;7415.666295016845;7424.443166762407;7448.9627551861895;7418.517796343436;7433.628318584158;7434.665440055102;7437.8140546486775;7442.62786860644;5493.917591236055;6590.176227971504;7203.243659415686;7215.386692131227;7226.494145409771;7420.777376678709;7432.888506672296;7450.515716478411;7461.365783908429;7480.812979675334;7247.927520724937;7262.237465066303;7264.891026634499;7266.781996540112;7284.963575182091 19:41:49 INFO - PROCESS | 1981 | |5;yui.html;731.9670614822334;770.3413581387913;771.3983093187315;776.1733753552463;786.174516757405;13221.867781322184;13597.640235976398;14011.789823152636;14291.92854035731;14721.779173312396;10287.588496460132;10807.75710793257;11117.499712512936;11956.521739130447;12048.337341446238;760.6805141840413;953.5041778275292;977.3549457358145;980.6763767956558;981.3425005246502;977.0961860279214;977.9168770654503;984.1683777208283;984.9015098490165;990.6037584965999;1018.5416562546884;1038.6364772329662;1040.5733649203828;1040.8074506216374;1042.6663467690341;1017.1252722658545;1022.2026819081092;1029.9021592948732;1030.8917563655857;1031.6698656429946;749.9550026998343;767.1676231289058;767.3592550220573;771.032354395236;776.747557043963;14978.925105374403;15013;15055.096694198382;15326.616834579114;15452.381904723798;12961.22232666043;13042.608721738268;13055.543055992996;13221.801672974912;13239.536616218385;10064.69805905824;10289.485525723683;10315.742106447324;10317.277790554665;10395.16838652906;3556.1643013891717;3565.144365352297;3565.3047655707146;3618.421052631593;3623.3296840084668;83576.58211708903;86423.70364444538;86511;86642.56678716629;86803.56598216969;9605.327627066039;9775.217982561378;9818.116369526633;9850.50747462624;10028.548715307828;22688.88655556712;23150;23150.07399704027;23187.420314492272;23202.419939501648;7461.813454663677;7523.774286771406;7537.924620753723;7546.547207167478;7552.622368881534;3892.221555688817;3965.6232657897453;4059.512858456945;4069.9389509157386;4077.347624380085;3768.3593789055926;3799.411091280856;3818.9497888081;3832.1952389997855;3841.8847434577006;677.1434135818193;680.53383432348;686.4851361478891;694.3820000199826;696.2237105627189;561.5283162143819;602.3735315272068;603.507513967321;610.1701685707434;616.1189499016449;8188.631511581993;8526.190011948855;8561.871571926426;8580.613872375634;8801.955990220136;548.1038502049179;584.2930054633856;601.560860571785;606.7209083821404;636.2174525333866;3879.9612003880166;3923.195744872294;3936.805473168047;3990.102226998902;4142.440770495945;78668;101237;103041;103509.48245258725;103836.48081759542;84201;87236.12763872407;88427;89726;90775;76521;76642.6167869157;77491.22508774952;78036.60981695056;78914.60542697365;7477.850442991218;7537.397008239437;8514.191151840565;8621.180987806149;8725.258353040063;50994;51141.977160457325;51442.74278628583;52206;53134.73432632812;50749;65037.02444463242;65496;67059.32940670726;67425.66287168533;10982.95661912117;11180.608678696206;11206.159538034517;11332;11548.036833738453;12083.818742718691;12157.81763273534;12209.145359824726;12282.631521054383;12628.621141365773;11516.827247591125;11717.707057323634;11801.114916381133;11851.940740296242;11910.285382877055;10714.678559643224;11330.093592512743;11368.204225704452;12056.336901470504;12210.084243681582;11098.667039988813;11135.33188008722;11330.830037549607;11564;11593.768124637629;9495.335326527076;9656.517174141125;9802.068803463659;9863.260255481011;10198.388096714221;9806.411615303105;9857.65498207588;9859.852102218616;9869.407835529892;9962.402255864672 19:41:49 INFO - PROCESS | 1981 | __end_tp_report 19:41:49 INFO - PROCESS | 1981 | __start_cc_report 19:41:49 INFO - PROCESS | 1981 | _x_x_mozilla_cycle_collect,359 19:41:49 INFO - PROCESS | 1981 | __end_cc_report 19:41:49 INFO - PROCESS | 1981 | __startTimestamp1457923309812__endTimestamp 19:41:49 INFO - PROCESS | 1981 | 19:41:49 INFO - PROCESS | 1981 | ------- Summary: start ------- 19:41:49 INFO - PROCESS | 1981 | Number of tests: 6 19:41:49 INFO - PROCESS | 1981 | 19:41:49 INFO - PROCESS | 1981 | [#0] dojo.html Cycles:165 Average:5800.03 Median:6118.16 stddev:680.20 (11.1%) stddev-sans-first:657.65 19:41:49 INFO - PROCESS | 1981 | Values: 3488.0 3528.5 3580.3 3588.8 3600.9 4725.8 5809.8 5830.2 5864.7 5866.0 4916.8 5696.5 5812.7 5844.6 5854.2 5279.0 5286.2 5339.7 5377.2 5442.5 4387.3 5239.6 5373.4 5390.9 5397.5 4344.3 5347.1 5445.5 5484.6 5489.9 5395.4 5413.8 5431.1 5433.5 5434.3 5217.3 5248.7 5346.8 5382.6 5413.1 4936.9 5129.4 5611.2 5753.9 5781.3 6197.7 6200.4 6251.9 6280.0 6280.6 6187.3 6272.7 6292.1 6313.7 6325.1 5961.2 6049.8 6054.0 6054.2 6090.3 6434.2 6491.1 6499.8 6510.4 6525.9 6171.3 6171.4 6227.2 6259.5 6292.0 6292.7 6311.0 6311.1 6337.7 6339.8 6188.4 6242.1 6266.4 6270.4 6287.1 6151.9 6191.1 6214.1 6263.0 6270.8 3820.3 5007.7 5009.9 5018.8 5055.9 4484.3 4496.8 4507.9 4530.2 4534.9 4890.9 5149.4 5902.5 5909.1 5934.8 5343.8 6091.8 6240.9 6266.1 6274.1 5931.7 5979.3 5983.3 5998.2 6005.9 5349.4 5410.7 5478.2 5483.5 5527.0 6518.9 6562.6 6599.3 6599.5 6620.8 6156.8 6307.4 6330.0 6338.7 6341.4 6228.6 6506.2 6511.5 6564.0 6604.5 6176.6 6177.1 6182.7 6185.8 6206.1 5242.3 5403.3 6118.2 6273.5 6282.6 6137.6 6182.0 6198.3 6233.9 6264.3 6192.9 6229.6 6251.6 6280.8 6305.1 5657.5 6045.7 6157.6 6160.6 6163.5 6176.2 6239.1 6273.3 6278.2 6289.6 6118.1 6124.9 6152.8 6167.1 6176.7 19:41:49 INFO - PROCESS | 1981 | 19:41:49 INFO - PROCESS | 1981 | [#1] ext.html Cycles:180 Average:69770.52 Median:39297.61 stddev:145041.02 (369.1%) stddev-sans-first:145354.84 19:41:49 INFO - PROCESS | 1981 | Values: 570.2 574.7 577.8 611.0 669.7 39278.4 40022.0 40198.0 40273.2 40278.6 39219.4 39684.4 40020.8 41964.8 42669.0 9507.7 9713.9 9730.9 9740.0 9754.9 9392.9 9623.1 9642.4 9670.0 9695.0 9640.3 9656.0 9681.4 9721.7 9732.2 9593.0 9655.3 9675.5 9676.1 9705.5 9684.4 9772.6 9802.3 9811.2 9846.0 38476.0 38711.6 38718.4 38801.2 38820.8 3373.5 3397.9 3493.7 3542.8 3568.4 27120.5 29509.6 29585.0 29863.4 29900.4 2798.7 2807.7 2818.0 2836.9 2843.7 523159.0 532569.0 537095.0 537687.0 537857.3 75931.0 76199.0 76234.2 76281.0 76649.6 80134.6 80380.6 80738.6 80881.2 80977.6 18209.7 18386.4 18498.8 18500.4 18543.1 13630.5 13637.8 13686.2 13714.7 13758.5 18493.0 23034.8 23220.8 23425.4 24224.3 7834.6 8202.8 9920.9 9952.8 10002.0 858.6 978.9 1068.7 1148.8 1183.6 30259.0 30679.2 30844.7 30970.4 31762.4 1071.3 1190.5 1224.9 1268.8 1276.2 13613.5 14013.0 15810.6 15907.4 16089.7 563269.0 565466.0 568820.0 569448.0 571699.1 47948.0 53867.7 62986.1 63928.0 64068.0 1498.6 1515.2 1535.5 1537.5 1540.1 25248.6 26686.9 30024.5 30441.8 31188.7 56000.2 56159.0 56540.4 56705.4 56775.7 529196.0 531547.0 531857.0 532651.0 534740.0 35166.0 35741.8 35981.3 36373.6 36403.8 47366.0 47493.8 48442.3 48746.5 49539.5 38814.8 39203.6 39537.0 39732.8 40573.0 31329.7 37250.3 38724.6 39042.2 39316.8 38164.0 38989.4 39195.6 39213.8 39549.4 32688.5 33968.0 34221.3 34368.7 34601.0 25972.9 26207.7 26290.9 26431.9 26564.9 19:41:49 INFO - PROCESS | 1981 | 19:41:49 INFO - PROCESS | 1981 | [#2] jquery.html Cycles:180 Average:36773.23 Median:11504.24 stddev:101823.24 (885.1%) stddev-sans-first:102072.22 19:41:49 INFO - PROCESS | 1981 | Values: 382.4 387.7 388.9 390.5 394.6 16589.7 19175.6 20097.5 21208.9 21230.2 20052.3 20360.6 20597.0 20603.6 20704.7 5139.5 5661.7 5955.7 5958.9 5964.8 4414.2 6342.9 6547.3 6578.7 6583.5 5515.4 6495.4 6521.3 6534.5 7303.6 6284.5 6361.6 6473.3 7654.5 7745.3 6111.8 7346.9 7357.2 7361.1 7369.0 26626.9 26769.3 26941.7 27359.7 27585.0 2113.0 2437.8 2508.1 2687.0 2966.8 12367.3 12946.0 15042.9 15553.4 15889.7 1779.5 1815.5 1823.7 1849.1 1868.1 120058.8 122267.4 128104.1 133428.0 133856.0 19691.4 20582.5 20713.0 20812.9 20817.4 30313.5 31185.5 31466.2 31475.0 31493.1 11724.5 11734.6 11769.1 11775.4 11810.8 9763.5 9774.6 9861.5 9907.8 10101.6 7510.9 9080.3 9253.6 9299.7 9312.8 1678.9 1907.9 1998.7 2004.9 2011.4 894.4 921.7 1006.2 1114.5 1115.8 20470.1 20895.5 21136.6 21288.1 21460.6 1012.5 1016.8 1047.6 1075.1 1135.8 10860.3 11332.7 11425.4 11429.6 11453.9 564737.0 579306.0 584439.0 584749.0 722519.0 127538.0 130883.0 133150.0 136194.6 139560.3 1062.9 1089.1 1105.8 1106.3 1110.9 17630.9 17736.7 17931.6 18065.7 18369.4 31035.0 50516.0 51520.2 53206.0 53357.2 74187.0 77505.6 77572.6 77732.0 78284.0 7857.1 8139.8 8296.0 8407.3 8506.9 12174.0 13522.3 13642.2 13669.5 13798.9 11677.8 11706.1 11774.2 12029.4 12276.0 8008.7 11180.8 11629.8 11639.9 11643.8 5738.7 6880.7 11722.9 11942.8 12306.0 8317.8 8412.4 8447.7 8514.9 8532.7 11289.4 12002.8 12156.8 12203.6 12212.0 19:41:49 INFO - PROCESS | 1981 | 19:41:49 INFO - PROCESS | 1981 | [#3] mootools.html Cycles:180 Average:6413.94 Median:5241.15 stddev:3451.46 (65.9%) stddev-sans-first:3442.03 19:41:49 INFO - PROCESS | 1981 | Values: 1581.0 1626.6 1641.0 1715.8 2025.2 8455.7 9079.0 9418.3 9587.7 9646.5 9265.1 9317.2 9415.8 9417.0 9433.3 2193.7 2614.0 2614.1 2614.4 2615.7 2523.1 2588.8 2592.6 2595.9 2607.7 2591.3 2593.6 2606.4 2642.9 2646.4 2181.6 2561.9 2596.4 2600.4 2605.2 2017.9 2554.9 2562.2 2580.1 2586.4 9490.1 9500.1 9557.5 9571.0 9611.0 4880.8 5846.5 5867.6 5937.8 5985.2 3675.0 3724.4 3726.9 3839.2 3842.4 1059.6 1072.9 1083.8 1086.6 1092.0 12682.2 12755.4 12794.8 12817.3 12837.3 5137.2 5148.5 5254.3 5278.7 5287.2 10854.3 10859.0 10865.4 10896.6 10897.3 5736.6 5757.7 5762.3 5802.4 5821.7 4637.1 5047.0 5169.3 5182.5 5228.0 4192.4 4235.3 4254.6 4257.4 4301.7 1206.6 1370.5 1408.3 1414.8 1418.1 1160.2 1184.3 1188.8 1404.4 1469.2 8698.0 8797.7 8870.4 8875.2 8908.8 533.3 540.3 541.1 545.2 550.2 6460.8 6462.3 6480.1 6482.7 6509.0 11213.3 11588.9 11590.6 11712.8 11749.4 11144.3 11262.9 11314.5 11415.9 11508.6 8716.6 8805.0 8825.8 8852.0 8909.0 8162.9 8258.5 8338.5 8448.7 8458.5 9957.7 9985.0 10143.2 10227.5 10270.8 10192.8 10342.1 10410.7 10613.4 10648.7 7131.3 7583.9 7747.6 7812.3 7990.8 8566.6 8623.2 8646.3 8646.4 8675.0 7531.0 7698.5 7761.7 7793.9 7893.4 7454.2 7543.3 7550.1 7626.7 7644.8 8114.4 8123.0 8175.1 8191.6 8199.5 7298.7 7408.7 7452.9 7485.5 7507.0 7502.6 7539.2 7552.5 7585.8 7588.2 19:41:49 INFO - PROCESS | 1981 | 19:41:49 INFO - PROCESS | 1981 | [#4] prototype.html Cycles:180 Average:6038.97 Median:6895.14 stddev:1932.72 (28.0%) stddev-sans-first:1890.14 19:41:49 INFO - PROCESS | 1981 | Values: 335.6 339.7 340.5 347.3 347.7 6354.4 6963.9 6965.5 7034.0 7039.9 5565.4 5957.7 6971.5 6980.9 7007.2 4790.7 4867.0 4943.6 5130.2 5187.8 5110.2 5119.4 5123.5 5141.2 5158.6 4389.6 4626.1 5055.8 5072.1 5177.3 5146.7 5156.4 5167.9 5178.2 5202.9 4421.9 4444.3 4444.5 4446.9 4451.1 6487.9 6547.5 6657.4 6662.5 6678.7 4848.5 5961.3 5971.5 6021.6 6039.6 7395.3 7408.7 7411.1 7419.6 7429.9 4919.0 4933.0 4943.7 4945.6 4952.9 7102.6 7870.4 7888.9 7901.2 7904.5 4890.4 4963.2 4964.2 4972.4 4973.3 5046.0 5056.9 5057.9 5066.0 5066.9 4954.6 5924.1 5944.6 5947.5 6031.5 7404.5 7414.0 7425.5 7449.0 7455.2 1692.7 1737.8 1754.8 1760.5 1787.5 1084.8 1088.2 1165.2 1180.7 1187.9 5272.0 6220.1 6851.6 6952.3 6954.8 6405.4 7237.5 7254.4 7666.9 7685.4 5505.8 6938.7 6965.4 6968.2 7001.9 3720.1 4034.7 4071.4 4091.8 4102.2 7889.1 7981.7 7998.5 8003.4 8031.3 7901.2 7928.4 7994.5 8036.3 8050.0 6354.8 8100.8 8102.9 8117.6 8128.5 7472.9 7724.2 7728.0 7746.6 7813.2 7549.4 7586.7 7588.6 7595.6 7597.0 8090.9 8104.7 8107.4 8181.1 8347.6 5030.3 5036.8 5037.4 5047.7 5061.1 7341.3 7703.7 7721.5 7728.6 7774.9 7355.2 7407.8 7415.7 7424.4 7449.0 7418.5 7433.6 7434.7 7437.8 7442.6 5493.9 6590.2 7203.2 7215.4 7226.5 7420.8 7432.9 7450.5 7461.4 7480.8 7247.9 7262.2 7264.9 7266.8 7285.0 19:41:49 INFO - PROCESS | 1981 | 19:41:49 INFO - PROCESS | 1981 | [#5] yui.html Cycles:180 Average:19057.65 Median:27445.72 stddev:27516.12 (100.3%) stddev-sans-first:27558.90 19:41:49 INFO - PROCESS | 1981 | Values: 732.0 770.3 771.4 776.2 786.2 13221.9 13597.6 14011.8 14291.9 14721.8 10287.6 10807.8 11117.5 11956.5 12048.3 760.7 953.5 977.4 980.7 981.3 977.1 977.9 984.2 984.9 990.6 1018.5 1038.6 1040.6 1040.8 1042.7 1017.1 1022.2 1029.9 1030.9 1031.7 750.0 767.2 767.4 771.0 776.7 14978.9 15013.0 15055.1 15326.6 15452.4 12961.2 13042.6 13055.5 13221.8 13239.5 10064.7 10289.5 10315.7 10317.3 10395.2 3556.2 3565.1 3565.3 3618.4 3623.3 83576.6 86423.7 86511.0 86642.6 86803.6 9605.3 9775.2 9818.1 9850.5 10028.5 22688.9 23150.0 23150.1 23187.4 23202.4 7461.8 7523.8 7537.9 7546.5 7552.6 3892.2 3965.6 4059.5 4069.9 4077.3 3768.4 3799.4 3818.9 3832.2 3841.9 677.1 680.5 686.5 694.4 696.2 561.5 602.4 603.5 610.2 616.1 8188.6 8526.2 8561.9 8580.6 8802.0 548.1 584.3 601.6 606.7 636.2 3880.0 3923.2 3936.8 3990.1 4142.4 78668.0 101237.0 103041.0 103509.5 103836.5 84201.0 87236.1 88427.0 89726.0 90775.0 76521.0 76642.6 77491.2 78036.6 78914.6 7477.9 7537.4 8514.2 8621.2 8725.3 50994.0 51142.0 51442.7 52206.0 53134.7 50749.0 65037.0 65496.0 67059.3 67425.7 10983.0 11180.6 11206.2 11332.0 11548.0 12083.8 12157.8 12209.1 12282.6 12628.6 11516.8 11717.7 11801.1 11851.9 11910.3 10714.7 11330.1 11368.2 12056.3 12210.1 11098.7 11135.3 11330.8 11564.0 11593.8 9495.3 9656.5 9802.1 9863.3 10198.4 9806.4 9857.7 9859.9 9869.4 9962.4 19:41:49 INFO - PROCESS | 1981 | -------- Summary: end -------- 19:41:49 INFO - PROCESS | 1981 | 19:41:50 INFO - TEST-INFO | 1981: exit 0 19:41:50 INFO - TEST-OK | dromaeo_css | took 1110562ms 19:41:50 INFO - TEST-START | kraken 19:41:50 INFO - operating with platform_type : mac_ 19:41:50 INFO - Initialising browser for kraken test... 19:41:50 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpMx7DxD/profile http://localhost:51922/getInfo.html) 19:41:53 INFO - PROCESS | 1988 | __metrics Screen width/height:1600/1200 19:41:53 INFO - PROCESS | 1988 | colorDepth:24 19:41:53 INFO - PROCESS | 1988 | Browser inner width/height: 1024/689 19:41:53 INFO - PROCESS | 1988 | __metrics 19:41:53 ERROR - PROCESS | 1988 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:41:53 INFO - TEST-INFO | 1988: exit 0 19:41:53 INFO - Browser initialized. 19:41:53 INFO - Running cycle 1/1 for kraken test... 19:41:53 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpMx7DxD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:42:05 INFO - PROCESS | 1991 | RSS: Main: 219394048 19:42:05 INFO - PROCESS | 1991 | 19:42:08 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51922/tests/kraken/driver.html?testName=audio-beat-detection) 19:42:08 INFO - PROCESS | 1991 | RSS: Main: 233250816 19:42:08 INFO - PROCESS | 1991 | 19:42:11 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51922/tests/kraken/driver.html?testName=audio-dft) 19:42:12 INFO - PROCESS | 1991 | RSS: Main: 241119232 19:42:12 INFO - PROCESS | 1991 | 19:42:15 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51922/tests/kraken/driver.html?testName=audio-fft) 19:42:16 INFO - PROCESS | 1991 | RSS: Main: 244076544 19:42:16 INFO - PROCESS | 1991 | 19:42:17 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51922/tests/kraken/driver.html?testName=audio-oscillator) 19:42:18 INFO - PROCESS | 1991 | RSS: Main: 244613120 19:42:18 INFO - PROCESS | 1991 | 19:42:20 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51922/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:42:21 INFO - PROCESS | 1991 | RSS: Main: 245215232 19:42:21 INFO - PROCESS | 1991 | 19:42:23 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51922/tests/kraken/driver.html?testName=imaging-darkroom) 19:42:24 INFO - PROCESS | 1991 | RSS: Main: 247607296 19:42:24 INFO - PROCESS | 1991 | 19:42:27 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51922/tests/kraken/driver.html?testName=imaging-desaturate) 19:42:27 INFO - PROCESS | 1991 | RSS: Main: 247726080 19:42:27 INFO - PROCESS | 1991 | 19:42:30 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51922/tests/kraken/driver.html?testName=json-parse-financial) 19:42:31 INFO - PROCESS | 1991 | RSS: Main: 248209408 19:42:31 INFO - PROCESS | 1991 | 19:42:32 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51922/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:42:33 INFO - PROCESS | 1991 | RSS: Main: 246030336 19:42:33 INFO - PROCESS | 1991 | 19:42:35 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51922/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:42:36 INFO - PROCESS | 1991 | RSS: Main: 245985280 19:42:36 INFO - PROCESS | 1991 | 19:42:38 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51922/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:42:38 INFO - PROCESS | 1991 | RSS: Main: 246874112 19:42:38 INFO - PROCESS | 1991 | 19:42:41 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:42:41 INFO - PROCESS | 1991 | RSS: Main: 247783424 19:42:41 INFO - PROCESS | 1991 | 19:42:44 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:42:45 INFO - PROCESS | 1991 | RSS: Main: 247791616 19:42:45 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51922/tests/kraken/driver.html?testName=ai-astar) 19:42:46 INFO - PROCESS | 1991 | RSS: Main: 248893440 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | __start_tp_report 19:42:46 INFO - PROCESS | 1991 | _x_x_mozilla_page_load 19:42:46 INFO - PROCESS | 1991 | _x_x_mozilla_page_load_details 19:42:46 INFO - PROCESS | 1991 | |i|pagename|runs| 19:42:46 INFO - PROCESS | 1991 | |0;ai-astar;113;110;115;114;114;129;115;113;118;114 19:42:46 INFO - PROCESS | 1991 | |1;audio-beat-detection;146;119;147;144;119;139;138;121;157;154 19:42:46 INFO - PROCESS | 1991 | |2;audio-dft;200;192;273;278;201;204;191;194;196;197 19:42:46 INFO - PROCESS | 1991 | |3;audio-fft;71;68;74;109;57;56;56;59;116;58 19:42:46 INFO - PROCESS | 1991 | |4;audio-oscillator;83;79;124;78;82;82;118;80;80;118 19:42:46 INFO - PROCESS | 1991 | |5;imaging-gaussian-blur;91;87;88;87;123;100;91;87;88;86 19:42:46 INFO - PROCESS | 1991 | |6;imaging-darkroom;94;97;94;105;96;95;94;96;96;138 19:42:46 INFO - PROCESS | 1991 | |7;imaging-desaturate;91;93;99;140;91;92;92;96;106;127 19:42:46 INFO - PROCESS | 1991 | |8;json-parse-financial;53;60;59;57;58;60;59;68;56;53 19:42:46 INFO - PROCESS | 1991 | |9;json-stringify-tinderbox;66;66;72;65;74;96;93;89;71;67 19:42:46 INFO - PROCESS | 1991 | |10;stanford-crypto-aes;83;81;82;84;82;82;83;79;83;87 19:42:46 INFO - PROCESS | 1991 | |11;stanford-crypto-ccm;127;112;139;144;102;131;130;111;127;138 19:42:46 INFO - PROCESS | 1991 | |12;stanford-crypto-pbkdf2;139;141;171;139;132;132;130;159;124;146 19:42:46 INFO - PROCESS | 1991 | |13;stanford-crypto-sha256-iterative;66;77;68;66;67;66;66;65;68;66 19:42:46 INFO - PROCESS | 1991 | __end_tp_report 19:42:46 INFO - PROCESS | 1991 | __start_cc_report 19:42:46 INFO - PROCESS | 1991 | _x_x_mozilla_cycle_collect,915 19:42:46 INFO - PROCESS | 1991 | __end_cc_report 19:42:46 INFO - PROCESS | 1991 | __startTimestamp1457923366976__endTimestamp 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | ------- Summary: start ------- 19:42:46 INFO - PROCESS | 1991 | Number of tests: 14 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#0] ai-astar Cycles:10 Average:115.50 Median:114.50 stddev:5.15 (4.5%) stddev-sans-first:5.38 19:42:46 INFO - PROCESS | 1991 | Values: 113.0 110.0 115.0 114.0 114.0 129.0 115.0 113.0 118.0 114.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:145.00 stddev:14.18 (9.8%) stddev-sans-first:14.77 19:42:46 INFO - PROCESS | 1991 | Values: 146.0 119.0 147.0 144.0 119.0 139.0 138.0 121.0 157.0 154.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#2] audio-dft Cycles:10 Average:212.60 Median:200.50 stddev:33.41 (16.7%) stddev-sans-first:35.13 19:42:46 INFO - PROCESS | 1991 | Values: 200.0 192.0 273.0 278.0 201.0 204.0 191.0 194.0 196.0 197.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#3] audio-fft Cycles:10 Average:72.40 Median:58.50 stddev:22.18 (37.9%) stddev-sans-first:23.52 19:42:46 INFO - PROCESS | 1991 | Values: 71.0 68.0 74.0 109.0 57.0 56.0 56.0 59.0 116.0 58.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:80.00 stddev:19.17 (24.0%) stddev-sans-first:20.03 19:42:46 INFO - PROCESS | 1991 | Values: 83.0 79.0 124.0 78.0 82.0 82.0 118.0 80.0 80.0 118.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:87.50 stddev:11.37 (13.0%) stddev-sans-first:12.04 19:42:46 INFO - PROCESS | 1991 | Values: 91.0 87.0 88.0 87.0 123.0 100.0 91.0 87.0 88.0 86.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:95.50 stddev:13.57 (14.2%) stddev-sans-first:14.18 19:42:46 INFO - PROCESS | 1991 | Values: 94.0 97.0 94.0 105.0 96.0 95.0 94.0 96.0 96.0 138.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#7] imaging-desaturate Cycles:10 Average:102.70 Median:92.00 stddev:17.15 (18.6%) stddev-sans-first:17.66 19:42:46 INFO - PROCESS | 1991 | Values: 91.0 93.0 99.0 140.0 91.0 92.0 92.0 96.0 106.0 127.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:59.00 stddev:4.27 (7.2%) stddev-sans-first:4.08 19:42:46 INFO - PROCESS | 1991 | Values: 53.0 60.0 59.0 57.0 58.0 60.0 59.0 68.0 56.0 53.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#9] json-stringify-tinderbox Cycles:10 Average:75.90 Median:73.00 stddev:12.04 (16.5%) stddev-sans-first:12.23 19:42:46 INFO - PROCESS | 1991 | Values: 66.0 66.0 72.0 65.0 74.0 96.0 93.0 89.0 71.0 67.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:2.07 (2.5%) stddev-sans-first:2.19 19:42:46 INFO - PROCESS | 1991 | Values: 83.0 81.0 82.0 84.0 82.0 82.0 83.0 79.0 83.0 87.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:130.50 stddev:13.65 (10.5%) stddev-sans-first:14.47 19:42:46 INFO - PROCESS | 1991 | Values: 127.0 112.0 139.0 144.0 102.0 131.0 130.0 111.0 127.0 138.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:140.00 stddev:14.25 (10.2%) stddev-sans-first:15.09 19:42:46 INFO - PROCESS | 1991 | Values: 139.0 141.0 171.0 139.0 132.0 132.0 130.0 159.0 124.0 146.0 19:42:46 INFO - PROCESS | 1991 | 19:42:46 INFO - PROCESS | 1991 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:66.50 stddev:3.47 (5.2%) stddev-sans-first:3.64 19:42:46 INFO - PROCESS | 1991 | Values: 66.0 77.0 68.0 66.0 67.0 66.0 66.0 65.0 68.0 66.0 19:42:46 INFO - PROCESS | 1991 | -------- Summary: end -------- 19:42:46 INFO - PROCESS | 1991 | 19:42:47 INFO - TEST-INFO | 1991: exit 0 19:42:47 INFO - TEST-OK | kraken | took 57421ms 19:42:47 INFO - SUITE-END | took 1167s 19:42:48 INFO - Completed test suite (00:19:28) 19:42:48 INFO - javascript benchmark 19:42:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3487.9536139158254, 3528.4707293905913, 3580.319739249541, 3588.802615856127, 3600.945985810215, 4725.799854345202, 5809.796657117002, 5830.154627578999, 5864.706764661766, 5866.0, 4916.80332786689, 5696.458836410535, 5812.709364531777, 5844.649321040741, 5854.151148083536, 5278.973605131969, 5286.207068939651, 5339.652922560041, 5377.247185394048, 5442.482964118402, 4387.2541667916375, 5239.580833533328, 5373.435789242132, 5390.8921821563545, 5397.514223719864, 4344.283193273122, 5347.0909945309195, 5445.455454454563, 5484.588655850807, 5489.862753431156, 5395.352557693062, 5413.810516631918, 5431.103867861798, 5433.4566543345745, 5434.2935418395355, 5217.2695822584865, 5248.71132087735, 5346.759395827197, 5382.6232163748555, 5413.079776438015, 4936.925946110775, 5129.435762066169, 5611.2144299798065, 5753.88492230153, 5781.335146458169, 6197.721102550396, 6200.379962003809, 6251.937480625181, 6280.0, 6280.591761535531, 6187.288461826857, 6272.717727702265, 6292.087647291117, 6313.652749098797, 6325.082862984841, 5961.195238642815, 6049.8487537811025, 6054.031354983225, 6054.152418661391, 6090.299615544181, 6434.233741706164, 6491.091247225392, 6499.772507962293, 6510.381513756186, 6525.902111468332, 6171.321154672983, 6171.413715697002, 6227.159333490012, 6259.4679452246155, 6291.9685401573615, 6292.653904035322, 6311.0217916223055, 6311.116443697886, 6337.683115844189, 6339.809805705836, 6188.350223226586, 6242.1261023455845, 6266.436020758154, 6270.435660790551, 6287.056941458726, 6151.9384806151365, 6191.133241346215, 6214.067889816563, 6262.968685156637, 6270.7805226816845, 3820.2741479118877, 5007.724575148329, 5009.949900500948, 5018.824341148043, 5055.949440505621, 4484.264598594855, 4496.775161241925, 4507.88730281739, 4530.207213737583, 4534.911621210886, 4890.877728056756, 5149.433562308143, 5902.468777810018, 5909.054551271776, 5934.821955341346, 5343.812966546152, 6091.786787462417, 6240.937590624127, 6266.060090986389, 6274.058891166362, 5931.673757943355, 5979.342272350038, 5983.311919129269, 5998.190244316961, 6005.879882402328, 5349.438308977579, 5410.675359478444, 5478.233047373371, 5483.533899618577, 5527.032769265443, 6518.860692703607, 6562.606243625398, 6599.307072757291, 6599.53803233769, 6620.768273110418, 6156.846078848064, 6307.432331090224, 6329.968350158219, 6338.746450141943, 6341.365863413622, 6228.56400051992, 6506.219253689587, 6511.511636627367, 6563.967180164069, 6604.537682362188, 6176.629402235881, 6177.073438984188, 6182.69086545662, 6185.84535386619, 6206.138158552507, 5242.275578801421, 5403.270558474713, 6118.162361256354, 6273.498120150468, 6282.560220784501, 6137.622145770902, 6181.979973304355, 6198.256209254918, 6233.937660623335, 6264.310925798068, 6192.876142477216, 6229.626222426669, 6251.593646412968, 6280.780172693934, 6305.1172835803945, 5657.4908258256955, 6045.727942242697, 6157.568970172045, 6160.599561028519, 6163.476104531165, 6176.197094377702, 6239.0953311768635, 6273.309935906956, 6278.183836101278, 6289.622622642656, 6118.051701986199, 6124.908126378197, 6152.846178845386, 6167.105769663463, 6176.66028368444], "unit": "score", "name": "dojo.html", "value": 5759.24498075226}, {"lowerIsBetter": false, "replicates": [570.2216474512289, 574.6753084507253, 577.7688924430224, 610.9663968481733, 669.6651674162919, 39278.41082383763, 40022.0, 40198.0, 40273.19453610926, 40278.59721402785, 39219.41170882439, 39684.40473392894, 40020.799376018695, 41964.79017604908, 42669.0, 9507.71476855692, 9713.854292185622, 9730.902690973071, 9739.977302383253, 9754.853677194847, 9392.906070939305, 9623.133917947383, 9642.373245739005, 9669.95165024174, 9695.030496950283, 9640.276979226552, 9655.951720241424, 9681.419114853095, 9721.736174297332, 9732.2214222862, 9593.0, 9655.275854310885, 9675.516224188763, 9676.129148376645, 9705.514724263794, 9684.353659877837, 9772.560234789451, 9802.313838031341, 9811.166050885684, 9846.0, 38476.0, 38711.61288387108, 38718.419223711666, 38801.22397552062, 38820.805895970625, 3373.4939759036097, 3397.9490307645406, 3493.650634936486, 3542.769719968194, 3568.411212150018, 27120.45759084827, 29509.557356639452, 29584.964526241478, 29863.402731945458, 29900.401991960258, 2798.678152012524, 2807.7332653397893, 2818.0, 2836.9007084751934, 2843.6587609486787, 523159.0, 532569.0, 537095.0, 537687.0, 537857.3107134479, 75931.0, 76199.0, 76234.23765762382, 76281.0, 76649.61675191588, 80134.59932700415, 80380.59809701031, 80738.59630701809, 80881.19118808855, 80977.59511202406, 18209.7268540972, 18386.448406547825, 18498.81501184971, 18500.444986650422, 18543.072846357627, 13630.454781808616, 13637.795433068512, 13686.247256400795, 13714.657133571542, 13758.518451854337, 18493.0, 23034.848257587055, 23220.7677923222, 23425.41436464102, 24224.273271801874, 7834.569098699512, 8202.794930126794, 9920.851187232198, 9952.751181220527, 10002.0, 858.553552152877, 978.8531720241879, 1068.71144790906, 1148.8391625172483, 1183.5679976808576, 30258.99309219029, 30679.2330191747, 30844.691553084183, 30970.380592388025, 31762.364752704816, 1071.287593750163, 1190.458341454636, 1224.8530176378893, 1268.8033354829831, 1276.1513593460431, 13613.455461781417, 14013.0, 15810.60473488149, 15907.443239486794, 16089.678206435805, 563269.0, 565466.0, 568820.0, 569448.0, 571699.1415042898, 47948.0, 53867.730661347225, 62986.110416687574, 63928.041079383845, 64068.0, 1498.5654160293393, 1515.212089713343, 1535.4625880941805, 1537.4618883390947, 1540.0836502281124, 25248.62127068132, 26686.86656566705, 30024.498775061595, 30441.84779076179, 31188.68811311858, 56000.15999760088, 56159.0, 56540.43459565352, 56705.432945670014, 56775.71612141913, 529196.0, 531547.0, 531857.0, 532651.0, 534740.0, 35166.0, 35741.82129089338, 35981.28037439289, 36373.636263637025, 36403.817980909924, 47366.0, 47493.76253118712, 48442.273365898836, 48746.53760387194, 49539.51381458562, 38814.80592597019, 39203.62787302545, 39537.011574710865, 39732.801335993136, 40573.0, 31329.686703132676, 37250.25499490049, 38724.6127538721, 39042.21915561616, 39316.80341598274, 38164.0, 38989.41515877208, 39195.608043919194, 39213.8039309813, 39549.40675889922, 32688.50967235541, 33968.0, 34221.31557368789, 34368.65631343654, 34600.9619711409, 25972.870135649202, 26207.73792262129, 26290.948362065305, 26431.867840660674, 26564.937402503685], "unit": "score", "name": "ext.html", "value": 20946.330446031374}, {"lowerIsBetter": false, "replicates": [382.40345061703727, 387.6995328620319, 388.947492088568, 390.48846011724623, 394.63693402070095, 16589.66820663586, 19175.61648767024, 20097.49268804838, 21208.939553022363, 21230.15079396824, 20052.29816956403, 20360.592788144266, 20597.0, 20603.587928241424, 20704.689429658567, 5139.486051394868, 5661.745221465023, 5955.70221488926, 5958.910616340759, 5964.821055368346, 4414.22751018572, 6342.904856427157, 6547.345265473438, 6578.703958321863, 6583.539152259344, 5515.448455154473, 6495.382938620847, 6521.347865213488, 6534.509911756613, 7303.598302093383, 6284.497240220771, 6361.6183029018175, 6473.255575608819, 7654.464187506876, 7745.264199901, 6111.755529778803, 7346.889796653055, 7357.153927298322, 7361.079865016873, 7368.963155184243, 26626.93492260307, 26769.330766730793, 26941.73058269412, 27359.726402736116, 27585.0, 2113.0, 2437.770468237606, 2508.059477695864, 2687.0192379781433, 2966.821990680566, 12367.319797411139, 12945.96432285415, 15042.924785376112, 15553.377864885391, 15889.682206355808, 1779.5373202967191, 1815.5370380553006, 1823.6535058338873, 1849.1031849552955, 1868.0753027251596, 120058.79941200564, 122267.388663057, 128104.07843882349, 133428.0, 133856.0, 19691.40925772229, 20582.485437864172, 20713.0, 20812.895935520224, 20817.375478735663, 30313.545296820565, 31185.532217016764, 31466.213344666565, 31475.0, 31493.055208343787, 11724.531018759155, 11734.647960561197, 11769.117316201318, 11775.442285850264, 11810.822837657443, 9763.463009534544, 9774.609015639295, 9861.457619830979, 9907.80184396308, 10101.595936162617, 7510.9484672145945, 9080.31897607682, 9253.629854805733, 9299.72100836976, 9312.813743725088, 1678.9496315110566, 1907.8950657713958, 1998.6702194138095, 2004.8997550122435, 2011.3865271092166, 894.4230971023784, 921.6958403726754, 1006.2101250518308, 1114.4873358255131, 1115.7824224276187, 20470.078846451946, 20895.477613059797, 21136.577268454854, 21288.148474060865, 21460.57078858414, 1012.549415510091, 1016.832222683249, 1047.61238341814, 1075.1345167140528, 1135.7501349703052, 10860.294080884718, 11332.660020199408, 11425.371604561662, 11429.59996400122, 11453.885461145448, 564737.0, 579306.0, 584439.0, 584749.0, 722519.0, 127538.0, 130883.0, 133150.0, 136194.63805362018, 139560.30219848835, 1062.888396718349, 1089.128697042363, 1105.7512059786645, 1106.3030290916831, 1110.8889111088988, 17630.94214347092, 17736.733948990517, 17931.641367172844, 18065.72901406454, 18369.448916532525, 31035.0, 50516.0, 51520.22719659283, 53206.0, 53357.19964200618, 74187.0, 77505.61247193727, 77572.61213693896, 77732.0, 78284.0, 7857.096433910174, 8139.837203255784, 8296.0, 8407.265315909255, 8506.872396913928, 12174.0, 13522.323883805968, 13642.181469111885, 13669.521566745116, 13798.862011379757, 11677.824832627348, 11706.063514918957, 11774.175807693378, 12029.398530073637, 12275.956543693886, 8008.719694810887, 11180.832287515856, 11629.76740465169, 11639.941800290944, 11643.825342619699, 5738.68437235956, 6880.69036893351, 11722.88277117252, 11942.820857686967, 12306.0, 8317.750467485985, 8412.411131220755, 8447.704330348653, 8514.914850851412, 8532.658693652184, 11289.37908415045, 12002.819957700467, 12156.75686486283, 12203.572874949334, 12212.0], "unit": "score", "name": "jquery.html", "value": 10678.861523616697}, {"lowerIsBetter": false, "replicates": [1580.9920950395247, 1626.5689592258054, 1641.0, 1715.7597936288914, 2025.159558783105, 8455.746327610166, 9079.046700096495, 9418.293627977904, 9587.712368628934, 9646.517674116292, 9265.073492650732, 9317.208037316836, 9415.764605884857, 9416.952915235432, 9433.339666223366, 2193.74771901231, 2613.986930065347, 2614.0720044384257, 2614.398688301692, 2615.725348838373, 2523.079076137206, 2588.7670109690125, 2592.5981472871736, 2595.896164153441, 2607.70011448683, 2591.300348905794, 2593.572060609997, 2606.387498937748, 2642.920712378632, 2646.3781011462293, 2181.6182168120595, 2561.871906404682, 2596.389848385628, 2600.4019075612528, 2605.2054123492326, 2017.9192832286692, 2554.9105781297753, 2562.2441379793004, 2580.148550978173, 2586.3534116470883, 9490.145886870216, 9500.144986951207, 9557.474338911357, 9571.042895710443, 9610.95194524023, 4880.780364883589, 5846.5322774178385, 5867.647941123546, 5937.762489500415, 5985.221921150222, 3674.9632503675157, 3724.3854763963914, 3726.850925962958, 3839.155385815144, 3842.385218365076, 1059.5602824827688, 1072.935623862563, 1083.7724077943642, 1086.5925278020743, 1091.9617813376574, 12682.175658582162, 12755.42600582976, 12794.808077878839, 12817.295048772314, 12837.293948832717, 5137.17805151174, 5148.485151484896, 5254.3169387979315, 5278.709670968057, 5287.154055351125, 10854.294470859526, 10859.0, 10865.40240286776, 10896.61861834832, 10897.346159230472, 5736.569757268222, 5757.740901659436, 5762.2509073820975, 5802.361740208574, 5821.650700957872, 4637.118947399983, 5047.0, 5169.327987361619, 5182.53357197854, 5227.9805437939995, 4192.392103145027, 4235.301175306102, 4254.617084462413, 4257.40396344512, 4301.65586753059, 1206.6018213989362, 1370.4792178972127, 1408.2747385096684, 1414.8231471066117, 1418.1491105336715, 1160.1762748448527, 1184.2657552317446, 1188.8395066666062, 1404.4382247101241, 1469.2286549561566, 8698.0, 8797.69208077727, 8870.379073464796, 8875.201231889161, 8908.777280567909, 533.2694208933708, 540.3434826685595, 541.1260813785708, 545.2148905576037, 550.2351731093783, 6460.806175814733, 6462.289148193695, 6480.125183100221, 6482.675866206765, 6509.02364645307, 11213.327200368005, 11588.94205528967, 11590.594329198437, 11712.824307635392, 11749.353785541707, 11144.275622084539, 11262.943685281685, 11314.547418103348, 11415.885841141648, 11508.59719909799, 8716.564171791386, 8805.0, 8825.823483530294, 8852.0, 8908.975467821154, 8162.877556836534, 8258.463199891989, 8338.541380224146, 8448.662053518035, 8458.534780587126, 9957.701268961942, 9984.950075249577, 10143.239257055899, 10227.539760710637, 10270.794584108426, 10192.796144077225, 10342.069213770797, 10410.73973150647, 10613.416262105658, 10648.733781655521, 7131.322524360177, 7583.886241706268, 7747.612619368896, 7812.296893279632, 7990.8002299940645, 8566.614502347535, 8623.180797824196, 8646.265067469336, 8646.43798153118, 8675.0, 7530.962345188239, 7698.499597526143, 7761.68953241864, 7793.883091753742, 7893.447458678067, 7454.180040195466, 7543.321101100927, 7550.093988721389, 7626.733064342721, 7644.847103058019, 8114.391420643594, 8122.959385203036, 8175.1007389188335, 8191.590420479071, 8199.467034642728, 7298.708051677873, 7408.703651853865, 7452.850942981218, 7485.47601667878, 7506.962465187639, 7502.624868756431, 7539.246075392417, 7552.509086909334, 7585.772426827204, 7588.203238660082], "unit": "score", "name": "mootools.html", "value": 5104.070558616214}, {"lowerIsBetter": false, "replicates": [335.5921907597629, 339.7248228934563, 340.4722679846238, 347.27766246207875, 347.65234765234766, 6354.428101470867, 6963.860722785541, 6965.5124141310125, 7034.0, 7039.929600703991, 5565.359983601887, 5957.731902064406, 6971.477139214554, 6980.860382792341, 7007.194172670144, 4790.658615587641, 4866.951330486685, 4943.604511639061, 5130.179171332587, 5187.766550505227, 5110.233464980264, 5119.360079990001, 5123.487651234884, 5141.177411614142, 5158.638895277332, 4389.561043895601, 4626.149540183937, 5055.797768089272, 5072.112380333445, 5177.275181474578, 5146.665466744668, 5156.432792392852, 5167.9224811627855, 5178.17149256121, 5202.921956170622, 4421.9115617687785, 4444.28891377378, 4444.533324000966, 4446.911061778746, 4451.132029254297, 6487.93512064878, 6547.476201903836, 6657.400833924921, 6662.533622646417, 6678.732850685967, 4848.539388758062, 5961.254843144607, 5971.462568368825, 6021.63870167787, 6039.63762174271, 7395.297446742551, 7408.7036518539735, 7411.147718012444, 7419.554826710415, 7429.9257007430315, 4918.975405122951, 4933.038057578774, 4943.703377797307, 4945.61522773624, 4952.90094198114, 7102.60935648534, 7870.370370370357, 7888.881666775003, 7901.170377110436, 7904.486208396494, 4890.364252647204, 4963.230699241623, 4964.180910149785, 4972.378452693413, 4973.303737476756, 5046.0, 5056.898862022739, 5057.8735531612, 5066.0, 5066.949330506722, 4954.628402869799, 5924.14099955504, 5944.64332140073, 5947.542852001201, 6031.517478601701, 7404.481686281909, 7414.0, 7425.480216384801, 7448.9627551861895, 7455.179930207672, 1692.6614677064636, 1737.7740893683992, 1754.7718796556621, 1760.515858139022, 1787.4816303272166, 1084.7505073833063, 1088.1892989722708, 1165.1901928160016, 1180.7107258721496, 1187.8990285825628, 5271.973640131775, 6220.129181914535, 6851.623160726108, 6952.270011648805, 6954.826129346807, 6405.391487808651, 7237.493375463667, 7254.419646428273, 7666.8849967250535, 7685.423593230418, 5505.834824955257, 6938.653067346612, 6965.373116419547, 6968.233494315621, 7001.894971575431, 3720.1443667956523, 4034.7377420467574, 4071.4096456013713, 4091.754494730326, 4102.179564087194, 7889.132195458495, 7981.72063977758, 7998.520088794691, 8003.359731221488, 8031.277185053374, 7901.209879012168, 7928.405369597303, 7994.5203287802915, 8036.276735093753, 8050.0, 6354.759072872868, 8100.756977290691, 8102.918970810334, 8117.594120293962, 8128.471649342774, 7472.8879066815125, 7724.150343462103, 7727.961360193163, 7746.612669366622, 7813.202963318355, 7549.358304544176, 7586.734464293944, 7588.582627955516, 7595.620218989139, 7596.962015189889, 8090.919090809017, 8104.675812967415, 8107.351411887153, 8181.059178194584, 8347.624356903832, 5030.346055012825, 5036.773345199402, 5037.445880953019, 5047.747612619428, 5061.063703214917, 7341.3392794648735, 7703.730369437043, 7721.536707797325, 7728.613569321624, 7774.922250777646, 7355.190928997913, 7407.777766667009, 7415.666295016845, 7424.443166762407, 7448.9627551861895, 7418.517796343436, 7433.628318584158, 7434.665440055102, 7437.8140546486775, 7442.62786860644, 5493.917591236055, 6590.176227971504, 7203.243659415686, 7215.386692131227, 7226.494145409771, 7420.777376678709, 7432.888506672296, 7450.515716478411, 7461.365783908429, 7480.812979675334, 7247.927520724937, 7262.237465066303, 7264.891026634499, 7266.781996540112, 7284.963575182091], "unit": "score", "name": "prototype.html", "value": 5398.986650314748}, {"lowerIsBetter": false, "replicates": [731.9670614822334, 770.3413581387913, 771.3983093187315, 776.1733753552463, 786.174516757405, 13221.867781322184, 13597.640235976398, 14011.789823152636, 14291.92854035731, 14721.779173312396, 10287.588496460132, 10807.75710793257, 11117.499712512936, 11956.521739130447, 12048.337341446238, 760.6805141840413, 953.5041778275292, 977.3549457358145, 980.6763767956558, 981.3425005246502, 977.0961860279214, 977.9168770654503, 984.1683777208283, 984.9015098490165, 990.6037584965999, 1018.5416562546884, 1038.6364772329662, 1040.5733649203828, 1040.8074506216374, 1042.6663467690341, 1017.1252722658545, 1022.2026819081092, 1029.9021592948732, 1030.8917563655857, 1031.6698656429946, 749.9550026998343, 767.1676231289058, 767.3592550220573, 771.032354395236, 776.747557043963, 14978.925105374403, 15013.0, 15055.096694198382, 15326.616834579114, 15452.381904723798, 12961.22232666043, 13042.608721738268, 13055.543055992996, 13221.801672974912, 13239.536616218385, 10064.69805905824, 10289.485525723683, 10315.742106447324, 10317.277790554665, 10395.16838652906, 3556.1643013891717, 3565.144365352297, 3565.3047655707146, 3618.421052631593, 3623.3296840084668, 83576.58211708903, 86423.70364444538, 86511.0, 86642.56678716629, 86803.56598216969, 9605.327627066039, 9775.217982561378, 9818.116369526633, 9850.50747462624, 10028.548715307828, 22688.88655556712, 23150.0, 23150.07399704027, 23187.420314492272, 23202.419939501648, 7461.813454663677, 7523.774286771406, 7537.924620753723, 7546.547207167478, 7552.622368881534, 3892.221555688817, 3965.6232657897453, 4059.512858456945, 4069.9389509157386, 4077.347624380085, 3768.3593789055926, 3799.411091280856, 3818.9497888081, 3832.1952389997855, 3841.8847434577006, 677.1434135818193, 680.53383432348, 686.4851361478891, 694.3820000199826, 696.2237105627189, 561.5283162143819, 602.3735315272068, 603.507513967321, 610.1701685707434, 616.1189499016449, 8188.631511581993, 8526.190011948855, 8561.871571926426, 8580.613872375634, 8801.955990220136, 548.1038502049179, 584.2930054633856, 601.560860571785, 606.7209083821404, 636.2174525333866, 3879.9612003880166, 3923.195744872294, 3936.805473168047, 3990.102226998902, 4142.440770495945, 78668.0, 101237.0, 103041.0, 103509.48245258725, 103836.48081759542, 84201.0, 87236.12763872407, 88427.0, 89726.0, 90775.0, 76521.0, 76642.6167869157, 77491.22508774952, 78036.60981695056, 78914.60542697365, 7477.850442991218, 7537.397008239437, 8514.191151840565, 8621.180987806149, 8725.258353040063, 50994.0, 51141.977160457325, 51442.74278628583, 52206.0, 53134.73432632812, 50749.0, 65037.02444463242, 65496.0, 67059.32940670726, 67425.66287168533, 10982.95661912117, 11180.608678696206, 11206.159538034517, 11332.0, 11548.036833738453, 12083.818742718691, 12157.81763273534, 12209.145359824726, 12282.631521054383, 12628.621141365773, 11516.827247591125, 11717.707057323634, 11801.114916381133, 11851.940740296242, 11910.285382877055, 10714.678559643224, 11330.093592512743, 11368.204225704452, 12056.336901470504, 12210.084243681582, 11098.667039988813, 11135.33188008722, 11330.830037549607, 11564.0, 11593.768124637629, 9495.335326527076, 9656.517174141125, 9802.068803463659, 9863.260255481011, 10198.388096714221, 9806.411615303105, 9857.65498207588, 9859.852102218616, 9869.407835529892, 9962.402255864672], "unit": "score", "name": "yui.html", "value": 7105.756468758828}], "name": "dromaeo_css", "value": 7948.994985118729}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 115.0, 114.0, 114.0, 129.0, 115.0, 113.0, 118.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [146.0, 119.0, 147.0, 144.0, 119.0, 139.0, 138.0, 121.0, 157.0, 154.0], "unit": "score", "name": "audio-beat-detection", "value": 138.4}, {"lowerIsBetter": true, "replicates": [200.0, 192.0, 273.0, 278.0, 201.0, 204.0, 191.0, 194.0, 196.0, 197.0], "unit": "score", "name": "audio-dft", "value": 212.6}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 74.0, 109.0, 57.0, 56.0, 56.0, 59.0, 116.0, 58.0], "unit": "score", "name": "audio-fft", "value": 72.4}, {"lowerIsBetter": true, "replicates": [83.0, 79.0, 124.0, 78.0, 82.0, 82.0, 118.0, 80.0, 80.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 92.4}, {"lowerIsBetter": true, "replicates": [91.0, 87.0, 88.0, 87.0, 123.0, 100.0, 91.0, 87.0, 88.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.8}, {"lowerIsBetter": true, "replicates": [94.0, 97.0, 94.0, 105.0, 96.0, 95.0, 94.0, 96.0, 96.0, 138.0], "unit": "score", "name": "imaging-darkroom", "value": 100.5}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 99.0, 140.0, 91.0, 92.0, 92.0, 96.0, 106.0, 127.0], "unit": "score", "name": "imaging-desaturate", "value": 102.7}, {"lowerIsBetter": true, "replicates": [53.0, 60.0, 59.0, 57.0, 58.0, 60.0, 59.0, 68.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 72.0, 65.0, 74.0, 96.0, 93.0, 89.0, 71.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 75.9}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 82.0, 84.0, 82.0, 82.0, 83.0, 79.0, 83.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [127.0, 112.0, 139.0, 144.0, 102.0, 131.0, 130.0, 111.0, 127.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [139.0, 141.0, 171.0, 139.0, 132.0, 132.0, 130.0, 159.0, 124.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [66.0, 77.0, 68.0, 66.0, 67.0, 66.0, 66.0, 65.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1478.9999999999998}]} 19:42:48 INFO - Return code: 0 19:42:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:42:48 ERROR - # TBPL SUCCESS # 19:42:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:42:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:42:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:42:48 INFO - 2016-03-13 19:42:48.307 screenresolution[1996:29801] starting screenresolution argv=screenresolution get 19:42:48 INFO - 2016-03-13 19:42:48.309 screenresolution[1996:29801] Display 0: 1600x1200x32@60 19:42:48 INFO - 2016-03-13 19:42:48.315 screenresolution[1997:29804] starting screenresolution argv=screenresolution list 19:42:48 INFO - Available Modes on Display 0 19:42:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:42:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:42:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:42:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:42:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:42:48 INFO - Intel Iris: 19:42:48 INFO - Chipset Model: Intel Iris 19:42:48 INFO - Type: GPU 19:42:48 INFO - Bus: Built-In 19:42:48 INFO - VRAM (Dynamic, Max): 1536 MB 19:42:48 INFO - Vendor: Intel (0x8086) 19:42:48 INFO - Device ID: 0x0a2e 19:42:48 INFO - Revision ID: 0x0009 19:42:48 INFO - Displays: 19:42:48 INFO - Display: 19:42:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:42:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:42:48 INFO - Display Serial Number: 1600x1200 60 19:42:48 INFO - Main Display: Yes 19:42:48 INFO - Mirror: Off 19:42:48 INFO - Online: Yes 19:42:48 INFO - Rotation: Supported 19:42:48 INFO - Return code: 0 19:42:48 INFO - Running post-action listener: _resource_record_post_action 19:42:48 INFO - Running post-run listener: _resource_record_post_run 19:42:49 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 503808; Write bytes: 667415552; Read time: 7; Write time: 1869 19:42:49 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 359981568; Write bytes: 355045888; Read time: 28148; Write time: 726 19:42:49 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 503808; Write bytes: 302244352; Read time: 7; Write time: 1114 19:42:49 INFO - Running post-run listener: _upload_blobber_files 19:42:49 INFO - Blob upload gear active. 19:42:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:42:49 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 19:42:49 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'] 19:42:49 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 19:42:50 INFO - (blobuploader) - INFO - Open directory for files ... 19:42:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:42:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:42:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:50 INFO - (blobuploader) - INFO - Done attempting. 19:42:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:42:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:42:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:51 INFO - (blobuploader) - INFO - Done attempting. 19:42:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:42:51 INFO - Return code: 0 19:42:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:42:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:42:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b67258b5d372c5693cd290eb08d1825cceeaae0910f61583f630b795985f0e5a797d422744b0b664e4578681c733344089adbee8f8c4517dbfdaa06fd10b72c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2282e6e801f5aaf387fbd6e5d60a68329280d01e1acb583d13c2ed48f17c2a8d66bdc74f53ad3d9f80453685abda1bb887ccbbcc042ae4001085c8983c17f2b"} 19:42:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:42:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:42:51 INFO - Contents: 19:42:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b67258b5d372c5693cd290eb08d1825cceeaae0910f61583f630b795985f0e5a797d422744b0b664e4578681c733344089adbee8f8c4517dbfdaa06fd10b72c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2282e6e801f5aaf387fbd6e5d60a68329280d01e1acb583d13c2ed48f17c2a8d66bdc74f53ad3d9f80453685abda1bb887ccbbcc042ae4001085c8983c17f2b"} 19:42:51 INFO - Running post-run listener: copy_logs_to_upload_dir 19:42:51 INFO - Copying logs to upload dir... 19:42:51 INFO - mkdir: /builds/slave/test/build/upload/logs 19:42:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.511509 ========= master_lag: 4.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-13 19:42:56.423037) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 19:42:56.424102) ========= 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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b67258b5d372c5693cd290eb08d1825cceeaae0910f61583f630b795985f0e5a797d422744b0b664e4578681c733344089adbee8f8c4517dbfdaa06fd10b72c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2282e6e801f5aaf387fbd6e5d60a68329280d01e1acb583d13c2ed48f17c2a8d66bdc74f53ad3d9f80453685abda1bb887ccbbcc042ae4001085c8983c17f2b"} build_url:https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011685 build_url: 'https://queue.taskcluster.net/v1/task/AWqD2XYFRtunrbQgiqpGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b67258b5d372c5693cd290eb08d1825cceeaae0910f61583f630b795985f0e5a797d422744b0b664e4578681c733344089adbee8f8c4517dbfdaa06fd10b72c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2282e6e801f5aaf387fbd6e5d60a68329280d01e1acb583d13c2ed48f17c2a8d66bdc74f53ad3d9f80453685abda1bb887ccbbcc042ae4001085c8983c17f2b"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 19:42:56.567839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-03-13 19:42:56.568176) ========= 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.aVfXKpcDV8/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.2QExHyA8Ng/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005184 ========= master_lag: 6.79 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-03-13 19:43:03.367673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 19:43:03.370043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 19:43:03.400633) ========= ========= Total master_lag: 18.77 =========