builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0033 starttime: 1446232899.6 results: success (0) buildid: 20151030110146 builduid: 8920a0c6819e4cb3a6c856362c2efa19 revision: d0b283bc162b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.604217) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.604783) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.605165) ========= 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.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006058 basedir: '/builds/slave/test' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.693587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.694033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.720543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.720900) ========= 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.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.027601 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.771680) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.772113) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.772619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.772996) ========= 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.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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:0x0:0x0 using PTY: False --2015-10-30 12:21:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-10-30 12:21:39 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128109 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.918402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:39.918823) ========= 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.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.135693 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:40.071380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:40.071895) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d0b283bc162b --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 d0b283bc162b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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:0x0:0x0 using PTY: False 2015-10-30 12:21:40,162 Setting DEBUG logging. 2015-10-30 12:21:40,162 attempt 1/10 2015-10-30 12:21:40,162 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d0b283bc162b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-30 12:21:40,538 unpacking tar archive at: mozilla-aurora-d0b283bc162b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658770 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:40.749650) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:40.750083) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:40.765244) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:40.765799) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 12:21:40.766628) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 9 secs) (at 2015-10-30 12:21:40.767305) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--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.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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:0x0:0x0 using PTY: False 12:21:41 INFO - MultiFileLogger online at 20151030 12:21:41 in /builds/slave/test 12:21:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:21:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:21:41 INFO - {'append_to_log': False, 12:21:41 INFO - 'base_work_dir': '/builds/slave/test', 12:21:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:21:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:21:41 INFO - 'branch': 'Mozilla-Aurora', 12:21:41 INFO - 'buildbot_json_path': 'buildprops.json', 12:21:41 INFO - 'config_files': ('talos/mac_config.py',), 12:21:41 INFO - 'default_actions': ('clobber', 12:21:41 INFO - 'read-buildbot-config', 12:21:41 INFO - 'download-and-extract', 12:21:41 INFO - 'populate-webroot', 12:21:41 INFO - 'create-virtualenv', 12:21:41 INFO - 'install', 12:21:41 INFO - 'run-tests'), 12:21:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:21:41 INFO - 'download_minidump_stackwalk': True, 12:21:41 INFO - 'download_symbols': 'ondemand', 12:21:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:21:41 INFO - 'tooltool.py': '/tools/tooltool.py', 12:21:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:21:41 INFO - '/tools/misc-python/virtualenv.py')}, 12:21:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:21:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:21:41 INFO - 'installer_path': 'installer.exe', 12:21:41 INFO - 'log_level': 'info', 12:21:41 INFO - 'log_name': 'talos', 12:21:41 INFO - 'log_to_console': True, 12:21:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:21:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:21:41 INFO - 'opt_config_files': (), 12:21:41 INFO - 'pip_index': False, 12:21:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:21:41 INFO - 'cmd': ('bash', 12:21:41 INFO - '-c', 12:21:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:21:41 INFO - 'enabled': True, 12:21:41 INFO - 'halt_on_failure': False, 12:21:41 INFO - 'name': 'check_screen_resolution'},), 12:21:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:21:41 INFO - 'cmd': ('bash', 12:21:41 INFO - '-c', 12:21:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:21:41 INFO - 'enabled': True, 12:21:41 INFO - 'halt_on_failure': False, 12:21:41 INFO - 'name': 'check_screen_resolution'},), 12:21:41 INFO - 'run_cmd_checks_enabled': True, 12:21:41 INFO - 'sps_profile': False, 12:21:41 INFO - 'sps_profile_interval': 0, 12:21:41 INFO - 'suite': 'dromaeojs', 12:21:41 INFO - 'system_bits': '64', 12:21:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:21:41 INFO - 'title': 't-yosemite-r5-0033', 12:21:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:21:41 INFO - 'use_talos_json': True, 12:21:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:21:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:21:41 INFO - 'work_dir': 'build'} 12:21:41 INFO - ##### 12:21:41 INFO - ##### Running clobber step. 12:21:41 INFO - ##### 12:21:41 INFO - Running pre-action listener: _resource_record_pre_action 12:21:41 INFO - Running main action method: clobber 12:21:41 INFO - rmtree: /builds/slave/test/build 12:21:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:21:42 INFO - Running post-action listener: _resource_record_post_action 12:21:42 INFO - ##### 12:21:42 INFO - ##### Running read-buildbot-config step. 12:21:42 INFO - ##### 12:21:42 INFO - Running pre-action listener: _resource_record_pre_action 12:21:42 INFO - Running main action method: read_buildbot_config 12:21:42 INFO - Using buildbot properties: 12:21:42 INFO - { 12:21:42 INFO - "properties": { 12:21:42 INFO - "buildnumber": 396, 12:21:42 INFO - "product": "firefox", 12:21:42 INFO - "script_repo_revision": "production", 12:21:42 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 12:21:42 INFO - "repository": "", 12:21:42 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 12:21:42 INFO - "buildid": "20151030110146", 12:21:42 INFO - "slavename": "t-yosemite-r5-0033", 12:21:42 INFO - "stage_platform": "macosx64", 12:21:42 INFO - "basedir": "/builds/slave/test", 12:21:42 INFO - "nightly_build": "True", 12:21:42 INFO - "project": "", 12:21:42 INFO - "platform": "yosemite", 12:21:42 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:21:42 INFO - "slavebuilddir": "test", 12:21:42 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:21:42 INFO - "branch": "mozilla-aurora", 12:21:42 INFO - "repo_path": "releases/mozilla-aurora", 12:21:42 INFO - "pgo_build": "False", 12:21:42 INFO - "builduid": "8920a0c6819e4cb3a6c856362c2efa19", 12:21:42 INFO - "revision": "d0b283bc162b" 12:21:42 INFO - }, 12:21:42 INFO - "sourcestamp": { 12:21:42 INFO - "repository": "", 12:21:42 INFO - "hasPatch": false, 12:21:42 INFO - "project": "", 12:21:42 INFO - "branch": "mozilla-aurora-macosx64-talos", 12:21:42 INFO - "changes": [ 12:21:42 INFO - { 12:21:42 INFO - "category": null, 12:21:42 INFO - "files": [ 12:21:42 INFO - { 12:21:42 INFO - "url": null, 12:21:42 INFO - "name": "https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 12:21:42 INFO - } 12:21:42 INFO - ], 12:21:42 INFO - "repository": "", 12:21:42 INFO - "rev": "d0b283bc162b", 12:21:42 INFO - "who": "sendchange", 12:21:42 INFO - "when": 1446232840, 12:21:42 INFO - "number": 6601765, 12:21:42 INFO - "comments": "", 12:21:42 INFO - "project": "", 12:21:42 INFO - "at": "Fri 30 Oct 2015 12:20:40", 12:21:42 INFO - "branch": "mozilla-aurora-macosx64-talos", 12:21:42 INFO - "revlink": "", 12:21:42 INFO - "properties": [ 12:21:42 INFO - [ 12:21:42 INFO - "buildid", 12:21:42 INFO - "20151030110146", 12:21:42 INFO - "Change" 12:21:42 INFO - ], 12:21:42 INFO - [ 12:21:42 INFO - "builduid", 12:21:42 INFO - "8920a0c6819e4cb3a6c856362c2efa19", 12:21:42 INFO - "Change" 12:21:42 INFO - ], 12:21:42 INFO - [ 12:21:42 INFO - "nightly_build", 12:21:42 INFO - "True", 12:21:42 INFO - "Change" 12:21:42 INFO - ], 12:21:42 INFO - [ 12:21:42 INFO - "pgo_build", 12:21:42 INFO - "False", 12:21:42 INFO - "Change" 12:21:42 INFO - ] 12:21:42 INFO - ], 12:21:42 INFO - "revision": "d0b283bc162b" 12:21:42 INFO - } 12:21:42 INFO - ], 12:21:42 INFO - "revision": "d0b283bc162b" 12:21:42 INFO - } 12:21:42 INFO - } 12:21:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 12:21:42 INFO - Running post-action listener: _resource_record_post_action 12:21:42 INFO - ##### 12:21:42 INFO - ##### Running download-and-extract step. 12:21:42 INFO - ##### 12:21:42 INFO - Running pre-action listener: _resource_record_pre_action 12:21:42 INFO - Running main action method: download_and_extract 12:21:42 INFO - mkdir: /builds/slave/test/build/tests 12:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:42 INFO - https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:21:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/test_packages.json 12:21:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/test_packages.json 12:21:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:21:43 INFO - Downloaded 1149 bytes. 12:21:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:21:43 INFO - Using the following test package requirements: 12:21:43 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 12:21:43 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:21:43 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 12:21:43 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:21:43 INFO - u'jsshell-mac.zip'], 12:21:43 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:21:43 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 12:21:43 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 12:21:43 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:21:43 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 12:21:43 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:21:43 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 12:21:43 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:21:43 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 12:21:43 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 12:21:43 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 12:21:43 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 12:21:43 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:21:43 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')]} 12:21:43 INFO - https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:21:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:21:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:21:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:21:44 INFO - Downloaded 17445310 bytes. 12:21:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:21:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:21:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 12:21:49 INFO - Return code: 0 12:21:49 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 12:21:49 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')]} 12:21:49 INFO - https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:21:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:21:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:21:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:21:51 INFO - Downloaded 17445310 bytes. 12:21:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:21:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 12:21:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 12:21:57 INFO - Return code: 0 12: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')]} 12:21:57 INFO - https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:21:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 12:21:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 12:21:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 12:21:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:21:58 INFO - Downloaded 11131307 bytes. 12:21:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 12:21:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 12:21:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:21:58 INFO - Return code: 0 12:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:58 INFO - https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 12:21:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 12:21:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 12:21:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 12:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 12:22:02 INFO - Downloaded 107844657 bytes. 12:22:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 12:22:02 INFO - mkdir: /builds/slave/test/properties 12:22:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:22:02 INFO - Writing to file /builds/slave/test/properties/build_url 12:22:02 INFO - Contents: 12:22:02 INFO - build_url:https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 12:22:02 INFO - Running post-action listener: _resource_record_post_action 12:22:02 INFO - Running post-action listener: set_extra_try_arguments 12:22:02 INFO - ##### 12:22:02 INFO - ##### Running populate-webroot step. 12:22:02 INFO - ##### 12:22:02 INFO - Running pre-action listener: _resource_record_pre_action 12:22:02 INFO - Running main action method: populate_webroot 12:22:02 INFO - Guessing talos json url... 12: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')]} 12:22:02 INFO - https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 12:22:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 12:22:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 12:22:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 12:22:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 12:22:02 INFO - Downloaded 107 bytes. 12:22:02 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 12:22:02 INFO - Contents: 12:22:02 INFO - 20151030110146 12:22:02 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/d0b283bc162b90b071af3b77c8168b4276d4e70a 12: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')]} 12:22:02 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/d0b283bc16/testing/talos/talos.json 12:22:02 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/d0b283bc16/testing/talos/talos.json to /builds/slave/test/build/talos.json 12:22:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/d0b283bc16/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 12:22:03 INFO - Downloaded 4264 bytes. 12:22:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:22:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:22:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:22:03 INFO - '../fennec_ids.txt'], 12:22:03 INFO - 'tests': ['tcheck2']}, 12:22:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:22:03 INFO - '--tppagecycles', 12:22:03 INFO - '7'], 12:22:03 INFO - 'tests': ['tsvgm']}}, 12:22:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:22:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:22:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:22:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:22:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:22:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:22:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:03 INFO - 'talos_options': ['--e10s'], 12:22:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:03 INFO - 'tests': ['damp', 'tps']}, 12:22:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:03 INFO - 'talos_options': ['--e10s'], 12:22:03 INFO - 'tests': ['damp', 'tps']}, 12:22:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:22:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:22:03 INFO - 'other': {'tests': ['a11yr', 12:22:03 INFO - 'ts_paint', 12:22:03 INFO - 'tpaint', 12:22:03 INFO - 'sessionrestore', 12:22:03 INFO - 'sessionrestore_no_auto_restore']}, 12:22:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:22:03 INFO - 'tests': ['a11yr', 12:22:03 INFO - 'ts_paint', 12:22:03 INFO - 'tpaint', 12:22:03 INFO - 'sessionrestore', 12:22:03 INFO - 'sessionrestore_no_auto_restore']}, 12:22:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:22:03 INFO - 'tests': ['a11yr', 12:22:03 INFO - 'ts_paint', 12:22:03 INFO - 'tpaint', 12:22:03 INFO - 'sessionrestore', 12:22:03 INFO - 'sessionrestore_no_auto_restore']}, 12:22:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:22:03 INFO - 'tests': ['a11yr', 12:22:03 INFO - 'ts_paint', 12:22:03 INFO - 'tpaint', 12:22:03 INFO - 'sessionrestore', 12:22:03 INFO - 'sessionrestore_no_auto_restore']}, 12:22:03 INFO - 'other_l64': {'tests': ['a11yr', 12:22:03 INFO - 'ts_paint', 12:22:03 INFO - 'tpaint', 12:22:03 INFO - 'sessionrestore', 12:22:03 INFO - 'sessionrestore_no_auto_restore']}, 12:22:03 INFO - 'other_nol64': {'tests': ['a11yr', 12:22:03 INFO - 'ts_paint', 12:22:03 INFO - 'tpaint', 12:22:03 INFO - 'sessionrestore', 12:22:03 INFO - 'sessionrestore_no_auto_restore']}, 12:22:03 INFO - 'svgr': {'tests': ['tsvgx', 12:22:03 INFO - 'tsvgr_opacity', 12:22:03 INFO - 'tart', 12:22:03 INFO - 'tscrollx', 12:22:03 INFO - 'cart']}, 12:22:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:22:03 INFO - 'tests': ['tsvgx', 12:22:03 INFO - 'tsvgr_opacity', 12:22:03 INFO - 'tart', 12:22:03 INFO - 'tscrollx', 12:22:03 INFO - 'cart']}, 12:22:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:03 INFO - 'tests': ['tp5o']}, 12:22:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:03 INFO - 'talos_options': ['--e10s'], 12:22:03 INFO - 'tests': ['tp5o']}, 12:22:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:03 INFO - 'talos_options': ['--xperf_path', 12:22:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:03 INFO - 'tests': ['tp5n']}, 12:22:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:03 INFO - 'talos_options': ['--e10s', 12:22:03 INFO - '--xperf_path', 12:22:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 12:22:03 INFO - 'C:/slave/talos-data/talos/xperf.config'], 12:22:03 INFO - 'tests': ['tp5n']}}, 12:22:03 INFO - 'talos.zip': {'path': '', 12:22:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:22:03 INFO - Running post-action listener: _resource_record_post_action 12:22:03 INFO - ##### 12:22:03 INFO - ##### Running create-virtualenv step. 12:22:03 INFO - ##### 12:22:03 INFO - Running pre-action listener: _resource_record_pre_action 12:22:03 INFO - Running main action method: create_virtualenv 12:22:03 INFO - Creating virtualenv /builds/slave/test/build/venv 12:22:03 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 12:22:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:22:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:22:03 INFO - Using real prefix '/tools/python27' 12:22:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:22:04 INFO - Installing distribute.............................................................................................................................................................................................done. 12:22:08 INFO - Installing pip.................done. 12:22:08 INFO - Return code: 0 12:22:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12: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')]} 12:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10eefba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e94f7840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb09f0>, '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 0x10ec0fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7a990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:22:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/Render', 12:22:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:22:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:22:08 INFO - 'HOME': '/Users/cltbld', 12:22:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:22:08 INFO - 'LOGNAME': 'cltbld', 12:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:08 INFO - 'MOZ_NO_REMOTE': '1', 12:22:08 INFO - 'NO_EM_RESTART': '1', 12:22:08 INFO - 'PAGER': '/bin/cat', 12:22:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:08 INFO - 'PWD': '/builds/slave/test', 12:22:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:22:08 INFO - 'SHELL': '/bin/bash', 12:22:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zb5cO4KVDc/Listeners', 12:22:08 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 12:22:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:22:08 INFO - 'USER': 'cltbld', 12:22:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:22:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:08 INFO - 'XPC_FLAGS': '0x0', 12:22:08 INFO - 'XPC_SERVICE_NAME': '0', 12:22:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:09 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 12:22:09 INFO - Cleaning up... 12:22:09 INFO - Return code: 0 12:22:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:22:09 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')]} 12:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:09 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')]} 12:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10eefba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e94f7840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb09f0>, '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 0x10ec0fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7a990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:22:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/Render', 12:22:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:22:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:22:09 INFO - 'HOME': '/Users/cltbld', 12:22:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:22:09 INFO - 'LOGNAME': 'cltbld', 12:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:09 INFO - 'MOZ_NO_REMOTE': '1', 12:22:09 INFO - 'NO_EM_RESTART': '1', 12:22:09 INFO - 'PAGER': '/bin/cat', 12:22:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:09 INFO - 'PWD': '/builds/slave/test', 12:22:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:22:09 INFO - 'SHELL': '/bin/bash', 12:22:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zb5cO4KVDc/Listeners', 12:22:09 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 12:22:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:22:09 INFO - 'USER': 'cltbld', 12:22:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:22:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:09 INFO - 'XPC_FLAGS': '0x0', 12:22:09 INFO - 'XPC_SERVICE_NAME': '0', 12:22:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:09 INFO - Downloading/unpacking psutil>=0.7.1 12:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:22:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:12 INFO - Installing collected packages: psutil 12:22:12 INFO - Running setup.py install for psutil 12:22:12 INFO - building 'psutil._psutil_osx' extension 12:22:12 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 12:22:14 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 12:22:14 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 12:22:14 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 12:22:15 INFO - building 'psutil._psutil_posix' extension 12:22:15 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 12:22:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:22:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:22:15 INFO - ^ 12:22:15 INFO - 1 warning generated. 12:22:15 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 12:22:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:15 INFO - Successfully installed psutil 12:22:15 INFO - Cleaning up... 12:22:15 INFO - Return code: 0 12:22:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10eefba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e94f7840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb09f0>, '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 0x10ec0fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7a990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:22:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/Render', 12:22:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:22:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:22:15 INFO - 'HOME': '/Users/cltbld', 12:22:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:22:15 INFO - 'LOGNAME': 'cltbld', 12:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:15 INFO - 'MOZ_NO_REMOTE': '1', 12:22:15 INFO - 'NO_EM_RESTART': '1', 12:22:15 INFO - 'PAGER': '/bin/cat', 12:22:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:15 INFO - 'PWD': '/builds/slave/test', 12:22:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:22:15 INFO - 'SHELL': '/bin/bash', 12:22:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zb5cO4KVDc/Listeners', 12:22:15 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 12:22:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:22:15 INFO - 'USER': 'cltbld', 12:22:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:22:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:15 INFO - 'XPC_FLAGS': '0x0', 12:22:15 INFO - 'XPC_SERVICE_NAME': '0', 12:22:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:22:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:22:18 INFO - Installing collected packages: mozsystemmonitor 12:22:18 INFO - Running setup.py install for mozsystemmonitor 12:22:19 INFO - Successfully installed mozsystemmonitor 12:22:19 INFO - Cleaning up... 12:22:19 INFO - Return code: 0 12:22:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10eefba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e94f7840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb09f0>, '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 0x10ec0fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7a990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/Render', 12:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:22:19 INFO - 'HOME': '/Users/cltbld', 12:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:22:19 INFO - 'LOGNAME': 'cltbld', 12:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:19 INFO - 'MOZ_NO_REMOTE': '1', 12:22:19 INFO - 'NO_EM_RESTART': '1', 12:22:19 INFO - 'PAGER': '/bin/cat', 12:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:19 INFO - 'PWD': '/builds/slave/test', 12:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:22:19 INFO - 'SHELL': '/bin/bash', 12:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zb5cO4KVDc/Listeners', 12:22:19 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 12:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:22:19 INFO - 'USER': 'cltbld', 12:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:19 INFO - 'XPC_FLAGS': '0x0', 12:22:19 INFO - 'XPC_SERVICE_NAME': '0', 12:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:19 INFO - Downloading/unpacking blobuploader==1.2.4 12:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:22 INFO - Downloading blobuploader-1.2.4.tar.gz 12:22:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:22:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:22:22 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 12:22:22 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 12:22:22 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 12:22:22 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 12:22:22 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 12:22:22 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 12:22:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:22:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12: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 12: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 12: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 12: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 12: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 12: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 12:22:23 INFO - Downloading docopt-0.6.1.tar.gz 12:22:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:22:23 INFO - Installing collected packages: blobuploader, requests, docopt 12:22:23 INFO - Running setup.py install for blobuploader 12:22:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:22:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:22:24 INFO - Running setup.py install for requests 12:22:24 INFO - Running setup.py install for docopt 12:22:24 INFO - Successfully installed blobuploader requests docopt 12:22:24 INFO - Cleaning up... 12:22:24 INFO - Return code: 0 12:22:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10eefba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e94f7840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb09f0>, '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 0x10ec0fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7a990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:22:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 12:22:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/Render', 12:22:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:22:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:22:24 INFO - 'HOME': '/Users/cltbld', 12:22:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:22:24 INFO - 'LOGNAME': 'cltbld', 12:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:24 INFO - 'MOZ_NO_REMOTE': '1', 12:22:24 INFO - 'NO_EM_RESTART': '1', 12:22:24 INFO - 'PAGER': '/bin/cat', 12:22:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:24 INFO - 'PWD': '/builds/slave/test', 12:22:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:22:24 INFO - 'SHELL': '/bin/bash', 12:22:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zb5cO4KVDc/Listeners', 12:22:24 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 12:22:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:22:24 INFO - 'USER': 'cltbld', 12:22:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:22:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:24 INFO - 'XPC_FLAGS': '0x0', 12:22:24 INFO - 'XPC_SERVICE_NAME': '0', 12:22:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:22:25 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-D_JnOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:22:25 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-T9fTUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:22:25 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-jf0lrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:22:25 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-NbWAbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:22:25 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-yJPgJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:22:26 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-rjhBPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:22:26 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-vNc5zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:22:26 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-Zrhv3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:22:26 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-xuGJod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:22:26 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-5Q1zPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:22:26 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-U0VNf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:22:26 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-aQPbp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:22:26 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-WZgeZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:22:27 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-3P2ewM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:27 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-8vBIZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:22:27 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-AZmu0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:22:27 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-yGYGNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:22:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:22:27 INFO - Running setup.py install for manifestparser 12:22:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:22:27 INFO - Running setup.py install for mozcrash 12:22:28 INFO - Running setup.py install for mozdebug 12:22:28 INFO - Running setup.py install for mozdevice 12:22:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:22:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:22:28 INFO - Running setup.py install for mozfile 12:22:28 INFO - Running setup.py install for mozhttpd 12:22:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:22:28 INFO - Running setup.py install for mozinfo 12:22:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Running setup.py install for mozInstall 12:22:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Running setup.py install for mozleak 12:22:29 INFO - Running setup.py install for mozlog 12:22:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Running setup.py install for moznetwork 12:22:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Running setup.py install for mozprocess 12:22:30 INFO - Running setup.py install for mozprofile 12:22:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Running setup.py install for mozrunner 12:22:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Running setup.py install for mozscreenshot 12:22:30 INFO - Running setup.py install for moztest 12:22:30 INFO - Running setup.py install for mozversion 12:22:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:22:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:22:31 INFO - Cleaning up... 12:22:31 INFO - Return code: 0 12:22:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10eefba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e94f7840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb09f0>, '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 0x10ec0fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7a990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:22:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/Render', 12:22:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:22:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:22:31 INFO - 'HOME': '/Users/cltbld', 12:22:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:22:31 INFO - 'LOGNAME': 'cltbld', 12:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:31 INFO - 'MOZ_NO_REMOTE': '1', 12:22:31 INFO - 'NO_EM_RESTART': '1', 12:22:31 INFO - 'PAGER': '/bin/cat', 12:22:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:31 INFO - 'PWD': '/builds/slave/test', 12:22:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:22:31 INFO - 'SHELL': '/bin/bash', 12:22:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zb5cO4KVDc/Listeners', 12:22:31 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 12:22:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:22:31 INFO - 'USER': 'cltbld', 12:22:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:22:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:31 INFO - 'XPC_FLAGS': '0x0', 12:22:31 INFO - 'XPC_SERVICE_NAME': '0', 12:22:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:22:31 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-r5BqqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:22:31 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-6uHzZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:22:31 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-kEPmNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:22:31 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-Hum6vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:22:32 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-cozp7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:22:32 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:22:32 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-Yuu20f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:22:32 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:22:32 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-2Lohox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:22:32 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-D8Msyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:22:32 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:22:32 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-yjL00t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:22:32 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:22:32 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-klyLkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:22:32 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-hoAgnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:22:33 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)) 12:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:22:33 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-K0g6LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:22:33 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)) 12:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:22:33 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-slQShR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 12:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:22:33 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-JULKDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:22:33 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)) 12:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:33 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-0vOr61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:33 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)) 12:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:22:33 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-ynPHcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:22:33 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)) 12:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:22:33 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-2L3mqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:22:33 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)) 12:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:22:33 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)) 12:22:33 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:22:33 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:22:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:36 INFO - Downloading blessings-1.5.1.tar.gz 12:22:36 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:22:36 INFO - Installing collected packages: blessings 12:22:36 INFO - Running setup.py install for blessings 12:22:37 INFO - Successfully installed blessings 12:22:37 INFO - Cleaning up... 12:22:37 INFO - Return code: 0 12:22:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:22:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:22:37 INFO - Reading from file tmpfile_stdout 12:22:37 INFO - Current package versions: 12:22:37 INFO - blessings == 1.5.1 12:22:37 INFO - blobuploader == 1.2.4 12:22:37 INFO - docopt == 0.6.1 12:22:37 INFO - manifestparser == 1.1 12:22:37 INFO - mozInstall == 1.12 12:22:37 INFO - mozcrash == 0.16 12:22:37 INFO - mozdebug == 0.1 12:22:37 INFO - mozdevice == 0.46 12:22:37 INFO - mozfile == 1.2 12:22:37 INFO - mozhttpd == 0.7 12:22:37 INFO - mozinfo == 0.8 12:22:37 INFO - mozleak == 0.1 12:22:37 INFO - mozlog == 3.0 12:22:37 INFO - moznetwork == 0.27 12:22:37 INFO - mozprocess == 0.22 12:22:37 INFO - mozprofile == 0.27 12:22:37 INFO - mozrunner == 6.11 12:22:37 INFO - mozscreenshot == 0.1 12:22:37 INFO - mozsystemmonitor == 0.0 12:22:37 INFO - moztest == 0.7 12:22:37 INFO - mozversion == 1.4 12:22:37 INFO - psutil == 3.1.1 12:22:37 INFO - requests == 1.2.3 12:22:37 INFO - wsgiref == 0.1.2 12:22:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12: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')]} 12:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10eefba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e94f7840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eeb09f0>, '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 0x10ec0fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7a990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:22:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/Render', 12:22:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:22:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:22:37 INFO - 'HOME': '/Users/cltbld', 12:22:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:22:37 INFO - 'LOGNAME': 'cltbld', 12:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:37 INFO - 'MOZ_NO_REMOTE': '1', 12:22:37 INFO - 'NO_EM_RESTART': '1', 12:22:37 INFO - 'PAGER': '/bin/cat', 12:22:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:37 INFO - 'PWD': '/builds/slave/test', 12:22:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:22:37 INFO - 'SHELL': '/bin/bash', 12:22:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zb5cO4KVDc/Listeners', 12:22:37 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 12:22:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:22:37 INFO - 'USER': 'cltbld', 12:22:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:22:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:37 INFO - 'XPC_FLAGS': '0x0', 12:22:37 INFO - 'XPC_SERVICE_NAME': '0', 12:22:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:37 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 1)) 12:22:37 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 2)) 12:22:37 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 3)) 12:22:37 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 4)) 12:22:37 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 5)) 12:22:37 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 6)) 12:22:37 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 7)) 12:22:37 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 8)) 12:22:37 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:22:37 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 3)) 12: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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:22:38 INFO - Cleaning up... 12:22:38 INFO - Return code: 0 12:22:38 INFO - Running post-action listener: _resource_record_post_action 12:22:38 INFO - Running post-action listener: _start_resource_monitoring 12:22:38 INFO - Starting resource monitoring. 12:22:38 INFO - ##### 12:22:38 INFO - ##### Running install step. 12:22:38 INFO - ##### 12:22:38 INFO - Running pre-action listener: _resource_record_pre_action 12:22:38 INFO - Running main action method: install 12:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:22:38 INFO - Reading from file tmpfile_stdout 12:22:38 INFO - Detecting whether we're running mozinstall >=1.0... 12:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:22:38 INFO - Reading from file tmpfile_stdout 12:22:38 INFO - Output received: 12:22:38 INFO - Usage: mozinstall [options] installer 12:22:38 INFO - Options: 12:22:38 INFO - -h, --help show this help message and exit 12:22:38 INFO - -d DEST, --destination=DEST 12:22:38 INFO - Directory to install application into. [default: 12:22:38 INFO - "/builds/slave/test"] 12:22:38 INFO - --app=APP Application being installed. [default: firefox] 12:22:38 INFO - mkdir: /builds/slave/test/build/application 12:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:23:21 INFO - Reading from file tmpfile_stdout 12:23:21 INFO - Output received: 12:23:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:23:21 INFO - Running post-action listener: _resource_record_post_action 12:23:21 INFO - ##### 12:23:21 INFO - ##### Running run-tests step. 12:23:21 INFO - ##### 12:23:21 INFO - Running pre-action listener: _resource_record_pre_action 12:23:21 INFO - Running main action method: run_tests 12:23:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:23:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:23:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:23:21 INFO - 2015-10-30 12:23:21.800 screenresolution[1629:7504] starting screenresolution argv=screenresolution get 12:23:21 INFO - 2015-10-30 12:23:21.804 screenresolution[1629:7504] Display 0: 1600x1200x32@60 12:23:21 INFO - 2015-10-30 12:23:21.811 screenresolution[1630:7506] starting screenresolution argv=screenresolution list 12:23:21 INFO - Available Modes on Display 0 12:23:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:23:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:23:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:23:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:23:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:23:22 INFO - Intel HD Graphics 3000: 12:23:22 INFO - Chipset Model: Intel HD Graphics 3000 12:23:22 INFO - Type: GPU 12:23:22 INFO - Bus: Built-In 12:23:22 INFO - VRAM (Total): 512 MB 12:23:22 INFO - VRAM (Dynamic, Max): 10 12:23:22 INFO - Vendor: Intel (0x8086) 12:23:22 INFO - Device ID: 0x0116 12:23:22 INFO - Revision ID: 0x0009 12:23:22 INFO - Displays: 12:23:22 INFO - Display: 12:23:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:23:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:23:22 INFO - Display Serial Number: 1600x1200 60 12:23:22 INFO - Main Display: Yes 12:23:22 INFO - Mirror: Off 12:23:22 INFO - Online: Yes 12:23:22 INFO - Rotation: Supported 12:23:22 INFO - Return code: 0 12:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:23:22 INFO - Python 2.7.3 12:23:22 INFO - Return code: 0 12:23:22 INFO - grabbing minidump binary from tooltool 12:23:22 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')]} 12:23:22 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 0x10eeb09f0>, '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 0x10ec0fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7a990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:23:22 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 12:23:22 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 12:23:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:23:22 INFO - Return code: 0 12:23:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:23:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:23:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:23:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:23:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0033', '--webServer', 'localhost'] in /builds/slave/test/build 12:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0033 --webServer localhost 12:23:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zE4oN8kmTb/Render', 12:23:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:22 INFO - 'HOME': '/Users/cltbld', 12:23:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:22 INFO - 'LOGNAME': 'cltbld', 12:23:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:23:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:22 INFO - 'MOZ_NO_REMOTE': '1', 12:23:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:23:22 INFO - 'NO_EM_RESTART': '1', 12:23:22 INFO - 'PAGER': '/bin/cat', 12:23:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:22 INFO - 'PWD': '/builds/slave/test', 12:23:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:23:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:22 INFO - 'SHELL': '/bin/bash', 12:23:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zb5cO4KVDc/Listeners', 12:23:22 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 12:23:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:22 INFO - 'USER': 'cltbld', 12:23:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:22 INFO - 'XPC_FLAGS': '0x0', 12:23:22 INFO - 'XPC_SERVICE_NAME': '0', 12:23:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:23:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0033', '--webServer', 'localhost'] with output_timeout 3600 12:23:22 INFO - mozversion INFO | application_buildid: 20151030110146 12:23:22 INFO - mozversion INFO | application_changeset: d0b283bc162b90b071af3b77c8168b4276d4e70a 12:23:22 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 12:23:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:23:22 INFO - mozversion INFO | application_name: Firefox 12:23:22 INFO - mozversion INFO | application_remotingname: firefox-dev 12:23:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:23:22 INFO - mozversion INFO | application_vendor: Mozilla 12:23:22 INFO - mozversion INFO | application_version: 44.0a2 12:23:22 INFO - mozversion INFO | platform_buildid: 20151030110146 12:23:22 INFO - mozversion INFO | platform_changeset: d0b283bc162b90b071af3b77c8168b4276d4e70a 12:23:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:23:22 INFO - mozversion INFO | platform_version: 44.0a2 12:23:22 INFO - 2015-10-30 12:23:22,589 DEBUG : using testdate: 1446233002 12:23:22 INFO - 2015-10-30 12:23:22,589 DEBUG : actual date: 1446233002 12:23:22 INFO - 2015-10-30 12:23:22,599 INFO : starting webserver on 'localhost:49265' 12:23:22 INFO - 2015-10-30 12:23:22,600 INFO : Starting test suite t-yosemite-r5-0033 12:23:22 INFO - 2015-10-30 12:23:22,601 INFO : Starting test dromaeo_css 12:23:22 INFO - 2015-10-30 12:23:22,601 DEBUG : operating with platform_type : mac_ 12:23:22 INFO - 2015-10-30 12:23:22,602 INFO : Initialising browser for dromaeo_css test... 12:23:22 INFO - 2015-10-30 12:23:22,627 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpaoJnkm/profile http://localhost:49265/getInfo.html 12:23:26 INFO - 2015-10-30 12:23:26,010 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:23:26 INFO - 2015-10-30 12:23:26,010 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:23:26 INFO - 2015-10-30 12:23:26,010 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:23:26 INFO - 2015-10-30 12:23:26,010 DEBUG : BROWSER_OUTPUT: __metrics 12:23:26 INFO - 2015-10-30 12:23:26,026 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:23:26 INFO - 2015-10-30 12:23:26,871 INFO : Browser initialized. 12:23:26 INFO - 2015-10-30 12:23:26,871 INFO : Running cycle 1/1 for dromaeo_css test... 12:23:26 INFO - 2015-10-30 12:23:26,871 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpaoJnkm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:23:39 INFO - 2015-10-30 12:23:39,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 201166848 12:23:39 INFO - 2015-10-30 12:23:39,069 DEBUG : BROWSER_OUTPUT: 12:24:30 INFO - 2015-10-30 12:24:30,872 DEBUG : BROWSER_OUTPUT: 1446233070869 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] 12:26:41 INFO - 2015-10-30 12:26:41,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 12:26:42 INFO - 2015-10-30 12:26:42,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 290381824 12:26:42 INFO - 2015-10-30 12:26:42,442 DEBUG : BROWSER_OUTPUT: 12:29:45 INFO - 2015-10-30 12:29:45,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 12:29:45 INFO - 2015-10-30 12:29:45,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 338907136 12:29:45 INFO - 2015-10-30 12:29:45,853 DEBUG : BROWSER_OUTPUT: 12:32:48 INFO - 2015-10-30 12:32:48,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 12:32:48 INFO - 2015-10-30 12:32:48,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 307003392 12:32:48 INFO - 2015-10-30 12:32:48,710 DEBUG : BROWSER_OUTPUT: 12:35:50 INFO - 2015-10-30 12:35:50,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 12:35:51 INFO - 2015-10-30 12:35:51,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 297697280 12:35:51 INFO - 2015-10-30 12:35:51,474 DEBUG : BROWSER_OUTPUT: 12:38:54 INFO - 2015-10-30 12:38:54,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 12:38:55 INFO - 2015-10-30 12:38:55,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 301355008 12:38:55 INFO - 2015-10-30 12:38:55,443 DEBUG : BROWSER_OUTPUT: 12:41:58 INFO - 2015-10-30 12:41:58,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 12:41:58 INFO - 2015-10-30 12:41:58,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 341487616 12:41:58 INFO - 2015-10-30 12:41:58,374 DEBUG : BROWSER_OUTPUT: 12:41:58 INFO - 2015-10-30 12:41:58,375 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:41:58 INFO - 2015-10-30 12:41:58,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:41:58 INFO - 2015-10-30 12:41:58,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:41:58 INFO - 2015-10-30 12:41:58,375 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:41:58 INFO - 2015-10-30 12:41:58,376 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2596.389848385629;2671.585904184852;2682.3830518980644;2701.1626395817298;2727.904523341683;4569.383133277007;4589.954100458995;4595.218812801823;4609.262517997113;4629.120467111246;4588.7476188809605;4632.953670463295;4642.628589712824;4668.439787225538;4712.882177945545;4077.1641813428178;4221.134667393177;4282.785860706976;4321.200577893084;4470.843520476784;4175.227582897173;4175.582441755831;4258.552851950547;4304.117655880553;4349.34759786033;4367.257566213735;4382.824687012531;4404.581564751344;4423.358613001113;4473.1501014807245;4025.416314634391;4337.284348082562;4354.716943398669;4383.627391671712;4419.138268037734;4172.499300083979;4208.705390622657;4254.595813397722;4257.467816522934;4301.354796780477;4442.244818380883;4451.554844515555;4461.375407442961;4463.062756821071;4489.573490518395;4595.931061034087;4747.311639812208;4752.619790416758;4764.309175169581;4797.2564252540915;4720.33915251865;4854.6359023073055;4863;4872.65891387603;4877.414710234759;4484.865454036384;4569.497355290915;4572.268437050056;4572.565606267399;4610.2854057621125;4822.614190864792;4971.651984361132;5034.874128146753;5040.168372218616;5042.873928151752;4628.514006029386;4690;4695.647826413033;4743.691660042086;4785.425748910153;4933.629977751683;4944.678595891256;4961.4294356148785;4986.102501549683;4992.375953005874;4578.290364993365;4843.2250839865455;4855.490173531799;4858.95141048585;4881.267809828483;4705.788239529229;4717.764111794397;4726.432828060655;4737.38414006177;4832.565069143794;3695.9630403696156;3713.6843368313457;3744.925101498009;3745.382011968049;3767.208886133888;3350.6146793119105;3403.8127902965575;3420.675035871588;3422.178677117524;3424;4332.566743325642;4350.195213885441;4443.555644435531;4449.28811390176;4564.794584243717;4919.163742163841;4919.2129259318335;4921.089598424232;4954.603631709455;4968.627352948543;4637.744924029211;4664.067186562701;4666.066786642617;4667.369905062841;4691;3983.2830090583393;4162.167566486714;4166.8333266669;4282.828686852553;4301.41930839339;4821.855344339676;4833.879153021203;4913.778879950411;4949.57928576075;4952.380952380952;4822.228443449031;4836.661433699607;4876.634252431153;4919.631027672867;4925.039617274597;4666.253399456071;4785.6171506278715;4850.805967761391;4928.728919909439;4972.552470277692;4737.857864264078;4750.168720473835;4763.499832517536;4855.028994201103;4868;4820.1805693031565;4823.662343635911;4939;4948.257761335828;4973.502649734997;4563.7489938052395;4627.352170696173;4630.3286023525725;4639.141758774637;4662.836800711959;4614.74618895964;4682.695624784378;4689.953100468952;4692.9530704692515;4727.858164255078;4270.188664153801;4502.707324023928;4587.908241835212;4602.7698615069785;4612.423447069116;4521.638268938543;4554.294084416921;4636;4642.86071417858;4786.904261914672;4617.145828021827;4627.7686115693405;4647.581717645428;4656.138614356355;4660.440747110233 12:41:58 INFO - 2015-10-30 12:41:58,381 DEBUG : BROWSER_OUTPUT: |1;ext.html;460.7811289637423;469.30074189457696;482.54881685623945;495.55895253224656;515.9268721060192;26236.212913612573;27801.443971120567;33263.168420789465;33653;33670.66329336706;35304.82347588265;35410.2917941641;35423.64576354236;35463.11342216446;35882.64117358826;6948.409385202264;7129.643517824114;7573.242675732437;7770.9611451942665;7898.486598371116;9021.954890225572;9220.8616870747;9318.767030824216;9323.347365684405;9427.811443771121;8950.015498295183;9056.954715226448;9076.092390760938;9084.182423581877;9222.44665320083;7159.248278930715;7486.962565187194;8972.102789721008;9038.909610903873;9271.165595096474;8788.956055219747;8885.866711999326;8911;8938.910610893872;8954.910450895473;32816.50775238373;33276.33447331064;33278.83360583206;33285.00144995654;33293.66706332954;2547.439563296072;2585.8060645451665;2697.325668582854;2876.985615071932;2892.1612732307603;22336.55326893453;22519;22929.656055159187;23430.531389372118;23806.88096559506;1968.0750047477663;1979.6337677529702;2003.7094621279832;2045.2228153301799;2068.917243310281;260254;263476.6826165876;264089;267356;269212;49563.752181239586;49691.75154124206;49723.254151187764;49760.25359619609;50517.747411263445;54097.72951135219;54893.72553137209;55498.445015549325;55510.444895551336;56184.719076404355;14434.711305773826;14474.638134046523;14674;14713.779293310608;14917.40330386794;10898.945505272422;11099.722506937229;11161.944190278997;11270.549178032787;11328.830067548994;17192.484225473258;17249.741253881202;17265.39571115005;17354.826451735575;17426;7267.345938865527;7336.853262934711;7342.559446433231;7391.334779869838;7405.7789258572575;725.1877896755667;731.042334541752;795.6141271483326;799.9960050137157;814.7677911795229;23744.762552374254;23930.7606923932;24040.519189616458;24469.143579974614;24559.38601534976;811.342812322021;874.9657047364902;877.9604917778715;988.8516722491684;1008.8234558952154;11493.597724079616;12611.432485538173;12635.1787133836;12826.615201543782;12856.264404305486;318423.4078829591;319989;320626;326863;327387;44706.32940505895;45303.32045019327;46002.53997459982;46495.5350446498;51530.22704659433;1191.0412118244724;1193.6956076200513;1209.044854564884;1214.392803598201;1218.0194943070912;23257.651135233322;23855.761442385356;24457;24946.62580061337;24993.500129996934;37632.623673762915;38556.228875422894;42234.5776542243;43652.34521482244;43921;229024;230744;231203;233674;236072;26208.8689556551;26379;27054.1883743488;27165.86417067902;27343.179704608894;33540.329193415506;34327.31345373028;34609.30781384408;34743.47884781781;35485.64514354823;29189.7081029187;29205.85397073001;29629.40741185121;29681.554776677935;32314.83842580772;29192.416151677273;29225;29885.5517167247;30316;30353;30711.2322191947;30879.382412351177;30891.382172356876;32856.83571582127;33599.664003359656;26101.477970440865;26738.46523069489;27158.72841271641;27327.86336068307;27340.453190935674;20551.280705175246;20588;20858.269960551308;20941;21584.460388489784 12:41:58 INFO - 2015-10-30 12:41:58,381 DEBUG : BROWSER_OUTPUT: |2;jquery.html;291.10775473174704;294.6125844514464;296.41753953481407;296.6795860470691;297.0375981818906;12246.203996740205;12631.368431578407;14069.859301406983;14772.210243120815;15036.173010484432;12729.236245825257;14872.62818429537;14951.47669831556;15288.082715037077;15311.157886316249;4387.276099443588;4400.251957167273;4508.458984921814;4515.345274935149;4543.591076803087;3348.11275012122;3399.5240666306613;3447.034830247522;4501.774911254441;4549.11292298002;4581.496035436099;4761.2143996240575;4811.326414302001;4856.781444834991;4874.926876096862;4509.6392288616835;4590.954090459086;4761.714297142165;4864.173090574611;4865.975670121662;4256.2764330063965;4273.487181538236;4344.978275108636;4345.869623911288;4352.804123814436;18080;18548;18626.906865465586;18643.347482838035;18675.813241867545;1669.3656410564029;1727.5076603168036;1785.7053586158268;1830.606419619788;1906.6663333916508;10390.740231494197;10495.895041049644;10515.421651809147;10675.092617127553;10926;1359.7416490866703;1384.6399936016708;1404.0101728281638;1417.8794802441805;1418.3830033935271;49077;49679.75160124176;49790.50209497895;50404.74797626025;50416.74791626055;7556.962215188999;7588.165301816795;7772.533647981139;7845.450818442769;7929.246721561442;9529.761755956157;9537.952310238405;9548.42709437436;9552.092551207625;9552.808943821223;6123.9387606124255;6124.173236613;6210.689465526796;6223.657698826608;6226.782062627786;6172.086653137452;6246.281677607042;6261.624302541862;6265;6320.178376810985;4270.50889147752;4288.035192081757;4338.436003319548;4387.420528609698;4428.579284967923;1307.9346032698327;1308.7447947650307;1315.2568798628745;1332.5202926946292;1367.1523655333756;775.9418043646749;782.9491083079581;784.9921500784919;791.3589992106412;920.1304766995125;15515.301811418512;15736.68526629461;15807.683846323009;16042.598935026717;16149.192540372935;711.5623891306913;785.1285073568334;789.9565523896126;846.6613354658062;872.829798189347;6364.522660800459;8592.140785921358;9012.143846334588;9022.188003079624;9126.771830704285;468472;470273;472296;475135;477223;58052.419475805546;61719.382806171365;62307.68846155831;62432.68783656053;63483.6825815868;391.26637554585153;402.0331103695675;402.48280958967587;404.3288141684789;405.4020320027994;9355.625774968925;9378.296627752808;9439.716808495756;9486;9718.173955213602;29744.405111898075;30525.542116867822;30830.691693082783;31636.841815791693;31834.204144896565;36751.448728269635;41370.79314603408;42028.57971420247;42666.36000459934;43696.344554832336;4978.32792572998;5070.569001634903;5075.543201111917;5146.819861304986;5168.9741551292;9086.818263634557;9572.425654460754;9622.278329125204;9708.902910970799;9768.218542516439;8136.22705842944;8333.791655208668;8385.371097167616;8419.284360829399;8433.578321084044;7459.477836551389;7975.601219939096;8025.678972841021;8073.313768329758;8307.626156822836;6819.454443644596;8391.622376993171;8449.577521124042;8644.78388040304;8810.03089660124;5224.477552244745;5299.046171688979;5311.017461769585;5352.197170424468;5419.34967803866;8489.193526614961;8575.228229459379;8589.52757598338;8620.913790862262;8796.824063518821 12:41:58 INFO - 2015-10-30 12:41:58,385 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1264.1593340428615;1384.9099808512447;1435.562153543169;1466.6113479927817;1497.0344128037423;6048.243969503812;6160.353162917891;6169.660668663228;6321.051842223669;6390.073439351291;6345.809625711236;6369.968150159254;6598.604083754978;6620.933790662092;6627.867442651156;1760.7975082865441;1770.1768677564899;1790.9194086266084;1800.4238643634042;1801.8288262615097;1779.5017395129385;1819.0450013742825;1830.1672738903833;1831.9267229310879;1872.5131465818918;1820.5630648644362;1838;1854.1934258597487;1859.479345783183;1869.252299080372;1758.1912320332663;1781.153951872863;1825.4341154242095;1826.6620675175136;1828.1773202059126;1772.5568607848038;1860.0048973799087;1877.1928070929496;1896.8482521398255;1899.2877670873422;5696.772129114872;6421.908275593114;6478.967605161991;6479.5788273762055;6496.058071579641;3493.545839040934;3934.0951581136214;4030.415589739501;4038.3134867072667;4045.959540404617;2292.518571100071;2348.4246359641825;2404.9519009619885;2406.3984003999;2406.843555168926;612.7579606055627;723.2225357740398;748.0574476160023;756.4818099601736;766.6933226709361;8592.054873963796;8606.655733770642;8641.43830651012;8763.780905477413;8802;3561.5726112866623;3573.4997100405963;3581.606023337431;3587.192881601619;3588.085038315265;7633.313001829751;7780.260875216845;7784.3772498200005;7790;7791.532508049535;4017.959820401817;4018.4976877890263;4042.939355909664;4105.158442519277;4141.7100802943505;3694.5935947045805;3731.104534911656;3741.0273328934672;3745.5505339358906;3750;3019.879204831826;3032.2570970112465;3033.1810411189294;3065.908022759321;3075.5694202811624;959.836827739286;971;971.3152227679469;985.1773768903046;991.9355241909398;1058.7829494953517;1068.738159151013;1073.4632683658172;1096.0792933935531;1100.7908497385472;6096.359882212392;6100.0544915537275;6247.0629405589525;6252.6873656317;6254.530910181755;388.93582558877466;1019.622739586343;1019.6482213636284;1048.035807057509;1071.7856428714288;4524.524924882906;4661.95338046622;4672.579467847842;4674.065186962621;4679.953200467951;7448.217937116633;7639.885401718979;7822.06135263772;7835.921640783519;7850.6859725611475;7598.468107232551;7617.885731714029;7767.33977611898;7768.65041073153;7797.025371828521;5149.716765577929;5592.804251851166;6006.579539432285;6091.817245482643;6169.907451388232;6052.425019623129;6090.969545152246;6146.0473626587955;6196.938030619636;6204.3795620437595;6522.608643481406;6690.13028306317;6845;6864.313568643096;6906.482013848881;6776.119104516381;6950.20072691647;6992.475564332797;7208.06295181623;7211.567305961659;5727.427257274239;5886.646801191942;5939.406059394026;5943.286805583358;5951.613145145551;6309.463695585927;6330.620162790247;6343.90484142729;6347.492200624031;6426.807195784134;5559.19391688211;5924.259467566554;5951.7024148791525;5973.402659733992;6081.239845019372;5666.093425051972;5708.857278568069;5850.356460789225;5880.882382352414;5905.114232865105;5783.971080144573;5851.941480585139;5860.970695146497;5900.350961394329;5949.315828679757;5183.974080129575;5325.387580428301;5362.758675859518;5381.327334083239;5471.206675032018;5401.162819762943;5481.479259470344;5520.454272803621;5521.254630624814;5525.778968841201 12:41:58 INFO - 2015-10-30 12:41:58,386 DEBUG : BROWSER_OUTPUT: |4;prototype.html;267.3130055756705;273.4803084304994;274.4127567006606;279.87265794063705;284.9928751781205;4795.904081918359;4907.362042934423;5028.547430731233;5033;5073.036123136606;4710.97644511777;4964.975175124128;4974.801007959677;4977.153883839747;4983.775730092146;3848.7690738555634;3852.6532612064907;3855.248226595801;3871.728978971473;3876.0891190570264;3803.7717736935733;3867.8066096695193;3872.0319920019997;3874.089588946595;3952.4071389291694;3814.6566808987186;3842.903927401809;3883.8446462141483;3897.0841852164717;3899.707521935852;3876.2441323941844;3881.941770873439;3894.591067937868;3914.5889681583594;3932.016995751062;3392.5589673342306;3395;3398.728101751854;3406.250624862551;3416.299658569987;4806.879828004293;4812.085703716318;4812.37439132914;4820.517948205152;4917.606591472673;4314.525402205755;4324.156789426063;4352.564743525654;4363.5418281080665;4429.136318417877;5167.638265321429;5176.145935920568;5199.896002079937;5202.661826981234;5203.297554830087;3591.479235510836;3592.0481072515804;3594.8382322795537;3604.9545631766755;3612.6748592626527;5430.456954304577;5431.185322201662;5432.375276843174;5445.809396671137;5450.591205659552;3471.635478274745;3518.876839310612;3521.2253304273017;3562.786232825987;3563.80399078048;3334.1997920498907;3668.761530500509;3687.022938921188;3687.225682606629;3706.629337066272;4285.142971405731;4286.057067445157;4293.463317085364;4299.54854740254;4313.525512193656;5051.545360917535;5128.7179205144075;5150.562202212854;5190.740462976836;5195.012947539955;1331.9267440290682;1335.4524644895546;1337.7658909690765;1338.8594197609111;1341.0947610362966;877.4559772940818;895.6059333893066;902.6254104546671;906.1844340093836;918.9862152067724;5016.598672106223;5060.949390506048;5081.695098294114;5087.135187018216;5099.643024988215;5448.37343705471;5459.317585301837;5474.3704473986;5480.506754392044;5483.369412517612;4971.45314015458;5053.039922414803;5055.9494405055475;5065.39215294167;5089.745512724423;2898.9418862115176;2954.896578619738;2977.880884764585;3015.351699384643;3016.185629879964;5523.751431185607;5525.613207075467;5545.584081193846;5545.611807173459;5550.666959982414;5568;5572.219889215513;5574.888502230014;5575.4424557543925;5599.8880022400135;5506.229127922014;5506.366767821752;5509.201165831012;5513;5524.226608274925;5206.947930520646;5336.973315133399;5429.484199001088;5441.863953401196;5483.287172667528;5140.537351638371;5244.790208391774;5316.654417463007;5325.2278419628165;5416.133418652997;5429.538489228302;5496.697681627389;5501.449855014466;5509.118541033416;5529.419410961952;3442.345954268681;3443.4490481522835;3446.052335607728;3449.965500345065;3452.948205776865;5209.71346575942;5379.704116273642;5385.46145385474;5409.459054094559;5471.753771080391;5306.469353064817;5313.654612450178;5314.335708036496;5325.840224793263;5385.6230063895155;5291.708956007456;5293.814716484904;5296.232046353334;5326.440723723953;5392;5158.690478571298;5161.483851614808;5169.92245116316;5184.896302074013;5232.633715639869;5114.258432527188;5227.947720522899;5238.816641417532;5239.554637855825;5314.601404894725;4979.651424400402;5053.343065401475;5127.41034781005;5150.356205474316;5151.2788209649925 12:41:58 INFO - 2015-10-30 12:41:58,389 DEBUG : BROWSER_OUTPUT: |5;yui.html;551.418253742302;614.751025834537;618.7927044440112;625.4652272307177;637.8405398650336;10136.645217417392;10150.796984060315;10365;10372.273940824136;10423.11403530699;9576.952115239414;10136.898631013688;10203.897961020406;10821.350718956868;10926.399048052353;746.0264355016701;748.206900685274;753.2919056087261;756.6821934787375;760.7717684694597;732.7801659502155;748.7042618165822;757.6590534259577;771.9691212351528;772.1274959296015;792.0574516325554;792.9524228546305;793.2266040610416;803.2971150243537;809.134226377776;769.0655853138436;788.8343447875895;795.9442839001272;797.2585495489193;797.8843067755143;584.6404461256296;585.8681796595774;590.4862769390614;591.7692100080972;599.2688919518181;10263.79472410555;10365.222608304408;10369.133555959925;10372.533236004398;10526.947365263124;9639.084286992724;9746.415215087118;9794.853077203848;10011.449370284632;10304.79390412195;7632.809179770495;7951.522908625501;7999.880001799977;8041.437099403044;8051.315638170762;2749.024096445753;2773.6948935617065;2777.1113243762006;2819.9013034543896;2837.333226691726;34813.47779783305;35419.64580354215;35681.10797230064;38103.42844857302;41482;7488.288612581796;7586.544807311579;7601.7719468416035;7646.9617651911385;7784.727534536264;16405.507834764976;16407;16425.6714865702;16438.424655137012;16710.08094554811;5834.591578589543;5843.883122337529;5845.912311315334;6037.758489660365;6292.874142517216;3150.7951983121484;3298.060052884964;3302.075418882717;3345.9330813383594;3404.863805447754;2438.3660248335204;2451.9264422067367;2453.227233421502;2484.1057219401;2495.1890635543523;359.3316431437524;364.5006341312366;369.2891184469885;374.7545357790651;374.7601535017591;377.6676524658338;393.94484772131926;399.2195258270133;423.16636226633483;457.7802654725684;6235.812925612239;6677.565958212701;6731.124953755981;6908.9309106909295;6944.166699995932;476.4140107667519;480.8314501597819;497.3286063813895;507.8197239979828;521.1141060197679;3035.605371301717;3114.1903105192814;3151.747860171181;3249.01323138794;3325.534425180477;44483.77758111253;44802.32796508055;45085.098298034514;45720.314195287094;45750.313745293846;39858;40836;44146;44562.10875782466;44629.55370446254;30847.383052338828;31238.375232495677;31255;34185.145371365914;36988;6599.251198432516;6650.434713049445;6798.660066996729;7059.18819335783;7063.894041589483;30078;30277.848610756806;30642.846785765927;31117;31693.683063169072;33913;35156.82421587978;35995.82002090078;37096.6290337104;39214.41178382384;6074.331823499323;6144.201253837151;6285.717142728679;6494.772682956074;6636.933630663824;8978.416402933788;9266.21237194846;9351.906480935104;9568.282378821477;9715.854262185932;8707.521086340312;8846.248068913957;8859.025507194332;8873.556322183995;9064.50145242018;8753.255973242345;8892.86660700103;8901.243394311556;8911.197992180734;9051.185393314634;8467.322614190973;8786.736397908073;8799.47203167812;8826.382153249468;8830.646774128963;7636.50362726421;7802.882956755767;7972.083210430875;8198.098209196864;8292.958535207285;7738;7881.330086942445;7888.6450109744055;8058.153893841062;8178.5092894426525 12:41:58 INFO - 2015-10-30 12:41:58,389 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:41:58 INFO - 2015-10-30 12:41:58,390 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:41:58 INFO - 2015-10-30 12:41:58,390 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1010 12:41:58 INFO - 2015-10-30 12:41:58,390 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:41:58 INFO - 2015-10-30 12:41:58,390 DEBUG : BROWSER_OUTPUT: __startTimestamp1446234118373__endTimestamp 12:41:58 INFO - 2015-10-30 12:41:58,390 DEBUG : BROWSER_OUTPUT: 12:41:58 INFO - 2015-10-30 12:41:58,391 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:41:58 INFO - 2015-10-30 12:41:58,391 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:41:58 INFO - 2015-10-30 12:41:58,391 DEBUG : BROWSER_OUTPUT: 12:41:58 INFO - 2015-10-30 12:41:58,391 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4513.46 Median:4632.95 stddev:475.44 (10.3%) stddev-sans-first:452.48 12:41:58 INFO - 2015-10-30 12:41:58,391 DEBUG : BROWSER_OUTPUT: Values: 2596.4 2671.6 2682.4 2701.2 2727.9 4569.4 4590.0 4595.2 4609.3 4629.1 4588.7 4633.0 4642.6 4668.4 4712.9 4077.2 4221.1 4282.8 4321.2 4470.8 4175.2 4175.6 4258.6 4304.1 4349.3 4367.3 4382.8 4404.6 4423.4 4473.2 4025.4 4337.3 4354.7 4383.6 4419.1 4172.5 4208.7 4254.6 4257.5 4301.4 4442.2 4451.6 4461.4 4463.1 4489.6 4595.9 4747.3 4752.6 4764.3 4797.3 4720.3 4854.6 4863.0 4872.7 4877.4 4484.9 4569.5 4572.3 4572.6 4610.3 4822.6 4971.7 5034.9 5040.2 5042.9 4628.5 4690.0 4695.6 4743.7 4785.4 4933.6 4944.7 4961.4 4986.1 4992.4 4578.3 4843.2 4855.5 4859.0 4881.3 4705.8 4717.8 4726.4 4737.4 4832.6 3696.0 3713.7 3744.9 3745.4 3767.2 3350.6 3403.8 3420.7 3422.2 3424.0 4332.6 4350.2 4443.6 4449.3 4564.8 4919.2 4919.2 4921.1 4954.6 4968.6 4637.7 4664.1 4666.1 4667.4 4691.0 3983.3 4162.2 4166.8 4282.8 4301.4 4821.9 4833.9 4913.8 4949.6 4952.4 4822.2 4836.7 4876.6 4919.6 4925.0 4666.3 4785.6 4850.8 4928.7 4972.6 4737.9 4750.2 4763.5 4855.0 4868.0 4820.2 4823.7 4939.0 4948.3 4973.5 4563.7 4627.4 4630.3 4639.1 4662.8 4614.7 4682.7 4690.0 4693.0 4727.9 4270.2 4502.7 4587.9 4602.8 4612.4 4521.6 4554.3 4636.0 4642.9 4786.9 4617.1 4627.8 4647.6 4656.1 4660.4 12:41:58 INFO - 2015-10-30 12:41:58,392 DEBUG : BROWSER_OUTPUT: 12:41:58 INFO - 2015-10-30 12:41:58,392 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41632.17 Median:319206.20 stddev:72346.35 (22.7%) stddev-sans-first:72483.26 12:41:58 INFO - 2015-10-30 12:41:58,393 DEBUG : BROWSER_OUTPUT: Values: 460.8 469.3 482.5 495.6 515.9 26236.2 27801.4 33263.2 33653.0 33670.7 35304.8 35410.3 35423.6 35463.1 35882.6 6948.4 7129.6 7573.2 7771.0 7898.5 9022.0 9220.9 9318.8 9323.3 9427.8 8950.0 9057.0 9076.1 9084.2 9222.4 7159.2 7487.0 8972.1 9038.9 9271.2 8789.0 8885.9 8911.0 8938.9 8954.9 32816.5 33276.3 33278.8 33285.0 33293.7 2547.4 2585.8 2697.3 2877.0 2892.2 22336.6 22519.0 22929.7 23430.5 23806.9 1968.1 1979.6 2003.7 2045.2 2068.9 260254.0 263476.7 264089.0 267356.0 269212.0 49563.8 49691.8 49723.3 49760.3 50517.7 54097.7 54893.7 55498.4 55510.4 56184.7 14434.7 14474.6 14674.0 14713.8 14917.4 10898.9 11099.7 11161.9 11270.5 11328.8 17192.5 17249.7 17265.4 17354.8 17426.0 7267.3 7336.9 7342.6 7391.3 7405.8 725.2 731.0 795.6 800.0 814.8 23744.8 23930.8 24040.5 24469.1 24559.4 811.3 875.0 878.0 988.9 1008.8 11493.6 12611.4 12635.2 12826.6 12856.3 318423.4 319989.0 320626.0 326863.0 327387.0 44706.3 45303.3 46002.5 46495.5 51530.2 1191.0 1193.7 1209.0 1214.4 1218.0 23257.7 23855.8 24457.0 24946.6 24993.5 37632.6 38556.2 42234.6 43652.3 43921.0 229024.0 230744.0 231203.0 233674.0 236072.0 26208.9 26379.0 27054.2 27165.9 27343.2 33540.3 34327.3 34609.3 34743.5 35485.6 29189.7 29205.9 29629.4 29681.6 32314.8 29192.4 29225.0 29885.6 30316.0 30353.0 30711.2 30879.4 30891.4 32856.8 33599.7 26101.5 26738.5 27158.7 27327.9 27340.5 20551.3 20588.0 20858.3 20941.0 21584.5 12:41:58 INFO - 2015-10-30 12:41:58,393 DEBUG : BROWSER_OUTPUT: 12:41:58 INFO - 2015-10-30 12:41:58,393 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23992.53 Median:4834.05 stddev:77263.95 (1598.3%) stddev-sans-first:77460.20 12:41:58 INFO - 2015-10-30 12:41:58,395 DEBUG : BROWSER_OUTPUT: Values: 291.1 294.6 296.4 296.7 297.0 12246.2 12631.4 14069.9 14772.2 15036.2 12729.2 14872.6 14951.5 15288.1 15311.2 4387.3 4400.3 4508.5 4515.3 4543.6 3348.1 3399.5 3447.0 4501.8 4549.1 4581.5 4761.2 4811.3 4856.8 4874.9 4509.6 4591.0 4761.7 4864.2 4866.0 4256.3 4273.5 4345.0 4345.9 4352.8 18080.0 18548.0 18626.9 18643.3 18675.8 1669.4 1727.5 1785.7 1830.6 1906.7 10390.7 10495.9 10515.4 10675.1 10926.0 1359.7 1384.6 1404.0 1417.9 1418.4 49077.0 49679.8 49790.5 50404.7 50416.7 7557.0 7588.2 7772.5 7845.5 7929.2 9529.8 9538.0 9548.4 9552.1 9552.8 6123.9 6124.2 6210.7 6223.7 6226.8 6172.1 6246.3 6261.6 6265.0 6320.2 4270.5 4288.0 4338.4 4387.4 4428.6 1307.9 1308.7 1315.3 1332.5 1367.2 775.9 782.9 785.0 791.4 920.1 15515.3 15736.7 15807.7 16042.6 16149.2 711.6 785.1 790.0 846.7 872.8 6364.5 8592.1 9012.1 9022.2 9126.8 468472.0 470273.0 472296.0 475135.0 477223.0 58052.4 61719.4 62307.7 62432.7 63483.7 391.3 402.0 402.5 404.3 405.4 9355.6 9378.3 9439.7 9486.0 9718.2 29744.4 30525.5 30830.7 31636.8 31834.2 36751.4 41370.8 42028.6 42666.4 43696.3 4978.3 5070.6 5075.5 5146.8 5169.0 9086.8 9572.4 9622.3 9708.9 9768.2 8136.2 8333.8 8385.4 8419.3 8433.6 7459.5 7975.6 8025.7 8073.3 8307.6 6819.5 8391.6 8449.6 8644.8 8810.0 5224.5 5299.0 5311.0 5352.2 5419.3 8489.2 8575.2 8589.5 8620.9 8796.8 12:41:58 INFO - 2015-10-30 12:41:58,395 DEBUG : BROWSER_OUTPUT: 12:41:58 INFO - 2015-10-30 12:41:58,395 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4529.07 Median:5718.14 stddev:2340.96 (40.9%) stddev-sans-first:2334.67 12:41:58 INFO - 2015-10-30 12:41:58,397 DEBUG : BROWSER_OUTPUT: Values: 1264.2 1384.9 1435.6 1466.6 1497.0 6048.2 6160.4 6169.7 6321.1 6390.1 6345.8 6370.0 6598.6 6620.9 6627.9 1760.8 1770.2 1790.9 1800.4 1801.8 1779.5 1819.0 1830.2 1831.9 1872.5 1820.6 1838.0 1854.2 1859.5 1869.3 1758.2 1781.2 1825.4 1826.7 1828.2 1772.6 1860.0 1877.2 1896.8 1899.3 5696.8 6421.9 6479.0 6479.6 6496.1 3493.5 3934.1 4030.4 4038.3 4046.0 2292.5 2348.4 2405.0 2406.4 2406.8 612.8 723.2 748.1 756.5 766.7 8592.1 8606.7 8641.4 8763.8 8802.0 3561.6 3573.5 3581.6 3587.2 3588.1 7633.3 7780.3 7784.4 7790.0 7791.5 4018.0 4018.5 4042.9 4105.2 4141.7 3694.6 3731.1 3741.0 3745.6 3750.0 3019.9 3032.3 3033.2 3065.9 3075.6 959.8 971.0 971.3 985.2 991.9 1058.8 1068.7 1073.5 1096.1 1100.8 6096.4 6100.1 6247.1 6252.7 6254.5 388.9 1019.6 1019.6 1048.0 1071.8 4524.5 4662.0 4672.6 4674.1 4680.0 7448.2 7639.9 7822.1 7835.9 7850.7 7598.5 7617.9 7767.3 7768.7 7797.0 5149.7 5592.8 6006.6 6091.8 6169.9 6052.4 6091.0 6146.0 6196.9 6204.4 6522.6 6690.1 6845.0 6864.3 6906.5 6776.1 6950.2 6992.5 7208.1 7211.6 5727.4 5886.6 5939.4 5943.3 5951.6 6309.5 6330.6 6343.9 6347.5 6426.8 5559.2 5924.3 5951.7 5973.4 6081.2 5666.1 5708.9 5850.4 5880.9 5905.1 5784.0 5851.9 5861.0 5900.4 5949.3 5184.0 5325.4 5362.8 5381.3 5471.2 5401.2 5481.5 5520.5 5521.3 5525.8 12:41:58 INFO - 2015-10-30 12:41:58,397 DEBUG : BROWSER_OUTPUT: 12:41:58 INFO - 2015-10-30 12:41:58,398 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4378.47 Median:5058.45 stddev:1317.36 (26.0%) stddev-sans-first:1284.41 12:41:58 INFO - 2015-10-30 12:41:58,398 DEBUG : BROWSER_OUTPUT: Values: 267.3 273.5 274.4 279.9 285.0 4795.9 4907.4 5028.5 5033.0 5073.0 4711.0 4965.0 4974.8 4977.2 4983.8 3848.8 3852.7 3855.2 3871.7 3876.1 3803.8 3867.8 3872.0 3874.1 3952.4 3814.7 3842.9 3883.8 3897.1 3899.7 3876.2 3881.9 3894.6 3914.6 3932.0 3392.6 3395.0 3398.7 3406.3 3416.3 4806.9 4812.1 4812.4 4820.5 4917.6 4314.5 4324.2 4352.6 4363.5 4429.1 5167.6 5176.1 5199.9 5202.7 5203.3 3591.5 3592.0 3594.8 3605.0 3612.7 5430.5 5431.2 5432.4 5445.8 5450.6 3471.6 3518.9 3521.2 3562.8 3563.8 3334.2 3668.8 3687.0 3687.2 3706.6 4285.1 4286.1 4293.5 4299.5 4313.5 5051.5 5128.7 5150.6 5190.7 5195.0 1331.9 1335.5 1337.8 1338.9 1341.1 877.5 895.6 902.6 906.2 919.0 5016.6 5060.9 5081.7 5087.1 5099.6 5448.4 5459.3 5474.4 5480.5 5483.4 4971.5 5053.0 5055.9 5065.4 5089.7 2898.9 2954.9 2977.9 3015.4 3016.2 5523.8 5525.6 5545.6 5545.6 5550.7 5568.0 5572.2 5574.9 5575.4 5599.9 5506.2 5506.4 5509.2 5513.0 5524.2 5206.9 5337.0 5429.5 5441.9 5483.3 5140.5 5244.8 5316.7 5325.2 5416.1 5429.5 5496.7 5501.4 5509.1 5529.4 3442.3 3443.4 3446.1 3450.0 3452.9 5209.7 5379.7 5385.5 5409.5 5471.8 5306.5 5313.7 5314.3 5325.8 5385.6 5291.7 5293.8 5296.2 5326.4 5392.0 5158.7 5161.5 5169.9 5184.9 5232.6 5114.3 5227.9 5238.8 5239.6 5314.6 4979.7 5053.3 5127.4 5150.4 5151.3 12:41:58 INFO - 2015-10-30 12:41:58,398 DEBUG : BROWSER_OUTPUT: 12:41:58 INFO - 2015-10-30 12:41:58,398 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10914.09 Median:3215.89 stddev:12719.37 (395.5%) stddev-sans-first:12731.25 12:41:58 INFO - 2015-10-30 12:41:58,399 DEBUG : BROWSER_OUTPUT: Values: 551.4 614.8 618.8 625.5 637.8 10136.6 10150.8 10365.0 10372.3 10423.1 9577.0 10136.9 10203.9 10821.4 10926.4 746.0 748.2 753.3 756.7 760.8 732.8 748.7 757.7 772.0 772.1 792.1 793.0 793.2 803.3 809.1 769.1 788.8 795.9 797.3 797.9 584.6 585.9 590.5 591.8 599.3 10263.8 10365.2 10369.1 10372.5 10526.9 9639.1 9746.4 9794.9 10011.4 10304.8 7632.8 7951.5 7999.9 8041.4 8051.3 2749.0 2773.7 2777.1 2819.9 2837.3 34813.5 35419.6 35681.1 38103.4 41482.0 7488.3 7586.5 7601.8 7647.0 7784.7 16405.5 16407.0 16425.7 16438.4 16710.1 5834.6 5843.9 5845.9 6037.8 6292.9 3150.8 3298.1 3302.1 3345.9 3404.9 2438.4 2451.9 2453.2 2484.1 2495.2 359.3 364.5 369.3 374.8 374.8 377.7 393.9 399.2 423.2 457.8 6235.8 6677.6 6731.1 6908.9 6944.2 476.4 480.8 497.3 507.8 521.1 3035.6 3114.2 3151.7 3249.0 3325.5 44483.8 44802.3 45085.1 45720.3 45750.3 39858.0 40836.0 44146.0 44562.1 44629.6 30847.4 31238.4 31255.0 34185.1 36988.0 6599.3 6650.4 6798.7 7059.2 7063.9 30078.0 30277.8 30642.8 31117.0 31693.7 33913.0 35156.8 35995.8 37096.6 39214.4 6074.3 6144.2 6285.7 6494.8 6636.9 8978.4 9266.2 9351.9 9568.3 9715.9 8707.5 8846.2 8859.0 8873.6 9064.5 8753.3 8892.9 8901.2 8911.2 9051.2 8467.3 8786.7 8799.5 8826.4 8830.6 7636.5 7802.9 7972.1 8198.1 8293.0 7738.0 7881.3 7888.6 8058.2 8178.5 12:41:58 INFO - 2015-10-30 12:41:58,399 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:41:58 INFO - 2015-10-30 12:41:58,399 DEBUG : BROWSER_OUTPUT: 12:41:59 INFO - 2015-10-30 12:41:59,062 INFO : Browser exited with error code: 0 12:41:59 INFO - 2015-10-30 12:41:59,095 INFO : Completed test dromaeo_css (00:18:36) 12:41:59 INFO - 2015-10-30 12:41:59,095 INFO : Starting test kraken 12:41:59 INFO - 2015-10-30 12:41:59,095 DEBUG : operating with platform_type : mac_ 12:41:59 INFO - 2015-10-30 12:41:59,095 INFO : Initialising browser for kraken test... 12:41:59 INFO - 2015-10-30 12:41:59,111 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmp9zq9wL/profile http://localhost:49265/getInfo.html 12:42:01 INFO - 2015-10-30 12:42:01,828 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:42:01 INFO - 2015-10-30 12:42:01,828 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:42:01 INFO - 2015-10-30 12:42:01,828 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:42:01 INFO - 2015-10-30 12:42:01,829 DEBUG : BROWSER_OUTPUT: __metrics 12:42:01 INFO - 2015-10-30 12:42:01,848 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:42:02 INFO - 2015-10-30 12:42:02,677 INFO : Browser initialized. 12:42:02 INFO - 2015-10-30 12:42:02,678 INFO : Running cycle 1/1 for kraken test... 12:42:02 INFO - 2015-10-30 12:42:02,678 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmp9zq9wL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:42:14 INFO - 2015-10-30 12:42:14,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 200282112 12:42:14 INFO - 2015-10-30 12:42:14,833 DEBUG : BROWSER_OUTPUT: 12:42:17 INFO - 2015-10-30 12:42:17,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 12:42:18 INFO - 2015-10-30 12:42:18,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 266518528 12:42:18 INFO - 2015-10-30 12:42:18,486 DEBUG : BROWSER_OUTPUT: 12:42:21 INFO - 2015-10-30 12:42:21,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 12:42:22 INFO - 2015-10-30 12:42:22,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 281608192 12:42:22 INFO - 2015-10-30 12:42:22,211 DEBUG : BROWSER_OUTPUT: 12:42:25 INFO - 2015-10-30 12:42:25,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 12:42:26 INFO - 2015-10-30 12:42:26,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 269893632 12:42:26 INFO - 2015-10-30 12:42:26,150 DEBUG : BROWSER_OUTPUT: 12:42:28 INFO - 2015-10-30 12:42:28,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 12:42:29 INFO - 2015-10-30 12:42:29,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 270438400 12:42:29 INFO - 2015-10-30 12:42:29,111 DEBUG : BROWSER_OUTPUT: 12:42:31 INFO - 2015-10-30 12:42:31,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:42:32 INFO - 2015-10-30 12:42:32,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 269852672 12:42:32 INFO - 2015-10-30 12:42:32,248 DEBUG : BROWSER_OUTPUT: 12:42:35 INFO - 2015-10-30 12:42:35,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 12:42:36 INFO - 2015-10-30 12:42:36,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 266813440 12:42:36 INFO - 2015-10-30 12:42:36,504 DEBUG : BROWSER_OUTPUT: 12:42:40 INFO - 2015-10-30 12:42:40,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 12:42:40 INFO - 2015-10-30 12:42:40,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 267079680 12:42:40 INFO - 2015-10-30 12:42:40,882 DEBUG : BROWSER_OUTPUT: 12:42:44 INFO - 2015-10-30 12:42:44,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 12:42:44 INFO - 2015-10-30 12:42:44,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 268214272 12:42:44 INFO - 2015-10-30 12:42:44,894 DEBUG : BROWSER_OUTPUT: 12:42:46 INFO - 2015-10-30 12:42:46,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:42:47 INFO - 2015-10-30 12:42:47,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 300503040 12:42:47 INFO - 2015-10-30 12:42:47,282 DEBUG : BROWSER_OUTPUT: 12:42:49 INFO - 2015-10-30 12:42:49,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:42:50 INFO - 2015-10-30 12:42:50,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 304140288 12:42:50 INFO - 2015-10-30 12:42:50,007 DEBUG : BROWSER_OUTPUT: 12:42:52 INFO - 2015-10-30 12:42:52,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:42:52 INFO - 2015-10-30 12:42:52,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 309510144 12:42:52 INFO - 2015-10-30 12:42:52,989 DEBUG : BROWSER_OUTPUT: 12:42:56 INFO - 2015-10-30 12:42:56,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:42:56 INFO - 2015-10-30 12:42:56,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 311816192 12:42:56 INFO - 2015-10-30 12:42:56,614 DEBUG : BROWSER_OUTPUT: 12:42:59 INFO - 2015-10-30 12:42:59,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:43:00 INFO - 2015-10-30 12:43:00,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 309354496 12:43:00 INFO - 2015-10-30 12:43:00,205 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 12:43:02 INFO - 2015-10-30 12:43:02,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 369864704 12:43:02 INFO - 2015-10-30 12:43:02,437 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,438 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:43:02 INFO - 2015-10-30 12:43:02,438 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:43:02 INFO - 2015-10-30 12:43:02,438 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:43:02 INFO - 2015-10-30 12:43:02,438 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:43:02 INFO - 2015-10-30 12:43:02,439 DEBUG : BROWSER_OUTPUT: |0;ai-astar;134;138;138;139;137;135;141;138;141;138 12:43:02 INFO - 2015-10-30 12:43:02,439 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;186;165;206;192;161;184;161;196;192;153 12:43:02 INFO - 2015-10-30 12:43:02,439 DEBUG : BROWSER_OUTPUT: |2;audio-dft;196;195;205;204;199;197;197;197;205;205 12:43:02 INFO - 2015-10-30 12:43:02,439 DEBUG : BROWSER_OUTPUT: |3;audio-fft;94;100;95;152;85;88;90;88;145;85 12:43:02 INFO - 2015-10-30 12:43:02,439 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;119;120;172;113;114;116;156;111;110;152 12:43:02 INFO - 2015-10-30 12:43:02,439 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;156;148;156;142;148;156;149;155;143 12:43:02 INFO - 2015-10-30 12:43:02,439 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;162;162;161;157;154;161;161;161;154;162 12:43:02 INFO - 2015-10-30 12:43:02,439 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;129;128;129;128;128;129;129;130;130;130 12:43:02 INFO - 2015-10-30 12:43:02,440 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;72;77;77;76;81;79;89;73;73 12:43:02 INFO - 2015-10-30 12:43:02,440 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;79;80;81;86;85;86;86;85;84 12:43:02 INFO - 2015-10-30 12:43:02,440 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;100;100;104;103;104;105;106;105;106;110 12:43:02 INFO - 2015-10-30 12:43:02,440 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;163;152;161;154;155;161;156;154;156;156 12:43:02 INFO - 2015-10-30 12:43:02,440 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;174;174;174;186;184;175;177;184;184;176 12:43:02 INFO - 2015-10-30 12:43:02,440 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;82;82;83;88;88;89;90;88;89;88 12:43:02 INFO - 2015-10-30 12:43:02,440 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:43:02 INFO - 2015-10-30 12:43:02,441 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:43:02 INFO - 2015-10-30 12:43:02,441 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,989 12:43:02 INFO - 2015-10-30 12:43:02,441 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:43:02 INFO - 2015-10-30 12:43:02,441 DEBUG : BROWSER_OUTPUT: __startTimestamp1446234182437__endTimestamp 12:43:02 INFO - 2015-10-30 12:43:02,441 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,443 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:43:02 INFO - 2015-10-30 12:43:02,443 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:43:02 INFO - 2015-10-30 12:43:02,443 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,444 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:137.90 Median:138.00 stddev:2.23 (1.6%) stddev-sans-first:1.87 12:43:02 INFO - 2015-10-30 12:43:02,444 DEBUG : BROWSER_OUTPUT: Values: 134.0 138.0 138.0 139.0 137.0 135.0 141.0 138.0 141.0 138.0 12:43:02 INFO - 2015-10-30 12:43:02,444 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,444 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:179.60 Median:189.00 stddev:18.09 (9.6%) stddev-sans-first:19.04 12:43:02 INFO - 2015-10-30 12:43:02,444 DEBUG : BROWSER_OUTPUT: Values: 186.0 165.0 206.0 192.0 161.0 184.0 161.0 196.0 192.0 153.0 12:43:02 INFO - 2015-10-30 12:43:02,444 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,445 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:200.00 Median:201.50 stddev:4.22 (2.1%) stddev-sans-first:4.22 12:43:02 INFO - 2015-10-30 12:43:02,445 DEBUG : BROWSER_OUTPUT: Values: 196.0 195.0 205.0 204.0 199.0 197.0 197.0 197.0 205.0 205.0 12:43:02 INFO - 2015-10-30 12:43:02,445 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,445 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:102.20 Median:88.00 stddev:24.90 (28.3%) stddev-sans-first:26.23 12:43:02 INFO - 2015-10-30 12:43:02,445 DEBUG : BROWSER_OUTPUT: Values: 94.0 100.0 95.0 152.0 85.0 88.0 90.0 88.0 145.0 85.0 12:43:02 INFO - 2015-10-30 12:43:02,445 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,446 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:128.30 Median:119.50 stddev:22.65 (19.0%) stddev-sans-first:23.77 12:43:02 INFO - 2015-10-30 12:43:02,446 DEBUG : BROWSER_OUTPUT: Values: 119.0 120.0 172.0 113.0 114.0 116.0 156.0 111.0 110.0 152.0 12:43:02 INFO - 2015-10-30 12:43:02,446 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,446 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:150.20 Median:152.00 stddev:5.33 (3.5%) stddev-sans-first:5.63 12:43:02 INFO - 2015-10-30 12:43:02,446 DEBUG : BROWSER_OUTPUT: Values: 149.0 156.0 148.0 156.0 142.0 148.0 156.0 149.0 155.0 143.0 12:43:02 INFO - 2015-10-30 12:43:02,446 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,447 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:159.50 Median:161.00 stddev:3.24 (2.0%) stddev-sans-first:3.31 12:43:02 INFO - 2015-10-30 12:43:02,447 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 157.0 154.0 161.0 161.0 161.0 154.0 162.0 12:43:02 INFO - 2015-10-30 12:43:02,447 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,447 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:129.00 Median:129.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 12:43:02 INFO - 2015-10-30 12:43:02,447 DEBUG : BROWSER_OUTPUT: Values: 129.0 128.0 129.0 128.0 128.0 129.0 129.0 130.0 130.0 130.0 12:43:02 INFO - 2015-10-30 12:43:02,449 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,449 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.60 Median:77.00 stddev:5.62 (7.3%) stddev-sans-first:5.25 12:43:02 INFO - 2015-10-30 12:43:02,449 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 77.0 77.0 76.0 81.0 79.0 89.0 73.0 73.0 12:43:02 INFO - 2015-10-30 12:43:02,449 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,449 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:82.60 Median:85.00 stddev:4.01 (4.7%) stddev-sans-first:2.79 12:43:02 INFO - 2015-10-30 12:43:02,450 DEBUG : BROWSER_OUTPUT: Values: 74.0 79.0 80.0 81.0 86.0 85.0 86.0 86.0 85.0 84.0 12:43:02 INFO - 2015-10-30 12:43:02,450 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,450 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:104.30 Median:105.00 stddev:2.95 (2.8%) stddev-sans-first:2.68 12:43:02 INFO - 2015-10-30 12:43:02,450 DEBUG : BROWSER_OUTPUT: Values: 100.0 100.0 104.0 103.0 104.0 105.0 106.0 105.0 106.0 110.0 12:43:02 INFO - 2015-10-30 12:43:02,450 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,450 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:156.80 Median:156.00 stddev:3.61 (2.3%) stddev-sans-first:3.06 12:43:02 INFO - 2015-10-30 12:43:02,450 DEBUG : BROWSER_OUTPUT: Values: 163.0 152.0 161.0 154.0 155.0 161.0 156.0 154.0 156.0 156.0 12:43:02 INFO - 2015-10-30 12:43:02,451 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,451 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:180.50 stddev:5.03 (2.8%) stddev-sans-first:5.02 12:43:02 INFO - 2015-10-30 12:43:02,451 DEBUG : BROWSER_OUTPUT: Values: 174.0 174.0 174.0 186.0 184.0 175.0 177.0 184.0 184.0 176.0 12:43:02 INFO - 2015-10-30 12:43:02,451 DEBUG : BROWSER_OUTPUT: 12:43:02 INFO - 2015-10-30 12:43:02,451 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.70 Median:88.00 stddev:3.09 (3.5%) stddev-sans-first:2.77 12:43:02 INFO - 2015-10-30 12:43:02,451 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 83.0 88.0 88.0 89.0 90.0 88.0 89.0 88.0 12:43:02 INFO - 2015-10-30 12:43:02,451 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:43:02 INFO - 2015-10-30 12:43:02,452 DEBUG : BROWSER_OUTPUT: 12:43:03 INFO - 2015-10-30 12:43:03,218 INFO : Browser exited with error code: 0 12:43:03 INFO - 2015-10-30 12:43:03,278 INFO : Completed test kraken (00:01:04) 12:43:03 INFO - 2015-10-30 12:43:03,278 INFO : Starting test v8_7 12:43:03 INFO - 2015-10-30 12:43:03,278 DEBUG : operating with platform_type : mac_ 12:43:03 INFO - 2015-10-30 12:43:03,278 INFO : Initialising browser for v8_7 test... 12:43:03 INFO - 2015-10-30 12:43:03,294 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmp1ezDiw/profile http://localhost:49265/getInfo.html 12:43:05 INFO - 2015-10-30 12:43:05,911 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:43:05 INFO - 2015-10-30 12:43:05,911 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:43:05 INFO - 2015-10-30 12:43:05,911 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:43:05 INFO - 2015-10-30 12:43:05,912 DEBUG : BROWSER_OUTPUT: __metrics 12:43:05 INFO - 2015-10-30 12:43:05,929 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:43:06 INFO - 2015-10-30 12:43:06,247 DEBUG : BROWSER_OUTPUT: console.error: 12:43:06 INFO - 2015-10-30 12:43:06,247 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 12:43:06 INFO - 2015-10-30 12:43:06,247 DEBUG : BROWSER_OUTPUT: Stack: 12:43:06 INFO - 2015-10-30 12:43:06,247 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 12:43:06 INFO - 2015-10-30 12:43:06,248 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 12:43:06 INFO - 2015-10-30 12:43:06,248 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 12:43:06 INFO - 2015-10-30 12:43:06,248 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 12:43:06 INFO - 2015-10-30 12:43:06,248 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 12:43:06 INFO - 2015-10-30 12:43:06,248 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 12:43:06 INFO - 2015-10-30 12:43:06,248 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:43:06 INFO - 2015-10-30 12:43:06,249 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 12:43:06 INFO - 2015-10-30 12:43:06,249 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:43:06 INFO - 2015-10-30 12:43:06,249 DEBUG : BROWSER_OUTPUT: 12:43:06 INFO - 2015-10-30 12:43:06,848 INFO : Browser initialized. 12:43:06 INFO - 2015-10-30 12:43:06,849 INFO : Running cycle 1/1 for v8_7 test... 12:43:06 INFO - 2015-10-30 12:43:06,849 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmp1ezDiw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:43:19 INFO - 2015-10-30 12:43:19,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 201539584 12:43:19 INFO - 2015-10-30 12:43:19,018 DEBUG : BROWSER_OUTPUT: 12:43:41 INFO - 2015-10-30 12:43:41,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/v8_7/run.html (next: http://localhost:49265/tests/v8_7/run.html) 12:43:42 INFO - 2015-10-30 12:43:42,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 521154560 12:43:42 INFO - 2015-10-30 12:43:42,178 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,178 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:43:42 INFO - 2015-10-30 12:43:42,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:43:42 INFO - 2015-10-30 12:43:42,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:43:42 INFO - 2015-10-30 12:43:42,178 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:43:42 INFO - 2015-10-30 12:43:42,178 DEBUG : BROWSER_OUTPUT: |0;Richards;205.5076037813399 12:43:42 INFO - 2015-10-30 12:43:42,179 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;241.3709872073377 12:43:42 INFO - 2015-10-30 12:43:42,179 DEBUG : BROWSER_OUTPUT: |2;Encrypt;403.2258064516129 12:43:42 INFO - 2015-10-30 12:43:42,179 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7084.507042253521 12:43:42 INFO - 2015-10-30 12:43:42,179 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1267.427122940431 12:43:42 INFO - 2015-10-30 12:43:42,179 DEBUG : BROWSER_OUTPUT: |5;Earley;846.740050804403 12:43:42 INFO - 2015-10-30 12:43:42,179 DEBUG : BROWSER_OUTPUT: |6;Boyer;15318.181818181818 12:43:42 INFO - 2015-10-30 12:43:42,179 DEBUG : BROWSER_OUTPUT: |7;RegExp;35491.228070175435 12:43:42 INFO - 2015-10-30 12:43:42,179 DEBUG : BROWSER_OUTPUT: |8;Splay;785.6025039123631 12:43:42 INFO - 2015-10-30 12:43:42,179 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7020.979020979021 12:43:42 INFO - 2015-10-30 12:43:42,180 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:43:42 INFO - 2015-10-30 12:43:42,180 DEBUG : BROWSER_OUTPUT: __startTimestamp1446234222171__endTimestamp 12:43:42 INFO - 2015-10-30 12:43:42,180 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,180 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:43:42 INFO - 2015-10-30 12:43:42,180 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:43:42 INFO - 2015-10-30 12:43:42,180 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,180 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:205.51 Median:205.51 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,181 DEBUG : BROWSER_OUTPUT: Values: 205.5 12:43:42 INFO - 2015-10-30 12:43:42,181 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,181 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:241.37 Median:241.37 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,181 DEBUG : BROWSER_OUTPUT: Values: 241.4 12:43:42 INFO - 2015-10-30 12:43:42,181 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,181 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:403.23 Median:403.23 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,181 DEBUG : BROWSER_OUTPUT: Values: 403.2 12:43:42 INFO - 2015-10-30 12:43:42,181 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,182 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7084.51 Median:7084.51 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,182 DEBUG : BROWSER_OUTPUT: Values: 7084.5 12:43:42 INFO - 2015-10-30 12:43:42,182 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,182 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1267.43 Median:1267.43 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,182 DEBUG : BROWSER_OUTPUT: Values: 1267.4 12:43:42 INFO - 2015-10-30 12:43:42,182 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,182 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:846.74 Median:846.74 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,183 DEBUG : BROWSER_OUTPUT: Values: 846.7 12:43:42 INFO - 2015-10-30 12:43:42,183 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,183 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15318.18 Median:15318.18 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,183 DEBUG : BROWSER_OUTPUT: Values: 15318.2 12:43:42 INFO - 2015-10-30 12:43:42,183 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,183 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35491.23 Median:35491.23 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,183 DEBUG : BROWSER_OUTPUT: Values: 35491.2 12:43:42 INFO - 2015-10-30 12:43:42,183 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,183 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:785.60 Median:785.60 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,184 DEBUG : BROWSER_OUTPUT: Values: 785.6 12:43:42 INFO - 2015-10-30 12:43:42,184 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,184 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7020.98 Median:7020.98 stddev:0.00 (0.0%) 12:43:42 INFO - 2015-10-30 12:43:42,184 DEBUG : BROWSER_OUTPUT: Values: 7021.0 12:43:42 INFO - 2015-10-30 12:43:42,184 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:43:42 INFO - 2015-10-30 12:43:42,184 DEBUG : BROWSER_OUTPUT: 12:43:42 INFO - 2015-10-30 12:43:42,910 INFO : Browser exited with error code: 0 12:43:42 INFO - 2015-10-30 12:43:42,934 INFO : Completed test v8_7 (00:00:39) 12:43:42 INFO - 2015-10-30 12:43:42,941 INFO : Completed test suite (00:20:20) 12:43:42 INFO - 2015-10-30 12:43:42,941 DEBUG : Working with test: dromaeo_css 12:43:42 INFO - 2015-10-30 12:43:42,941 DEBUG : Generating results file: dromaeo_css 12:43:42 INFO - 2015-10-30 12:43:42,942 DEBUG : Working with test: kraken 12:43:42 INFO - 2015-10-30 12:43:42,942 DEBUG : Generating results file: kraken 12:43:42 INFO - 2015-10-30 12:43:42,942 INFO : javascript benchmark 12:43:42 INFO - 2015-10-30 12:43:42,942 DEBUG : Working with test: v8_7 12:43:42 INFO - 2015-10-30 12:43:42,942 DEBUG : Generating results file: v8_7 12:43:42 INFO - 2015-10-30 12:43:42,943 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:43:43 INFO - 2015-10-30 12:43:43,012 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 12:43:43 INFO - 2015-10-30 12:43:43,013 DEBUG : process_Request line: dromaeo_css 5727.95 graph.html#tests=[[72,52,55]] 12:43:43 INFO - 2015-10-30 12:43:43,013 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:43:43 INFO - 2015-10-30 12:43:43,143 DEBUG : process_Request line: kraken 1872.50 graph.html#tests=[[232,52,55]] 12:43:43 INFO - 2015-10-30 12:43:43,143 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:43:43 INFO - 2015-10-30 12:43:43,175 DEBUG : process_Request line: v8_7 16375.86 graph.html#tests=[[230,52,55]] 12:43:43 INFO - 2015-10-30 12:43:43,176 INFO : javascript benchmark 12:43:43 INFO - 2015-10-30 12:43:43,178 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [291.10775473174704, 294.6125844514464, 296.41753953481407, 296.6795860470691, 297.0375981818906, 12246.203996740205, 12631.368431578407, 14069.859301406983, 14772.210243120815, 15036.173010484432, 12729.236245825257, 14872.62818429537, 14951.47669831556, 15288.082715037077, 15311.157886316249, 4387.276099443588, 4400.251957167273, 4508.458984921814, 4515.345274935149, 4543.591076803087, 3348.11275012122, 3399.5240666306613, 3447.034830247522, 4501.774911254441, 4549.11292298002, 4581.496035436099, 4761.2143996240575, 4811.326414302001, 4856.781444834991, 4874.926876096862, 4509.6392288616835, 4590.954090459086, 4761.714297142165, 4864.173090574611, 4865.975670121662, 4256.2764330063965, 4273.487181538236, 4344.978275108636, 4345.869623911288, 4352.804123814436, 18080.0, 18548.0, 18626.906865465586, 18643.347482838035, 18675.813241867545, 1669.3656410564029, 1727.5076603168036, 1785.7053586158268, 1830.606419619788, 1906.6663333916508, 10390.740231494197, 10495.895041049644, 10515.421651809147, 10675.092617127553, 10926.0, 1359.7416490866703, 1384.6399936016708, 1404.0101728281638, 1417.8794802441805, 1418.3830033935271, 49077.0, 49679.75160124176, 49790.50209497895, 50404.74797626025, 50416.74791626055, 7556.962215188999, 7588.165301816795, 7772.533647981139, 7845.450818442769, 7929.246721561442, 9529.761755956157, 9537.952310238405, 9548.42709437436, 9552.092551207625, 9552.808943821223, 6123.9387606124255, 6124.173236613, 6210.689465526796, 6223.657698826608, 6226.782062627786, 6172.086653137452, 6246.281677607042, 6261.624302541862, 6265.0, 6320.178376810985, 4270.50889147752, 4288.035192081757, 4338.436003319548, 4387.420528609698, 4428.579284967923, 1307.9346032698327, 1308.7447947650307, 1315.2568798628745, 1332.5202926946292, 1367.1523655333756, 775.9418043646749, 782.9491083079581, 784.9921500784919, 791.3589992106412, 920.1304766995125, 15515.301811418512, 15736.68526629461, 15807.683846323009, 16042.598935026717, 16149.192540372935, 711.5623891306913, 785.1285073568334, 789.9565523896126, 846.6613354658062, 872.829798189347, 6364.522660800459, 8592.140785921358, 9012.143846334588, 9022.188003079624, 9126.771830704285, 468472.0, 470273.0, 472296.0, 475135.0, 477223.0, 58052.419475805546, 61719.382806171365, 62307.68846155831, 62432.68783656053, 63483.6825815868, 391.26637554585153, 402.0331103695675, 402.48280958967587, 404.3288141684789, 405.4020320027994, 9355.625774968925, 9378.296627752808, 9439.716808495756, 9486.0, 9718.173955213602, 29744.405111898075, 30525.542116867822, 30830.691693082783, 31636.841815791693, 31834.204144896565, 36751.448728269635, 41370.79314603408, 42028.57971420247, 42666.36000459934, 43696.344554832336, 4978.32792572998, 5070.569001634903, 5075.543201111917, 5146.819861304986, 5168.9741551292, 9086.818263634557, 9572.425654460754, 9622.278329125204, 9708.902910970799, 9768.218542516439, 8136.22705842944, 8333.791655208668, 8385.371097167616, 8419.284360829399, 8433.578321084044, 7459.477836551389, 7975.601219939096, 8025.678972841021, 8073.313768329758, 8307.626156822836, 6819.454443644596, 8391.622376993171, 8449.577521124042, 8644.78388040304, 8810.03089660124, 5224.477552244745, 5299.046171688979, 5311.017461769585, 5352.197170424468, 5419.34967803866, 8489.193526614961, 8575.228229459379, 8589.52757598338, 8620.913790862262, 8796.824063518821], "dojo.html": [2596.389848385629, 2671.585904184852, 2682.3830518980644, 2701.1626395817298, 2727.904523341683, 4569.383133277007, 4589.954100458995, 4595.218812801823, 4609.262517997113, 4629.120467111246, 4588.7476188809605, 4632.953670463295, 4642.628589712824, 4668.439787225538, 4712.882177945545, 4077.1641813428178, 4221.134667393177, 4282.785860706976, 4321.200577893084, 4470.843520476784, 4175.227582897173, 4175.582441755831, 4258.552851950547, 4304.117655880553, 4349.34759786033, 4367.257566213735, 4382.824687012531, 4404.581564751344, 4423.358613001113, 4473.1501014807245, 4025.416314634391, 4337.284348082562, 4354.716943398669, 4383.627391671712, 4419.138268037734, 4172.499300083979, 4208.705390622657, 4254.595813397722, 4257.467816522934, 4301.354796780477, 4442.244818380883, 4451.554844515555, 4461.375407442961, 4463.062756821071, 4489.573490518395, 4595.931061034087, 4747.311639812208, 4752.619790416758, 4764.309175169581, 4797.2564252540915, 4720.33915251865, 4854.6359023073055, 4863.0, 4872.65891387603, 4877.414710234759, 4484.865454036384, 4569.497355290915, 4572.268437050056, 4572.565606267399, 4610.2854057621125, 4822.614190864792, 4971.651984361132, 5034.874128146753, 5040.168372218616, 5042.873928151752, 4628.514006029386, 4690.0, 4695.647826413033, 4743.691660042086, 4785.425748910153, 4933.629977751683, 4944.678595891256, 4961.4294356148785, 4986.102501549683, 4992.375953005874, 4578.290364993365, 4843.2250839865455, 4855.490173531799, 4858.95141048585, 4881.267809828483, 4705.788239529229, 4717.764111794397, 4726.432828060655, 4737.38414006177, 4832.565069143794, 3695.9630403696156, 3713.6843368313457, 3744.925101498009, 3745.382011968049, 3767.208886133888, 3350.6146793119105, 3403.8127902965575, 3420.675035871588, 3422.178677117524, 3424.0, 4332.566743325642, 4350.195213885441, 4443.555644435531, 4449.28811390176, 4564.794584243717, 4919.163742163841, 4919.2129259318335, 4921.089598424232, 4954.603631709455, 4968.627352948543, 4637.744924029211, 4664.067186562701, 4666.066786642617, 4667.369905062841, 4691.0, 3983.2830090583393, 4162.167566486714, 4166.8333266669, 4282.828686852553, 4301.41930839339, 4821.855344339676, 4833.879153021203, 4913.778879950411, 4949.57928576075, 4952.380952380952, 4822.228443449031, 4836.661433699607, 4876.634252431153, 4919.631027672867, 4925.039617274597, 4666.253399456071, 4785.6171506278715, 4850.805967761391, 4928.728919909439, 4972.552470277692, 4737.857864264078, 4750.168720473835, 4763.499832517536, 4855.028994201103, 4868.0, 4820.1805693031565, 4823.662343635911, 4939.0, 4948.257761335828, 4973.502649734997, 4563.7489938052395, 4627.352170696173, 4630.3286023525725, 4639.141758774637, 4662.836800711959, 4614.74618895964, 4682.695624784378, 4689.953100468952, 4692.9530704692515, 4727.858164255078, 4270.188664153801, 4502.707324023928, 4587.908241835212, 4602.7698615069785, 4612.423447069116, 4521.638268938543, 4554.294084416921, 4636.0, 4642.86071417858, 4786.904261914672, 4617.145828021827, 4627.7686115693405, 4647.581717645428, 4656.138614356355, 4660.440747110233], "mootools.html": [1264.1593340428615, 1384.9099808512447, 1435.562153543169, 1466.6113479927817, 1497.0344128037423, 6048.243969503812, 6160.353162917891, 6169.660668663228, 6321.051842223669, 6390.073439351291, 6345.809625711236, 6369.968150159254, 6598.604083754978, 6620.933790662092, 6627.867442651156, 1760.7975082865441, 1770.1768677564899, 1790.9194086266084, 1800.4238643634042, 1801.8288262615097, 1779.5017395129385, 1819.0450013742825, 1830.1672738903833, 1831.9267229310879, 1872.5131465818918, 1820.5630648644362, 1838.0, 1854.1934258597487, 1859.479345783183, 1869.252299080372, 1758.1912320332663, 1781.153951872863, 1825.4341154242095, 1826.6620675175136, 1828.1773202059126, 1772.5568607848038, 1860.0048973799087, 1877.1928070929496, 1896.8482521398255, 1899.2877670873422, 5696.772129114872, 6421.908275593114, 6478.967605161991, 6479.5788273762055, 6496.058071579641, 3493.545839040934, 3934.0951581136214, 4030.415589739501, 4038.3134867072667, 4045.959540404617, 2292.518571100071, 2348.4246359641825, 2404.9519009619885, 2406.3984003999, 2406.843555168926, 612.7579606055627, 723.2225357740398, 748.0574476160023, 756.4818099601736, 766.6933226709361, 8592.054873963796, 8606.655733770642, 8641.43830651012, 8763.780905477413, 8802.0, 3561.5726112866623, 3573.4997100405963, 3581.606023337431, 3587.192881601619, 3588.085038315265, 7633.313001829751, 7780.260875216845, 7784.3772498200005, 7790.0, 7791.532508049535, 4017.959820401817, 4018.4976877890263, 4042.939355909664, 4105.158442519277, 4141.7100802943505, 3694.5935947045805, 3731.104534911656, 3741.0273328934672, 3745.5505339358906, 3750.0, 3019.879204831826, 3032.2570970112465, 3033.1810411189294, 3065.908022759321, 3075.5694202811624, 959.836827739286, 971.0, 971.3152227679469, 985.1773768903046, 991.9355241909398, 1058.7829494953517, 1068.738159151013, 1073.4632683658172, 1096.0792933935531, 1100.7908497385472, 6096.359882212392, 6100.0544915537275, 6247.0629405589525, 6252.6873656317, 6254.530910181755, 388.93582558877466, 1019.622739586343, 1019.6482213636284, 1048.035807057509, 1071.7856428714288, 4524.524924882906, 4661.95338046622, 4672.579467847842, 4674.065186962621, 4679.953200467951, 7448.217937116633, 7639.885401718979, 7822.06135263772, 7835.921640783519, 7850.6859725611475, 7598.468107232551, 7617.885731714029, 7767.33977611898, 7768.65041073153, 7797.025371828521, 5149.716765577929, 5592.804251851166, 6006.579539432285, 6091.817245482643, 6169.907451388232, 6052.425019623129, 6090.969545152246, 6146.0473626587955, 6196.938030619636, 6204.3795620437595, 6522.608643481406, 6690.13028306317, 6845.0, 6864.313568643096, 6906.482013848881, 6776.119104516381, 6950.20072691647, 6992.475564332797, 7208.06295181623, 7211.567305961659, 5727.427257274239, 5886.646801191942, 5939.406059394026, 5943.286805583358, 5951.613145145551, 6309.463695585927, 6330.620162790247, 6343.90484142729, 6347.492200624031, 6426.807195784134, 5559.19391688211, 5924.259467566554, 5951.7024148791525, 5973.402659733992, 6081.239845019372, 5666.093425051972, 5708.857278568069, 5850.356460789225, 5880.882382352414, 5905.114232865105, 5783.971080144573, 5851.941480585139, 5860.970695146497, 5900.350961394329, 5949.315828679757, 5183.974080129575, 5325.387580428301, 5362.758675859518, 5381.327334083239, 5471.206675032018, 5401.162819762943, 5481.479259470344, 5520.454272803621, 5521.254630624814, 5525.778968841201], "ext.html": [460.7811289637423, 469.30074189457696, 482.54881685623945, 495.55895253224656, 515.9268721060192, 26236.212913612573, 27801.443971120567, 33263.168420789465, 33653.0, 33670.66329336706, 35304.82347588265, 35410.2917941641, 35423.64576354236, 35463.11342216446, 35882.64117358826, 6948.409385202264, 7129.643517824114, 7573.242675732437, 7770.9611451942665, 7898.486598371116, 9021.954890225572, 9220.8616870747, 9318.767030824216, 9323.347365684405, 9427.811443771121, 8950.015498295183, 9056.954715226448, 9076.092390760938, 9084.182423581877, 9222.44665320083, 7159.248278930715, 7486.962565187194, 8972.102789721008, 9038.909610903873, 9271.165595096474, 8788.956055219747, 8885.866711999326, 8911.0, 8938.910610893872, 8954.910450895473, 32816.50775238373, 33276.33447331064, 33278.83360583206, 33285.00144995654, 33293.66706332954, 2547.439563296072, 2585.8060645451665, 2697.325668582854, 2876.985615071932, 2892.1612732307603, 22336.55326893453, 22519.0, 22929.656055159187, 23430.531389372118, 23806.88096559506, 1968.0750047477663, 1979.6337677529702, 2003.7094621279832, 2045.2228153301799, 2068.917243310281, 260254.0, 263476.6826165876, 264089.0, 267356.0, 269212.0, 49563.752181239586, 49691.75154124206, 49723.254151187764, 49760.25359619609, 50517.747411263445, 54097.72951135219, 54893.72553137209, 55498.445015549325, 55510.444895551336, 56184.719076404355, 14434.711305773826, 14474.638134046523, 14674.0, 14713.779293310608, 14917.40330386794, 10898.945505272422, 11099.722506937229, 11161.944190278997, 11270.549178032787, 11328.830067548994, 17192.484225473258, 17249.741253881202, 17265.39571115005, 17354.826451735575, 17426.0, 7267.345938865527, 7336.853262934711, 7342.559446433231, 7391.334779869838, 7405.7789258572575, 725.1877896755667, 731.042334541752, 795.6141271483326, 799.9960050137157, 814.7677911795229, 23744.762552374254, 23930.7606923932, 24040.519189616458, 24469.143579974614, 24559.38601534976, 811.342812322021, 874.9657047364902, 877.9604917778715, 988.8516722491684, 1008.8234558952154, 11493.597724079616, 12611.432485538173, 12635.1787133836, 12826.615201543782, 12856.264404305486, 318423.4078829591, 319989.0, 320626.0, 326863.0, 327387.0, 44706.32940505895, 45303.32045019327, 46002.53997459982, 46495.5350446498, 51530.22704659433, 1191.0412118244724, 1193.6956076200513, 1209.044854564884, 1214.392803598201, 1218.0194943070912, 23257.651135233322, 23855.761442385356, 24457.0, 24946.62580061337, 24993.500129996934, 37632.623673762915, 38556.228875422894, 42234.5776542243, 43652.34521482244, 43921.0, 229024.0, 230744.0, 231203.0, 233674.0, 236072.0, 26208.8689556551, 26379.0, 27054.1883743488, 27165.86417067902, 27343.179704608894, 33540.329193415506, 34327.31345373028, 34609.30781384408, 34743.47884781781, 35485.64514354823, 29189.7081029187, 29205.85397073001, 29629.40741185121, 29681.554776677935, 32314.83842580772, 29192.416151677273, 29225.0, 29885.5517167247, 30316.0, 30353.0, 30711.2322191947, 30879.382412351177, 30891.382172356876, 32856.83571582127, 33599.664003359656, 26101.477970440865, 26738.46523069489, 27158.72841271641, 27327.86336068307, 27340.453190935674, 20551.280705175246, 20588.0, 20858.269960551308, 20941.0, 21584.460388489784], "prototype.html": [267.3130055756705, 273.4803084304994, 274.4127567006606, 279.87265794063705, 284.9928751781205, 4795.904081918359, 4907.362042934423, 5028.547430731233, 5033.0, 5073.036123136606, 4710.97644511777, 4964.975175124128, 4974.801007959677, 4977.153883839747, 4983.775730092146, 3848.7690738555634, 3852.6532612064907, 3855.248226595801, 3871.728978971473, 3876.0891190570264, 3803.7717736935733, 3867.8066096695193, 3872.0319920019997, 3874.089588946595, 3952.4071389291694, 3814.6566808987186, 3842.903927401809, 3883.8446462141483, 3897.0841852164717, 3899.707521935852, 3876.2441323941844, 3881.941770873439, 3894.591067937868, 3914.5889681583594, 3932.016995751062, 3392.5589673342306, 3395.0, 3398.728101751854, 3406.250624862551, 3416.299658569987, 4806.879828004293, 4812.085703716318, 4812.37439132914, 4820.517948205152, 4917.606591472673, 4314.525402205755, 4324.156789426063, 4352.564743525654, 4363.5418281080665, 4429.136318417877, 5167.638265321429, 5176.145935920568, 5199.896002079937, 5202.661826981234, 5203.297554830087, 3591.479235510836, 3592.0481072515804, 3594.8382322795537, 3604.9545631766755, 3612.6748592626527, 5430.456954304577, 5431.185322201662, 5432.375276843174, 5445.809396671137, 5450.591205659552, 3471.635478274745, 3518.876839310612, 3521.2253304273017, 3562.786232825987, 3563.80399078048, 3334.1997920498907, 3668.761530500509, 3687.022938921188, 3687.225682606629, 3706.629337066272, 4285.142971405731, 4286.057067445157, 4293.463317085364, 4299.54854740254, 4313.525512193656, 5051.545360917535, 5128.7179205144075, 5150.562202212854, 5190.740462976836, 5195.012947539955, 1331.9267440290682, 1335.4524644895546, 1337.7658909690765, 1338.8594197609111, 1341.0947610362966, 877.4559772940818, 895.6059333893066, 902.6254104546671, 906.1844340093836, 918.9862152067724, 5016.598672106223, 5060.949390506048, 5081.695098294114, 5087.135187018216, 5099.643024988215, 5448.37343705471, 5459.317585301837, 5474.3704473986, 5480.506754392044, 5483.369412517612, 4971.45314015458, 5053.039922414803, 5055.9494405055475, 5065.39215294167, 5089.745512724423, 2898.9418862115176, 2954.896578619738, 2977.880884764585, 3015.351699384643, 3016.185629879964, 5523.751431185607, 5525.613207075467, 5545.584081193846, 5545.611807173459, 5550.666959982414, 5568.0, 5572.219889215513, 5574.888502230014, 5575.4424557543925, 5599.8880022400135, 5506.229127922014, 5506.366767821752, 5509.201165831012, 5513.0, 5524.226608274925, 5206.947930520646, 5336.973315133399, 5429.484199001088, 5441.863953401196, 5483.287172667528, 5140.537351638371, 5244.790208391774, 5316.654417463007, 5325.2278419628165, 5416.133418652997, 5429.538489228302, 5496.697681627389, 5501.449855014466, 5509.118541033416, 5529.419410961952, 3442.345954268681, 3443.4490481522835, 3446.052335607728, 3449.965500345065, 3452.948205776865, 5209.71346575942, 5379.704116273642, 5385.46145385474, 5409.459054094559, 5471.753771080391, 5306.469353064817, 5313.654612450178, 5314.335708036496, 5325.840224793263, 5385.6230063895155, 5291.708956007456, 5293.814716484904, 5296.232046353334, 5326.440723723953, 5392.0, 5158.690478571298, 5161.483851614808, 5169.92245116316, 5184.896302074013, 5232.633715639869, 5114.258432527188, 5227.947720522899, 5238.816641417532, 5239.554637855825, 5314.601404894725, 4979.651424400402, 5053.343065401475, 5127.41034781005, 5150.356205474316, 5151.2788209649925], "yui.html": [551.418253742302, 614.751025834537, 618.7927044440112, 625.4652272307177, 637.8405398650336, 10136.645217417392, 10150.796984060315, 10365.0, 10372.273940824136, 10423.11403530699, 9576.952115239414, 10136.898631013688, 10203.897961020406, 10821.350718956868, 10926.399048052353, 746.0264355016701, 748.206900685274, 753.2919056087261, 756.6821934787375, 760.7717684694597, 732.7801659502155, 748.7042618165822, 757.6590534259577, 771.9691212351528, 772.1274959296015, 792.0574516325554, 792.9524228546305, 793.2266040610416, 803.2971150243537, 809.134226377776, 769.0655853138436, 788.8343447875895, 795.9442839001272, 797.2585495489193, 797.8843067755143, 584.6404461256296, 585.8681796595774, 590.4862769390614, 591.7692100080972, 599.2688919518181, 10263.79472410555, 10365.222608304408, 10369.133555959925, 10372.533236004398, 10526.947365263124, 9639.084286992724, 9746.415215087118, 9794.853077203848, 10011.449370284632, 10304.79390412195, 7632.809179770495, 7951.522908625501, 7999.880001799977, 8041.437099403044, 8051.315638170762, 2749.024096445753, 2773.6948935617065, 2777.1113243762006, 2819.9013034543896, 2837.333226691726, 34813.47779783305, 35419.64580354215, 35681.10797230064, 38103.42844857302, 41482.0, 7488.288612581796, 7586.544807311579, 7601.7719468416035, 7646.9617651911385, 7784.727534536264, 16405.507834764976, 16407.0, 16425.6714865702, 16438.424655137012, 16710.08094554811, 5834.591578589543, 5843.883122337529, 5845.912311315334, 6037.758489660365, 6292.874142517216, 3150.7951983121484, 3298.060052884964, 3302.075418882717, 3345.9330813383594, 3404.863805447754, 2438.3660248335204, 2451.9264422067367, 2453.227233421502, 2484.1057219401, 2495.1890635543523, 359.3316431437524, 364.5006341312366, 369.2891184469885, 374.7545357790651, 374.7601535017591, 377.6676524658338, 393.94484772131926, 399.2195258270133, 423.16636226633483, 457.7802654725684, 6235.812925612239, 6677.565958212701, 6731.124953755981, 6908.9309106909295, 6944.166699995932, 476.4140107667519, 480.8314501597819, 497.3286063813895, 507.8197239979828, 521.1141060197679, 3035.605371301717, 3114.1903105192814, 3151.747860171181, 3249.01323138794, 3325.534425180477, 44483.77758111253, 44802.32796508055, 45085.098298034514, 45720.314195287094, 45750.313745293846, 39858.0, 40836.0, 44146.0, 44562.10875782466, 44629.55370446254, 30847.383052338828, 31238.375232495677, 31255.0, 34185.145371365914, 36988.0, 6599.251198432516, 6650.434713049445, 6798.660066996729, 7059.18819335783, 7063.894041589483, 30078.0, 30277.848610756806, 30642.846785765927, 31117.0, 31693.683063169072, 33913.0, 35156.82421587978, 35995.82002090078, 37096.6290337104, 39214.41178382384, 6074.331823499323, 6144.201253837151, 6285.717142728679, 6494.772682956074, 6636.933630663824, 8978.416402933788, 9266.21237194846, 9351.906480935104, 9568.282378821477, 9715.854262185932, 8707.521086340312, 8846.248068913957, 8859.025507194332, 8873.556322183995, 9064.50145242018, 8753.255973242345, 8892.86660700103, 8901.243394311556, 8911.197992180734, 9051.185393314634, 8467.322614190973, 8786.736397908073, 8799.47203167812, 8826.382153249468, 8830.646774128963, 7636.50362726421, 7802.882956755767, 7972.083210430875, 8198.098209196864, 8292.958535207285, 7738.0, 7881.330086942445, 7888.6450109744055, 8058.153893841062, 8178.5092894426525]}, "summary": {"suite": 5727.94585538398, "subtests": {"jquery.html": {"filtered": 6717.03182869677, "value": 6717.03182869677}, "dojo.html": {"filtered": 4483.847766014792, "value": 4483.847766014792}, "mootools.html": {"filtered": 3716.040143560384, "value": 3716.040143560384}, "ext.html": {"filtered": 15976.740388051627, "value": 15976.740388051627}, "prototype.html": {"filtered": 3950.7677422244924, "value": 3950.7677422244924}, "yui.html": {"filtered": 4998.821730394651, "value": 4998.821730394651}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0033"}, "testrun": {"date": 1446233002, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151030110146", "branch": "Mozilla-Aurora", "revision": "d0b283bc162b90b071af3b77c8168b4276d4e70a"}}, {"talos_counters": {}, "results": {"audio-dft": [196.0, 195.0, 205.0, 204.0, 199.0, 197.0, 197.0, 197.0, 205.0, 205.0], "ai-astar": [134.0, 138.0, 138.0, 139.0, 137.0, 135.0, 141.0, 138.0, 141.0, 138.0], "imaging-gaussian-blur": [149.0, 156.0, 148.0, 156.0, 142.0, 148.0, 156.0, 149.0, 155.0, 143.0], "audio-beat-detection": [186.0, 165.0, 206.0, 192.0, 161.0, 184.0, 161.0, 196.0, 192.0, 153.0], "json-stringify-tinderbox": [74.0, 79.0, 80.0, 81.0, 86.0, 85.0, 86.0, 86.0, 85.0, 84.0], "stanford-crypto-pbkdf2": [174.0, 174.0, 174.0, 186.0, 184.0, 175.0, 177.0, 184.0, 184.0, 176.0], "json-parse-financial": [69.0, 72.0, 77.0, 77.0, 76.0, 81.0, 79.0, 89.0, 73.0, 73.0], "stanford-crypto-sha256-iterative": [82.0, 82.0, 83.0, 88.0, 88.0, 89.0, 90.0, 88.0, 89.0, 88.0], "audio-fft": [94.0, 100.0, 95.0, 152.0, 85.0, 88.0, 90.0, 88.0, 145.0, 85.0], "imaging-darkroom": [162.0, 162.0, 161.0, 157.0, 154.0, 161.0, 161.0, 161.0, 154.0, 162.0], "stanford-crypto-ccm": [163.0, 152.0, 161.0, 154.0, 155.0, 161.0, 156.0, 154.0, 156.0, 156.0], "audio-oscillator": [119.0, 120.0, 172.0, 113.0, 114.0, 116.0, 156.0, 111.0, 110.0, 152.0], "stanford-crypto-aes": [100.0, 100.0, 104.0, 103.0, 104.0, 105.0, 106.0, 105.0, 106.0, 110.0], "imaging-desaturate": [129.0, 128.0, 129.0, 128.0, 128.0, 129.0, 129.0, 130.0, 130.0, 130.0]}, "summary": {"suite": 1872.4999999999998, "subtests": {"audio-fft": {"filtered": 102.2, "value": 102.2}, "stanford-crypto-pbkdf2": {"filtered": 178.8, "value": 178.8}, "audio-beat-detection": {"filtered": 179.6, "value": 179.6}, "stanford-crypto-ccm": {"filtered": 156.8, "value": 156.8}, "imaging-darkroom": {"filtered": 159.5, "value": 159.5}, "json-parse-financial": {"filtered": 76.6, "value": 76.6}, "audio-oscillator": {"filtered": 128.3, "value": 128.3}, "ai-astar": {"filtered": 137.9, "value": 137.9}, "audio-dft": {"filtered": 200.0, "value": 200.0}, "stanford-crypto-sha256-iterative": {"filtered": 86.7, "value": 86.7}, "json-stringify-tinderbox": {"filtered": 82.6, "value": 82.6}, "imaging-gaussian-blur": {"filtered": 150.2, "value": 150.2}, "stanford-crypto-aes": {"filtered": 104.3, "value": 104.3}, "imaging-desaturate": {"filtered": 129.0, "value": 129.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0033"}, "testrun": {"date": 1446233002, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151030110146", "branch": "Mozilla-Aurora", "revision": "d0b283bc162b90b071af3b77c8168b4276d4e70a"}}, {"talos_counters": {}, "results": {"DeltaBlue": [241.3709872073377], "Encrypt": [403.2258064516129], "NavierStokes": [7020.979020979021], "Decrypt": [7084.507042253521], "Splay": [785.6025039123631], "Richards": [205.5076037813399], "RegExp": [35491.228070175435], "Earley": [846.740050804403], "Boyer": [15318.181818181818], "RayTrace": [1267.427122940431]}, "summary": {"suite": 16375.855242417205, "subtests": {"DeltaBlue": {"filtered": 273.926874, "value": 273.926874}, "Encrypt": {"filtered": 660.1288800000001, "value": 660.1288800000001}, "NavierStokes": {"filtered": 211.366533864542, "value": 211.366533864542}, "Decrypt": {"filtered": 37.572268389662035, "value": 37.572268389662035}, "Splay": {"filtered": 103.73057569721118, "value": 103.73057569721118}, "RegExp": {"filtered": 25.667891744933275, "value": 25.667891744933275}, "Richards": {"filtered": 171.779532, "value": 171.779532}, "Earley": {"filtered": 787.0928030000003, "value": 787.0928030000003}, "Boyer": {"filtered": 43.50797032640952, "value": 43.50797032640952}, "RayTrace": {"filtered": 583.8513209999999, "value": 583.8513209999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0033"}, "testrun": {"date": 1446233002, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151030110146", "branch": "Mozilla-Aurora", "revision": "d0b283bc162b90b071af3b77c8168b4276d4e70a"}}] 12:43:43 INFO - RETURN: dromaeo_css: 5727.95 12:43:43 INFO - RETURN: kraken: 1872.50 12:43:43 INFO - RETURN: v8_7: 16375.86 12:43:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "16375.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1872.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5727.95"}}} 12:43:43 INFO - Return code: 0 12:43:43 INFO - # TBPL SUCCESS # 12:43:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:43:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:43:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:43:43 INFO - 2015-10-30 12:43:43.286 screenresolution[1659:9781] starting screenresolution argv=screenresolution get 12:43:43 INFO - 2015-10-30 12:43:43.290 screenresolution[1659:9781] Display 0: 1600x1200x32@60 12:43:43 INFO - 2015-10-30 12:43:43.297 screenresolution[1660:9784] starting screenresolution argv=screenresolution list 12:43:43 INFO - Available Modes on Display 0 12:43:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:43:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:43:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:43:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:43:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:43:43 INFO - Intel HD Graphics 3000: 12:43:43 INFO - Chipset Model: Intel HD Graphics 3000 12:43:43 INFO - Type: GPU 12:43:43 INFO - Bus: Built-In 12:43:43 INFO - VRAM (Total): 512 MB 12:43:43 INFO - VRAM (Dynamic, Max): 10 12:43:43 INFO - Vendor: Intel (0x8086) 12:43:43 INFO - Device ID: 0x0116 12:43:43 INFO - Revision ID: 0x0009 12:43:43 INFO - Displays: 12:43:43 INFO - Display: 12:43:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:43:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:43:43 INFO - Display Serial Number: 1600x1200 60 12:43:43 INFO - Main Display: Yes 12:43:43 INFO - Mirror: Off 12:43:43 INFO - Online: Yes 12:43:43 INFO - Rotation: Supported 12:43:43 INFO - Return code: 0 12:43:43 INFO - Running post-action listener: _resource_record_post_action 12:43:43 INFO - Running post-run listener: _resource_record_post_run 12:43:44 INFO - Total resource usage - Wall time: 1265s; CPU: 30.0%; Read bytes: 38650880; Write bytes: 687414272; Read time: 4543; Write time: 57770 12:43:44 INFO - install - Wall time: 44s; CPU: 30.0%; Read bytes: 335596032; Write bytes: 334815232; Read time: 38003; Write time: 7053 12:43:44 INFO - run-tests - Wall time: 1222s; CPU: 30.0%; Read bytes: 37700608; Write bytes: 342334464; Read time: 4001; Write time: 49037 12:43:44 INFO - Running post-run listener: _upload_blobber_files 12:43:44 INFO - Blob upload gear active. 12:43:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:43:44 INFO - Copying logs to upload dir... 12:43:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1323.962317 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 9 secs) (at 2015-10-30 12:43:50.204477) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 12:43:50.207754) ========= 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.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010550 build_url: 'https://queue.taskcluster.net/v1/task/vJ9QDIwBSA6BnbHJVFpmOw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 12:43:50.261325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:43:50.261757) ========= 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.zE4oN8kmTb/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.Zb5cO4KVDc/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005320 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:43:50.358132) ========= ========= Started reboot slave lost (results: 0, elapsed: 2 secs) (at 2015-10-30 12:43:50.361632) ========= ========= Finished reboot slave lost (results: 0, elapsed: 2 secs) (at 2015-10-30 12:43:52.417805) =========