builder: mozilla-aurora_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0018 starttime: 1449075044.83 results: success (0) buildid: 20151202071122 builduid: 74d9424fa5264d23828c467d0d4fae2d revision: bd29d7c987b554842ccee62dad4dec506e98227e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.834874) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.835300) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.835591) ========= 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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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.005574 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.866401) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.866739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.891421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.891768) ========= 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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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.020309 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.939816) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.940208) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.940614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:44.940924) ========= 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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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-12-02 08:50:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.26M=0.001s 2015-12-02 08:50:45 (9.26 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193829 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:45.145476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:45.145801) ========= 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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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.120821 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:45.277542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:45.278231) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bd29d7c987b554842ccee62dad4dec506e98227e --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 bd29d7c987b554842ccee62dad4dec506e98227e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9Jz5mUnRRT/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.p5LCNWjGun/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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-12-02 08:50:45,373 truncating revision to first 12 chars 2015-12-02 08:50:45,373 Setting DEBUG logging. 2015-12-02 08:50:45,373 attempt 1/10 2015-12-02 08:50:45,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bd29d7c987b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 08:50:45,790 unpacking tar archive at: mozilla-aurora-bd29d7c987b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689985 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:45.980694) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:45.981006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:45.989237) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:45.989531) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:50:45.989915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-12-02 08:50:45.990207) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 08:50:46 INFO - MultiFileLogger online at 20151202 08:50:46 in /builds/slave/test 08:50:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 08:50:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:46 INFO - {'append_to_log': False, 08:50:46 INFO - 'base_work_dir': '/builds/slave/test', 08:50:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:50:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:46 INFO - 'branch': 'Mozilla-Aurora', 08:50:46 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:46 INFO - 'config_files': ('talos/mac_config.py',), 08:50:46 INFO - 'default_actions': ('clobber', 08:50:46 INFO - 'read-buildbot-config', 08:50:46 INFO - 'download-and-extract', 08:50:46 INFO - 'populate-webroot', 08:50:46 INFO - 'create-virtualenv', 08:50:46 INFO - 'install', 08:50:46 INFO - 'run-tests'), 08:50:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:46 INFO - 'download_minidump_stackwalk': True, 08:50:46 INFO - 'download_symbols': 'ondemand', 08:50:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:46 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:46 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:46 INFO - 'installer_path': 'installer.exe', 08:50:46 INFO - 'log_level': 'info', 08:50:46 INFO - 'log_name': 'talos', 08:50:46 INFO - 'log_to_console': True, 08:50:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:50:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:50:46 INFO - 'opt_config_files': (), 08:50:46 INFO - 'pip_index': False, 08:50:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:46 INFO - 'cmd': ('bash', 08:50:46 INFO - '-c', 08:50:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:46 INFO - 'enabled': True, 08:50:46 INFO - 'halt_on_failure': False, 08:50:46 INFO - 'name': 'check_screen_resolution'},), 08:50:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:46 INFO - 'cmd': ('bash', 08:50:46 INFO - '-c', 08:50:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:46 INFO - 'enabled': True, 08:50:46 INFO - 'halt_on_failure': False, 08:50:46 INFO - 'name': 'check_screen_resolution'},), 08:50:46 INFO - 'run_cmd_checks_enabled': True, 08:50:46 INFO - 'sps_profile': False, 08:50:46 INFO - 'sps_profile_interval': 0, 08:50:46 INFO - 'suite': 'dromaeojs-e10s', 08:50:46 INFO - 'system_bits': '64', 08:50:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:46 INFO - 'title': 't-yosemite-r5-0018', 08:50:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:46 INFO - 'use_talos_json': True, 08:50:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:46 INFO - 'work_dir': 'build'} 08:50:46 INFO - ##### 08:50:46 INFO - ##### Running clobber step. 08:50:46 INFO - ##### 08:50:46 INFO - Running pre-action listener: _resource_record_pre_action 08:50:46 INFO - Running main action method: clobber 08:50:46 INFO - rmtree: /builds/slave/test/build 08:50:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:50 INFO - Running post-action listener: _resource_record_post_action 08:50:50 INFO - ##### 08:50:50 INFO - ##### Running read-buildbot-config step. 08:50:50 INFO - ##### 08:50:50 INFO - Running pre-action listener: _resource_record_pre_action 08:50:50 INFO - Running main action method: read_buildbot_config 08:50:50 INFO - Using buildbot properties: 08:50:50 INFO - { 08:50:50 INFO - "properties": { 08:50:50 INFO - "buildnumber": 1, 08:50:50 INFO - "product": "firefox", 08:50:50 INFO - "script_repo_revision": "production", 08:50:50 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs-e10s", 08:50:50 INFO - "repository": "", 08:50:50 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs-e10s", 08:50:50 INFO - "buildid": "20151202071122", 08:50:50 INFO - "slavename": "t-yosemite-r5-0018", 08:50:50 INFO - "pgo_build": "False", 08:50:50 INFO - "basedir": "/builds/slave/test", 08:50:50 INFO - "project": "", 08:50:50 INFO - "platform": "yosemite", 08:50:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:50:50 INFO - "slavebuilddir": "test", 08:50:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:50:50 INFO - "branch": "mozilla-aurora", 08:50:50 INFO - "repo_path": "releases/mozilla-aurora", 08:50:50 INFO - "stage_platform": "macosx64", 08:50:50 INFO - "builduid": "74d9424fa5264d23828c467d0d4fae2d", 08:50:50 INFO - "revision": "bd29d7c987b554842ccee62dad4dec506e98227e" 08:50:50 INFO - }, 08:50:50 INFO - "sourcestamp": { 08:50:50 INFO - "repository": "", 08:50:50 INFO - "hasPatch": false, 08:50:50 INFO - "project": "", 08:50:50 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:50:50 INFO - "changes": [ 08:50:50 INFO - { 08:50:50 INFO - "category": null, 08:50:50 INFO - "files": [ 08:50:50 INFO - { 08:50:50 INFO - "url": null, 08:50:50 INFO - "name": "https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 08:50:50 INFO - } 08:50:50 INFO - ], 08:50:50 INFO - "repository": "", 08:50:50 INFO - "rev": "bd29d7c987b554842ccee62dad4dec506e98227e", 08:50:50 INFO - "who": "cbook@mozilla.com", 08:50:50 INFO - "when": 1449074282, 08:50:50 INFO - "number": 6733502, 08:50:50 INFO - "comments": "Bug 1224100 - Initialize row buffer to 0 in Downscaler - r=seth, a=lizzard", 08:50:50 INFO - "project": "", 08:50:50 INFO - "at": "Wed 02 Dec 2015 08:38:02", 08:50:50 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:50:50 INFO - "revlink": "", 08:50:50 INFO - "properties": [ 08:50:50 INFO - [ 08:50:50 INFO - "buildid", 08:50:50 INFO - "20151202071122", 08:50:50 INFO - "Change" 08:50:50 INFO - ], 08:50:50 INFO - [ 08:50:50 INFO - "builduid", 08:50:50 INFO - "74d9424fa5264d23828c467d0d4fae2d", 08:50:50 INFO - "Change" 08:50:50 INFO - ], 08:50:50 INFO - [ 08:50:50 INFO - "pgo_build", 08:50:50 INFO - "False", 08:50:50 INFO - "Change" 08:50:50 INFO - ] 08:50:50 INFO - ], 08:50:50 INFO - "revision": "bd29d7c987b554842ccee62dad4dec506e98227e" 08:50:50 INFO - } 08:50:50 INFO - ], 08:50:50 INFO - "revision": "bd29d7c987b554842ccee62dad4dec506e98227e" 08:50:50 INFO - } 08:50:50 INFO - } 08:50:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 08:50:50 INFO - Running post-action listener: _resource_record_post_action 08:50:50 INFO - ##### 08:50:50 INFO - ##### Running download-and-extract step. 08:50:50 INFO - ##### 08:50:50 INFO - Running pre-action listener: _resource_record_pre_action 08:50:50 INFO - Running main action method: download_and_extract 08:50:50 INFO - mkdir: /builds/slave/test/build/tests 08:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:50 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json 08:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json 08:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:50:50 INFO - Downloaded 1149 bytes. 08:50:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:50:50 INFO - Using the following test package requirements: 08:50:50 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:50:50 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:50:50 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 08:50:50 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:50:50 INFO - u'jsshell-mac.zip'], 08:50:50 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:50:50 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 08:50:50 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:50:50 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:50:50 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 08:50:50 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:50:50 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 08:50:50 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:50:50 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 08:50:50 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:50:50 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:50:50 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 08:50:50 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:50 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/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 08:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/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 08:50:51 INFO - Downloaded 17490149 bytes. 08:50: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 08:50:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:50:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:50:56 INFO - Return code: 0 08:50:56 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 08:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:56 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:50:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:50:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:50:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/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 08:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/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 08:50:58 INFO - Downloaded 17490149 bytes. 08:50:58 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 08:50:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:50:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:51:04 INFO - Return code: 0 08:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:04 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:51:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:51:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:51:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/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 08:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/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 08:51:05 INFO - Downloaded 11131307 bytes. 08:51:05 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 08:51:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:51:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:51:05 INFO - Return code: 0 08:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:05 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:51:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:51:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:51:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 08:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/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 08:51:08 INFO - Downloaded 108652001 bytes. 08:51:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:51:08 INFO - mkdir: /builds/slave/test/properties 08:51:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:08 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:08 INFO - Contents: 08:51:08 INFO - build_url:https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:51:08 INFO - Running post-action listener: _resource_record_post_action 08:51:08 INFO - Running post-action listener: set_extra_try_arguments 08:51:08 INFO - ##### 08:51:08 INFO - ##### Running populate-webroot step. 08:51:08 INFO - ##### 08:51:08 INFO - Running pre-action listener: _resource_record_pre_action 08:51:08 INFO - Running main action method: populate_webroot 08:51:08 INFO - Guessing talos json url... 08:51: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')]} 08:51:08 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 08:51:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:51:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:51:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:51:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/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 08:51:09 INFO - Downloaded 107 bytes. 08:51:09 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:51:09 INFO - Contents: 08:51:09 INFO - 20151202071122 08:51:09 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/bd29d7c987b554842ccee62dad4dec506e98227e 08:51: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')]} 08:51:09 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bd29d7c987/testing/talos/talos.json 08:51:09 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bd29d7c987/testing/talos/talos.json to /builds/slave/test/build/talos.json 08:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bd29d7c987/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 08:51:10 INFO - Downloaded 4264 bytes. 08:51:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:51:10 INFO - '../fennec_ids.txt'], 08:51:10 INFO - 'tests': ['tcheck2']}, 08:51:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:10 INFO - '--tppagecycles', 08:51:10 INFO - '7'], 08:51:10 INFO - 'tests': ['tsvgm']}}, 08:51:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:51:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:51:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:51:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:51:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:51:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:10 INFO - 'talos_options': ['--e10s'], 08:51:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:10 INFO - 'tests': ['damp', 'tps']}, 08:51:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:10 INFO - 'talos_options': ['--e10s'], 08:51:10 INFO - 'tests': ['damp', 'tps']}, 08:51:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:51:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:10 INFO - 'other': {'tests': ['a11yr', 08:51:10 INFO - 'ts_paint', 08:51:10 INFO - 'tpaint', 08:51:10 INFO - 'sessionrestore', 08:51:10 INFO - 'sessionrestore_no_auto_restore']}, 08:51:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:51:10 INFO - 'tests': ['a11yr', 08:51:10 INFO - 'ts_paint', 08:51:10 INFO - 'tpaint', 08:51:10 INFO - 'sessionrestore', 08:51:10 INFO - 'sessionrestore_no_auto_restore']}, 08:51:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:51:10 INFO - 'tests': ['a11yr', 08:51:10 INFO - 'ts_paint', 08:51:10 INFO - 'tpaint', 08:51:10 INFO - 'sessionrestore', 08:51:10 INFO - 'sessionrestore_no_auto_restore']}, 08:51:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:51:10 INFO - 'tests': ['a11yr', 08:51:10 INFO - 'ts_paint', 08:51:10 INFO - 'tpaint', 08:51:10 INFO - 'sessionrestore', 08:51:10 INFO - 'sessionrestore_no_auto_restore']}, 08:51:10 INFO - 'other_l64': {'tests': ['a11yr', 08:51:10 INFO - 'ts_paint', 08:51:10 INFO - 'tpaint', 08:51:10 INFO - 'sessionrestore', 08:51:10 INFO - 'sessionrestore_no_auto_restore']}, 08:51:10 INFO - 'other_nol64': {'tests': ['a11yr', 08:51:10 INFO - 'ts_paint', 08:51:10 INFO - 'tpaint', 08:51:10 INFO - 'sessionrestore', 08:51:10 INFO - 'sessionrestore_no_auto_restore']}, 08:51:10 INFO - 'svgr': {'tests': ['tsvgx', 08:51:10 INFO - 'tsvgr_opacity', 08:51:10 INFO - 'tart', 08:51:10 INFO - 'tscrollx', 08:51:10 INFO - 'cart']}, 08:51:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:51:10 INFO - 'tests': ['tsvgx', 08:51:10 INFO - 'tsvgr_opacity', 08:51:10 INFO - 'tart', 08:51:10 INFO - 'tscrollx', 08:51:10 INFO - 'cart']}, 08:51:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:10 INFO - 'tests': ['tp5o']}, 08:51:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:10 INFO - 'talos_options': ['--e10s'], 08:51:10 INFO - 'tests': ['tp5o']}, 08:51:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:10 INFO - 'talos_options': ['--xperf_path', 08:51:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:10 INFO - 'tests': ['tp5n']}, 08:51:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:10 INFO - 'talos_options': ['--e10s', 08:51:10 INFO - '--xperf_path', 08:51:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 08:51:10 INFO - 'C:/slave/talos-data/talos/xperf.config'], 08:51:10 INFO - 'tests': ['tp5n']}}, 08:51:10 INFO - 'talos.zip': {'path': '', 08:51:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:10 INFO - Running post-action listener: _resource_record_post_action 08:51:10 INFO - ##### 08:51:10 INFO - ##### Running create-virtualenv step. 08:51:10 INFO - ##### 08:51:10 INFO - Running pre-action listener: _resource_record_pre_action 08:51:10 INFO - Running main action method: create_virtualenv 08:51:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:10 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 08:51:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:10 INFO - Using real prefix '/tools/python27' 08:51:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:15 INFO - Installing pip.................done. 08:51:15 INFO - Return code: 0 08:51:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10464fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046bc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4baf4fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046049f0>, '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 0x104363cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045ce990>, '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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 08:51: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', 'pip>=1.5'] in /builds/slave/test/build 08:51: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 pip>=1.5 08:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Jz5mUnRRT/Render', 08:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:15 INFO - 'HOME': '/Users/cltbld', 08:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:15 INFO - 'LOGNAME': 'cltbld', 08:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:15 INFO - 'MOZ_NO_REMOTE': '1', 08:51:15 INFO - 'NO_EM_RESTART': '1', 08:51:15 INFO - 'PAGER': '/bin/cat', 08:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:15 INFO - 'PWD': '/builds/slave/test', 08:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:15 INFO - 'SHELL': '/bin/bash', 08:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p5LCNWjGun/Listeners', 08:51:15 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 08:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:15 INFO - 'USER': 'cltbld', 08:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:15 INFO - 'XPC_FLAGS': '0x0', 08:51:15 INFO - 'XPC_SERVICE_NAME': '0', 08:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:51:16 INFO - Cleaning up... 08:51:16 INFO - Return code: 0 08:51:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:16 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 0x10464fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046bc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4baf4fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046049f0>, '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 0x104363cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045ce990>, '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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 08:51:16 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 08:51:16 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 08:51:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Jz5mUnRRT/Render', 08:51:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:16 INFO - 'HOME': '/Users/cltbld', 08:51:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:16 INFO - 'LOGNAME': 'cltbld', 08:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:16 INFO - 'MOZ_NO_REMOTE': '1', 08:51:16 INFO - 'NO_EM_RESTART': '1', 08:51:16 INFO - 'PAGER': '/bin/cat', 08:51:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:16 INFO - 'PWD': '/builds/slave/test', 08:51:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:16 INFO - 'SHELL': '/bin/bash', 08:51:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p5LCNWjGun/Listeners', 08:51:16 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 08:51:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:16 INFO - 'USER': 'cltbld', 08:51:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:16 INFO - 'XPC_FLAGS': '0x0', 08:51:16 INFO - 'XPC_SERVICE_NAME': '0', 08:51:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:16 INFO - Downloading/unpacking psutil>=0.7.1 08:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:51:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:19 INFO - Installing collected packages: psutil 08:51:19 INFO - Running setup.py install for psutil 08:51:19 INFO - building 'psutil._psutil_osx' extension 08:51:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:51:21 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 08:51:21 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 08:51:21 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 08:51:22 INFO - building 'psutil._psutil_posix' extension 08:51:22 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 08:51:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:51:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:51:22 INFO - ^ 08:51:22 INFO - 1 warning generated. 08:51:22 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 08:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:22 INFO - Successfully installed psutil 08:51:22 INFO - Cleaning up... 08:51:22 INFO - Return code: 0 08:51:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:22 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 0x10464fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046bc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4baf4fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046049f0>, '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 0x104363cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045ce990>, '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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 08:51:22 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 08:51:22 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 08:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Jz5mUnRRT/Render', 08:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:22 INFO - 'HOME': '/Users/cltbld', 08:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:22 INFO - 'LOGNAME': 'cltbld', 08:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:22 INFO - 'MOZ_NO_REMOTE': '1', 08:51:22 INFO - 'NO_EM_RESTART': '1', 08:51:22 INFO - 'PAGER': '/bin/cat', 08:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:22 INFO - 'PWD': '/builds/slave/test', 08:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:22 INFO - 'SHELL': '/bin/bash', 08:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p5LCNWjGun/Listeners', 08:51:22 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 08:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:22 INFO - 'USER': 'cltbld', 08:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:22 INFO - 'XPC_FLAGS': '0x0', 08:51:22 INFO - 'XPC_SERVICE_NAME': '0', 08:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:51:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:51:25 INFO - Installing collected packages: mozsystemmonitor 08:51:25 INFO - Running setup.py install for mozsystemmonitor 08:51:25 INFO - Successfully installed mozsystemmonitor 08:51:25 INFO - Cleaning up... 08:51:25 INFO - Return code: 0 08:51:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 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 0x10464fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046bc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4baf4fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046049f0>, '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 0x104363cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045ce990>, '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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 08:51:25 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 08:51:25 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 08:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Jz5mUnRRT/Render', 08:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:25 INFO - 'HOME': '/Users/cltbld', 08:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:25 INFO - 'LOGNAME': 'cltbld', 08:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:25 INFO - 'MOZ_NO_REMOTE': '1', 08:51:25 INFO - 'NO_EM_RESTART': '1', 08:51:25 INFO - 'PAGER': '/bin/cat', 08:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:25 INFO - 'PWD': '/builds/slave/test', 08:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:25 INFO - 'SHELL': '/bin/bash', 08:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p5LCNWjGun/Listeners', 08:51:25 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 08:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:25 INFO - 'USER': 'cltbld', 08:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:25 INFO - 'XPC_FLAGS': '0x0', 08:51:25 INFO - 'XPC_SERVICE_NAME': '0', 08:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:28 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 08:51:28 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 08:51:28 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 08:51:28 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 08:51:28 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 08:51:28 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 08:51:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51:29 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 08:51:29 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 08:51:29 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 08:51:29 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 08:51:29 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 08:51:29 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 08:51:30 INFO - Downloading docopt-0.6.1.tar.gz 08:51:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:30 INFO - Running setup.py install for blobuploader 08:51:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:30 INFO - Running setup.py install for requests 08:51:31 INFO - Running setup.py install for docopt 08:51:31 INFO - Successfully installed blobuploader requests docopt 08:51:31 INFO - Cleaning up... 08:51:31 INFO - Return code: 0 08:51:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:31 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 0x10464fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046bc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4baf4fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046049f0>, '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 0x104363cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045ce990>, '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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 08:51:31 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 08:51:31 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 08:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Jz5mUnRRT/Render', 08:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:31 INFO - 'HOME': '/Users/cltbld', 08:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:31 INFO - 'LOGNAME': 'cltbld', 08:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:31 INFO - 'MOZ_NO_REMOTE': '1', 08:51:31 INFO - 'NO_EM_RESTART': '1', 08:51:31 INFO - 'PAGER': '/bin/cat', 08:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:31 INFO - 'PWD': '/builds/slave/test', 08:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:31 INFO - 'SHELL': '/bin/bash', 08:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p5LCNWjGun/Listeners', 08:51:31 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 08:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:31 INFO - 'USER': 'cltbld', 08:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:31 INFO - 'XPC_FLAGS': '0x0', 08:51:31 INFO - 'XPC_SERVICE_NAME': '0', 08:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:31 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-rY9Ipt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:31 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-OJVU3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:31 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-Ex7NZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:32 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-XaksgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:32 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-uv9sUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:32 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-gV5K1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:32 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-OJEu1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:32 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-gwNzbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:32 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-CQAvbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:32 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-U2oAJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:32 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-UuUbgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-U6E04A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-meFrXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-7o32sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-uc3koV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-E4l86N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-qy4_Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:33 INFO - Running setup.py install for manifestparser 08:51:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozcrash 08:51:34 INFO - Running setup.py install for mozdebug 08:51:34 INFO - Running setup.py install for mozdevice 08:51:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozfile 08:51:34 INFO - Running setup.py install for mozhttpd 08:51:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozinfo 08:51:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Running setup.py install for mozInstall 08:51:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Running setup.py install for mozleak 08:51:35 INFO - Running setup.py install for mozlog 08:51:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Running setup.py install for moznetwork 08:51:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Running setup.py install for mozprocess 08:51:36 INFO - Running setup.py install for mozprofile 08:51:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:36 INFO - Running setup.py install for mozrunner 08:51:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:36 INFO - Running setup.py install for mozscreenshot 08:51:36 INFO - Running setup.py install for moztest 08:51:36 INFO - Running setup.py install for mozversion 08:51:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:36 INFO - Cleaning up... 08:51:37 INFO - Return code: 0 08:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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/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 0x10464fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046bc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4baf4fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046049f0>, '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 0x104363cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045ce990>, '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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 08:51: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/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 08:51: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/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 08:51:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Jz5mUnRRT/Render', 08:51:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:37 INFO - 'HOME': '/Users/cltbld', 08:51:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:37 INFO - 'LOGNAME': 'cltbld', 08:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:37 INFO - 'MOZ_NO_REMOTE': '1', 08:51:37 INFO - 'NO_EM_RESTART': '1', 08:51:37 INFO - 'PAGER': '/bin/cat', 08:51:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:37 INFO - 'PWD': '/builds/slave/test', 08:51:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:37 INFO - 'SHELL': '/bin/bash', 08:51:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p5LCNWjGun/Listeners', 08:51:37 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 08:51:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:37 INFO - 'USER': 'cltbld', 08:51:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:37 INFO - 'XPC_FLAGS': '0x0', 08:51:37 INFO - 'XPC_SERVICE_NAME': '0', 08:51:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:37 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-O2jPWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:37 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)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:37 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-aLRdeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:37 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)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:37 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-7_mAn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:37 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)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:37 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-PflF7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:37 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)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:37 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-RjRwmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:38 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)) 08:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:38 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-ZvGl5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:38 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)) 08:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:38 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-NrAQg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:38 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)) 08:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:38 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-WRWXic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:38 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)) 08:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:38 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-MoVPu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:38 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)) 08:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:38 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-hmWMxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:38 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)) 08:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:38 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-le5dBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:38 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)) 08:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:38 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-zMbfqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:38 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)) 08:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:38 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-dfMtXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:39 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)) 08:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:39 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-Us92Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:39 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)) 08:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:39 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-XcUtoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:39 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)) 08:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:39 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-SSQFU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:39 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)) 08:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:39 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-wg0sv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:39 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 08:51:39 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 08:51:39 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 08:51:39 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 08:51:39 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 08:51:39 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 08:51:42 INFO - Downloading blessings-1.5.1.tar.gz 08:51:42 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 08:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:42 INFO - Installing collected packages: blessings 08:51:42 INFO - Running setup.py install for blessings 08:51:42 INFO - Successfully installed blessings 08:51:42 INFO - Cleaning up... 08:51:42 INFO - Return code: 0 08:51:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:43 INFO - Reading from file tmpfile_stdout 08:51:43 INFO - Current package versions: 08:51:43 INFO - blessings == 1.5.1 08:51:43 INFO - blobuploader == 1.2.4 08:51:43 INFO - docopt == 0.6.1 08:51:43 INFO - manifestparser == 1.1 08:51:43 INFO - mozInstall == 1.12 08:51:43 INFO - mozcrash == 0.16 08:51:43 INFO - mozdebug == 0.1 08:51:43 INFO - mozdevice == 0.46 08:51:43 INFO - mozfile == 1.2 08:51:43 INFO - mozhttpd == 0.7 08:51:43 INFO - mozinfo == 0.8 08:51:43 INFO - mozleak == 0.1 08:51:43 INFO - mozlog == 3.0 08:51:43 INFO - moznetwork == 0.27 08:51:43 INFO - mozprocess == 0.22 08:51:43 INFO - mozprofile == 0.27 08:51:43 INFO - mozrunner == 6.11 08:51:43 INFO - mozscreenshot == 0.1 08:51:43 INFO - mozsystemmonitor == 0.0 08:51:43 INFO - moztest == 0.7 08:51:43 INFO - mozversion == 1.4 08:51:43 INFO - psutil == 3.1.1 08:51:43 INFO - requests == 1.2.3 08:51:43 INFO - wsgiref == 0.1.2 08:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:43 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 0x10464fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046bc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4baf4fee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046049f0>, '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 0x104363cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045ce990>, '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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 08:51:43 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 08:51:43 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 08:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Jz5mUnRRT/Render', 08:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:43 INFO - 'HOME': '/Users/cltbld', 08:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:43 INFO - 'LOGNAME': 'cltbld', 08:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:43 INFO - 'MOZ_NO_REMOTE': '1', 08:51:43 INFO - 'NO_EM_RESTART': '1', 08:51:43 INFO - 'PAGER': '/bin/cat', 08:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:43 INFO - 'PWD': '/builds/slave/test', 08:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:43 INFO - 'SHELL': '/bin/bash', 08:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p5LCNWjGun/Listeners', 08:51:43 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 08:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:43 INFO - 'USER': 'cltbld', 08:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:43 INFO - 'XPC_FLAGS': '0x0', 08:51:43 INFO - 'XPC_SERVICE_NAME': '0', 08:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:43 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)) 08:51:43 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)) 08:51:43 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)) 08:51:43 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)) 08:51:43 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)) 08:51:43 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)) 08:51:43 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)) 08:51:43 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)) 08:51:43 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)) 08:51:43 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)) 08:51:43 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)) 08:51:43 INFO - Cleaning up... 08:51:43 INFO - Return code: 0 08:51:43 INFO - Running post-action listener: _resource_record_post_action 08:51:43 INFO - Running post-action listener: _start_resource_monitoring 08:51:43 INFO - Starting resource monitoring. 08:51:43 INFO - ##### 08:51:43 INFO - ##### Running install step. 08:51:43 INFO - ##### 08:51:43 INFO - Running pre-action listener: _resource_record_pre_action 08:51:43 INFO - Running main action method: install 08:51:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:43 INFO - Reading from file tmpfile_stdout 08:51:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:43 INFO - Reading from file tmpfile_stdout 08:51:43 INFO - Output received: 08:51:43 INFO - Usage: mozinstall [options] installer 08:51:43 INFO - Options: 08:51:43 INFO - -h, --help show this help message and exit 08:51:43 INFO - -d DEST, --destination=DEST 08:51:43 INFO - Directory to install application into. [default: 08:51:43 INFO - "/builds/slave/test"] 08:51:43 INFO - --app=APP Application being installed. [default: firefox] 08:51:43 INFO - mkdir: /builds/slave/test/build/application 08:51:43 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'] 08:51:43 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 08:52:23 INFO - Reading from file tmpfile_stdout 08:52:23 INFO - Output received: 08:52:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:52:23 INFO - Running post-action listener: _resource_record_post_action 08:52:23 INFO - ##### 08:52:23 INFO - ##### Running run-tests step. 08:52:23 INFO - ##### 08:52:23 INFO - Running pre-action listener: _resource_record_pre_action 08:52:23 INFO - Running main action method: run_tests 08:52:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:52:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:52:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:52:23 INFO - 2015-12-02 08:52:23.530 screenresolution[1632:7555] starting screenresolution argv=screenresolution get 08:52:23 INFO - 2015-12-02 08:52:23.533 screenresolution[1632:7555] Display 0: 1600x1200x32@60 08:52:23 INFO - 2015-12-02 08:52:23.540 screenresolution[1633:7557] starting screenresolution argv=screenresolution list 08:52:23 INFO - Available Modes on Display 0 08:52:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:52:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:52:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:52:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:52:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:52:23 INFO - Intel HD Graphics 3000: 08:52:23 INFO - Chipset Model: Intel HD Graphics 3000 08:52:23 INFO - Type: GPU 08:52:23 INFO - Bus: Built-In 08:52:23 INFO - VRAM (Total): 512 MB 08:52:23 INFO - VRAM (Dynamic, Max): 10 08:52:23 INFO - Vendor: Intel (0x8086) 08:52:23 INFO - Device ID: 0x0116 08:52:23 INFO - Revision ID: 0x0009 08:52:23 INFO - Displays: 08:52:23 INFO - Display: 08:52:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:52:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:52:23 INFO - Display Serial Number: 1600x1200 60 08:52:23 INFO - Main Display: Yes 08:52:23 INFO - Mirror: Off 08:52:23 INFO - Online: Yes 08:52:23 INFO - Rotation: Supported 08:52:23 INFO - Return code: 0 08:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:23 INFO - Python 2.7.3 08:52:23 INFO - Return code: 0 08:52:23 INFO - grabbing minidump binary from tooltool 08:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:23 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 0x1046049f0>, '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 0x104363cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045ce990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:23 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 08:52:23 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 08:52:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:23 INFO - Return code: 0 08:52:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:52:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:52:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:23 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0018', '--webServer', 'localhost'] in /builds/slave/test/build 08:52:23 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0018 --webServer localhost 08:52:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Jz5mUnRRT/Render', 08:52:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:23 INFO - 'HOME': '/Users/cltbld', 08:52:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:23 INFO - 'LOGNAME': 'cltbld', 08:52:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:23 INFO - 'MOZ_NO_REMOTE': '1', 08:52:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:23 INFO - 'NO_EM_RESTART': '1', 08:52:23 INFO - 'PAGER': '/bin/cat', 08:52:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:23 INFO - 'PWD': '/builds/slave/test', 08:52:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:23 INFO - 'SHELL': '/bin/bash', 08:52:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p5LCNWjGun/Listeners', 08:52:23 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 08:52:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:23 INFO - 'USER': 'cltbld', 08:52:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:23 INFO - 'XPC_FLAGS': '0x0', 08:52:23 INFO - 'XPC_SERVICE_NAME': '0', 08:52:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:52:23 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0018', '--webServer', 'localhost'] with output_timeout 3600 08:52:24 INFO - mozversion INFO | application_buildid: 20151202071122 08:52:24 INFO - mozversion INFO | application_changeset: bd29d7c987b554842ccee62dad4dec506e98227e 08:52:24 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 08:52:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:24 INFO - mozversion INFO | application_name: Firefox 08:52:24 INFO - mozversion INFO | application_remotingname: firefox-dev 08:52:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:52:24 INFO - mozversion INFO | application_vendor: Mozilla 08:52:24 INFO - mozversion INFO | application_version: 44.0a2 08:52:24 INFO - mozversion INFO | platform_buildid: 20151202071122 08:52:24 INFO - mozversion INFO | platform_changeset: bd29d7c987b554842ccee62dad4dec506e98227e 08:52:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:52:24 INFO - mozversion INFO | platform_version: 44.0a2 08:52:24 INFO - 2015-12-02 08:52:24,291 DEBUG : using testdate: 1449075144 08:52:24 INFO - 2015-12-02 08:52:24,291 DEBUG : actual date: 1449075144 08:52:24 INFO - 2015-12-02 08:52:24,340 INFO : starting webserver on 'localhost:49270' 08:52:24 INFO - 2015-12-02 08:52:24,341 INFO : Starting test suite t-yosemite-r5-0018.e 08:52:24 INFO - 2015-12-02 08:52:24,341 INFO : Starting test dromaeo_css 08:52:24 INFO - 2015-12-02 08:52:24,342 DEBUG : operating with platform_type : mac_ 08:52:24 INFO - 2015-12-02 08:52:24,342 INFO : Initialising browser for dromaeo_css test... 08:52:24 INFO - 2015-12-02 08:52:24,369 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmph12ZRp/profile http://localhost:49270/getInfo.html 08:52:27 INFO - 2015-12-02 08:52:27,756 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:52:27 INFO - 2015-12-02 08:52:27,756 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:52:27 INFO - 2015-12-02 08:52:27,756 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:52:27 INFO - 2015-12-02 08:52:27,756 DEBUG : BROWSER_OUTPUT: __metrics 08:52:28 INFO - 2015-12-02 08:52:28,378 INFO : Browser initialized. 08:52:28 INFO - 2015-12-02 08:52:28,378 INFO : Running cycle 1/1 for dromaeo_css test... 08:52:28 INFO - 2015-12-02 08:52:28,379 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmph12ZRp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:52:40 INFO - 2015-12-02 08:52:40,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 210137088 08:52:40 INFO - 2015-12-02 08:52:40,395 DEBUG : BROWSER_OUTPUT: 08:53:30 INFO - 2015-12-02 08:53:30,261 DEBUG : BROWSER_OUTPUT: 1449075210258 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] 08:55:41 INFO - 2015-12-02 08:55:41,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:55:42 INFO - 2015-12-02 08:55:42,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 238227456 08:55:42 INFO - 2015-12-02 08:55:42,488 DEBUG : BROWSER_OUTPUT: 08:58:44 INFO - 2015-12-02 08:58:44,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:58:45 INFO - 2015-12-02 08:58:45,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 243089408 08:58:45 INFO - 2015-12-02 08:58:45,095 DEBUG : BROWSER_OUTPUT: 09:01:46 INFO - 2015-12-02 09:01:46,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 09:01:47 INFO - 2015-12-02 09:01:47,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 245309440 09:01:47 INFO - 2015-12-02 09:01:47,418 DEBUG : BROWSER_OUTPUT: 09:04:49 INFO - 2015-12-02 09:04:49,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 09:04:49 INFO - 2015-12-02 09:04:49,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 248057856 09:04:49 INFO - 2015-12-02 09:04:49,670 DEBUG : BROWSER_OUTPUT: 09:07:52 INFO - 2015-12-02 09:07:52,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 09:07:52 INFO - 2015-12-02 09:07:52,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 254275584 09:07:52 INFO - 2015-12-02 09:07:52,855 DEBUG : BROWSER_OUTPUT: 09:10:55 INFO - 2015-12-02 09:10:55,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 09:10:55 INFO - 2015-12-02 09:10:55,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 258703360 09:10:55 INFO - 2015-12-02 09:10:55,347 DEBUG : BROWSER_OUTPUT: 09:10:55 INFO - 2015-12-02 09:10:55,347 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:10:55 INFO - 2015-12-02 09:10:55,348 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:10:55 INFO - 2015-12-02 09:10:55,348 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:10:55 INFO - 2015-12-02 09:10:55,348 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:10:55 INFO - 2015-12-02 09:10:55,348 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2906.9273268168295;2941.558766185072;2951.7343439090478;2953.719396657318;2971.4057188562288;4927.310176575278;4933.062718083562;5011.799528018884;5016.648834581581;5036.068327359441;4992.7753251103695;4995.775190116445;5011.148104822179;5024.070546948817;5088.49115088491;4428.933565996513;4525.728456292633;4602.884927876813;4643.628509719231;4655.394798676184;4469.798859051334;4471.351654010166;4504.977475112636;4553.317002449626;4607.792649330771;4472.53038430965;4482.596566309032;4525;4529.547045295477;4563.201439748031;4384.21084204843;4567.908641827162;4622.352870598119;4623.930641040387;4642.721436713774;4434.911301773978;4473.172463094338;4503.324501324795;4552.68131230814;4554.407926969506;4789.56893879549;4830.879228019293;4929.816843957425;4989.126902791997;5049.747512624354;5076.36545431821;5166.638335316529;5205.895882082337;5291.3650361956425;5303.284056652341;5315.973420132875;5393.487618676219;5445.319335083114;5449.6730196187955;5455.863603409907;5005.849824505271;5026.220935754964;5027.974860125676;5047.848564543069;5086.923696144598;5117.795288188505;5183.585313174937;5265.868353291122;5376.623636345418;5492.752826122754;5108.361454818148;5110.693358398508;5124.538791508782;5168.069747445421;5172.120739474299;5226.216067589892;5249.947500525022;5257.842264732064;5297.125974214211;5306.92039619406;5011.674241174312;5131.204663277198;5152.974235128875;5162.6902385856965;5192.1173400522;5242.659227150223;5277.551408130275;5284.233786100994;5326.627136100513;5344.225087362311;4160.563140870226;4197.622214000694;4198.748075115503;4211.557786432441;4214.304639734471;3580.838862251205;3630.09247688078;3671.2290419012306;3776.4712940188397;3779.3764028935466;4875.317455556225;4886.998165376161;4898.926516102261;4913.828016019494;4944.431390390151;5287;5328.280682107943;5335.573154147659;5352.866178345573;5366.463353664602;4566.725996440225;4707.270373092176;4740.881477963009;4862.319275301461;4913.901721965541;4627.3521706961055;4647.535246475393;4682.531746825291;4686.133065382915;4722.433308003062;5123.38519377677;5308.2464379526755;5318.494742999409;5367.1680889462195;5377.838664840061;5238.738063096906;5347.839564813062;5375.247465354775;5397.757100930389;5421.457854214547;5264.736763161904;5285.9471405286995;5325.440828713085;5333.066713325075;5363.651362661414;4950.133726597759;5135.87160320995;5178.300929374486;5216.530512253916;5221.216817477409;4965.602751779921;5154.871128221825;5227.451117632746;5265.921011184912;5332.653377530448;5205.375354957429;5228.71242081674;5231.503007214308;5264.789408423773;5275.208718692227;5040.16837221869;5077.796888124433;5163.561097306771;5189.818356357509;5259.21111833228;4950.430700469492;4999.250112483157;5036.722980236123;5047.4952504749235;5049.8737531562;5105.183170692671;5148.897022059613;5189.844304670866;5192.117340052125;5230.163173892159;4921.360223170965;5011.9976004798455;5086.3896332440345;5108.208227724708;5108.79564817418 09:10:55 INFO - 2015-12-02 09:10:55,350 DEBUG : BROWSER_OUTPUT: |1;ext.html;506.5188071332233;515.0934355534259;525.0968334464719;526.1187510919209;539.0109149710281;32914.50628240578;33784.49323260153;33870.49194262088;33883.83058084709;34288.31423371531;37447.43828842569;38149.42775858357;38154;38161;38192.618073819256;8282.668693252263;8297.253247207751;8437.493750374966;8438.915610843906;8452.957735211347;8283.668653253862;8286.668533258662;8353.707620233294;8378.329733621325;8395.496270223775;8253.876191857127;8276.627551760184;8293.253607175353;8355.289800366945;8363.080061193265;8186.508809471451;8282.254597086292;8374.623141958597;8380.413371064027;8403.41176117672;8057.274845263954;8178.550179740112;8186.345092392594;8265;8268.710595129141;34522.48216276758;34532.482012769826;34964.82517587396;35033.824830875936;35060.64939350599;2619.3320703220556;2642.2733748219202;2649.2714503511497;2687.8252913560555;2706.7563919247364;24536.631950520758;25381.111661091774;25480.745192548024;25641.102561410447;26297.474050518882;2073.6060148571873;2074.471009892483;2078.251829341436;2087.081684059024;2130.243763463979;214422;216945;217487;217570;218239.90880045656;50192.247116293285;51696.48303516916;51885.740571296905;52335.47664523306;56917.71541142268;54692.72653636707;54889.176662350095;55123;55176.72411637996;55257;15996;16026.519204423887;16048.19759012068;16202.837971620369;16221.675566488604;11951.16341856079;12013.939930300467;12090.69773255658;12162.148649594443;12178.330191839357;17512.299508019536;17598.29606815713;17708.734368984475;17752.28990840352;17782.822171778116;7359;7547.16981132075;7592.240775922363;7597.164311925684;7642.7325043623205;819.3158712475031;910.9706032183723;1035.632350515556;1052.1109662335314;1055.3351388625117;26355.86822065916;26780.19659410221;27539.586906196022;28933.276668083465;29105.85447072751;980.1927646297277;988.7330420786348;994.5872462927948;1037.6990672704983;1052.1793001458875;13209.40557674907;13562.93218533901;13956.860431395758;14634.707305853823;14703.41186352534;222141;227170;229519;229736;230020;50556;50684.239736403986;50708.23937640939;50821.23768143481;51279.46161615157;1256.5288016993627;1258.4022589270023;1305.6213698027655;1307.5162189989574;1308.7305313845554;26666.600001000388;26826.59760103561;27262.011787034106;27392.315192120357;27558;43534;43937.34093988529;43977.78011109924;44050.55949440593;44141.558584413746;282399;286754;286795;286937;287566;27824.44351113007;28389.290267743472;29439.85280073586;29468.263293417836;29754.70245297606;34480.65519344775;35292;35419.468707969914;35488.822555887054;36072.27855442824;29202.561961571017;29908.551371729878;30201.697983020767;30641.54037689481;31968;29856.402871942875;30224;30514.542281865346;30526;30639.54040689436;30881.073567793002;30930.536041958938;31119.844400777853;32449;32930.17674558155;28247.43505129845;28301.71698282991;28676;28962.420751585272;29566.260843479085;21869.453263668536;22024.889875551162;22236.444088897908;22735.317940461813;22770.43073923165 09:10:55 INFO - 2015-12-02 09:10:55,353 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.4440723308894;314.6114548532563;317.3541842350817;324.3448234566176;325.2113624460682;10767.676969690901;11126.38804865732;15847.84152158478;16458.177091145426;16481.50555483336;10816.837747433794;10848.837267440995;11130.554777808899;11201.159913006537;11203.60787372442;3922.9996350930546;4026.1746341999965;4027.8791636250958;4036.011177261575;4037.878863634081;3946.861859834906;4002.1995600879795;4016.2369149861433;4024.215278020787;4075.1645912587846;3234.110619579611;3324.2188085799817;4022.8189731462007;4023.5976402359825;4226.556211597784;4341.587549182823;4366.956330436703;4378.540253273408;4395.626371758372;4398.274284743014;3680.6319368063246;3713.3687273163355;3746.4380342948502;3748.3815170496837;3754.793486358249;11673.649790506299;11749.706257343549;12028.939855300756;12035.819462708067;12079.758404831942;1569.9529014129594;1668.8664906807549;1760.815114412981;1786.9910650446664;1823.8632102592358;8556.401051926368;8575.699850505265;8686;8700.825983480296;8948.149925757043;1345.5559665310523;1363.7068030373516;1404.6418163368378;1432.10493441599;1472.263868065967;53044.20433693498;54830.45169548293;54964.45035549633;55739.72130139364;55968.720156399366;6171.7531298748445;6188.412100850412;6202.968985155046;6224.688765561704;6256.186695729526;6805.591664500146;7073.504854660125;7110.857782844314;7111.679974401164;7171.533850299714;5166.250893620404;5189.7405129743365;5218.269442278084;5219.347581552306;5280.9207861882105;5562.9443705563235;5578.330600327987;5583.916241256385;5629.211910332557;5658.405867383948;2736.521108805991;2768.224897028835;2786.6098746175553;2787.0941943868324;2806.116073436902;975.7658162041059;976.4141515090888;978.4814048554277;987.0770829274508;992.9375568142019;385.89002134391563;403.0005586146315;418.7738621144609;422.81818817908595;429.6906227516183;9285;11401.600943966921;11458.54165833374;11580.131490138274;11644.184907056595;419.767029298736;421.8144016632672;422.9809658565372;426.9786510674454;445.9152760975404;5410.404855465896;5547.639403438763;5798.072308430631;5934.228550288522;6000.729967151488;474907;483658;490401;495714;502123;67230.32769672338;70603;70868.64565677139;70890.64554677194;72799.63600181966;407.4112906849574;416.50851994646;423.50872987335157;426.17322394554463;433.59458905923066;9239.39943903644;9495.43027418357;9702.175315098295;9732.12410883024;9935.155511781579;32789.67210327866;32977.505337419476;33000.66999330072;33023.339533209684;33242.83650072236;45011.54988450074;45621.034632748764;46263.768681156376;46505.302420464395;46601.53398465972;7321.707131714885;7346.926530734624;7413.851722965403;7496.137944136276;7505.812354691177;10568.682939511827;10963.342199468058;11173.888261117285;11196.608118715805;11217.775644487228;9555.426674399558;9642.469664168539;9697.951510242403;9740.951295243762;9743.853842192231;8345.248927596545;8935.776605584653;9146.542672866462;9224.723258302261;9306.953465232631;9317.580708868252;9430.151286384258;9503.524823758922;9515.762105947406;9665.9033409665;7242.855142897007;7302.488825782144;7427.888581671171;7512.699492020258;7532.246775322424;9471.337006409485;9619.51902404863;9700.029997000243;9717.22262219035;9732.80534389294 09:10:55 INFO - 2015-12-02 09:10:55,353 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1440.1287221231148;1622.95942601435;1655.693696666117;1666.6000159961604;1680.9495715128544;5983.521318294537;6117.204763380765;6420.133282006927;6821.420179284761;6823;6403.103565500822;6623.768168114117;6709.597424154555;6711.563748356366;6715.160604924385;1929.2090243000373;1940.8544359173047;1959.7452331196996;1960.2649006622516;1964.8329891959202;1963.0773536437923;1978.4361456984761;1998.6902030185272;2013.4060452166646;2018.1322031526438;1933.787283398825;1937.8449724022114;1954.7067939809;1959.823615874571;1961.1272983522338;1894.2328357015363;1913.808619138089;1920.8655394122418;1923.5671973805852;1923.5864289177894;1960;1992.5417154054503;1992.671209250472;1993.0333788112753;1993.8404927605757;6638.73445062197;6785.525013249075;6788.355106264897;6810.761623343209;6840.623765692885;4096.201240758053;4163.854265100707;4164.708470407073;4171.749695018309;4184.037671335579;2442.2795275393623;2490.4645501217324;2492.6385674077155;2529.5320365732214;2537.4671319023028;747.1706405889458;750;750.2497502497503;769.0809482668213;780.8243145292321;8530;8540.359473039547;8545.401821872472;8564.272036876873;8602.225799677997;3694.5012423323046;3696.1129328960856;3716.4611131385795;3716.572594151707;3729.7948612826553;7557;7574.977378053893;7581.886271705929;7587.886181707278;7588.468807183554;4206.053637931441;4212.347086201644;4213.2837417639075;4213.810378532973;4241.851535196253;3475.2007038380807;3555.591107022674;3852.114013776847;3854.0557563396587;3856.1709232515145;3079.892203772857;3166.493361062265;3204.3110731192905;3240.756943229267;3245.4158251514955;1025.9846102308472;1035.3684252605904;1040.9011143941314;1044.368157264859;1044.9216308776872;912.5574096563162;989.010989010989;1049.7585555322319;1181.6041626055196;1193.7433451807904;5912.201852749909;5943.286805583271;6028.608140470856;6029.276486821609;6055.666938318434;1045.3153184663904;1054.4674939155677;1055.9736006599896;1062.1184416934082;1067.8611780468646;4965.925511117336;5123.257127716461;5125.154349532286;5126.769295381717;5167.224916262516;7719.498232614975;7826.804329891798;7917.643706033243;7933.206679332021;7939;7869.449138560361;7872.685092596346;7873.881891771628;7879.330256928225;7942.483738556975;6333.841653958688;6347.904781428282;6368.968155159195;6371.490280777527;6378.52161087911;6037.396260374103;6073.878522429438;6137.140800287874;6137.60105593135;6138.355472675484;7028.367446929801;7151.392131668867;7160.355567998905;7168.390686791681;7232.168300645493;7149.463790215858;7287.562746235243;7295.306945840137;7342.596157211405;7350.558966462029;5499.927514134865;5585.2180694701965;5998.280206375263;6030.065339872327;6052.182955300978;5974.522038237017;6081.756729730761;6082.239720034996;6132.141500190066;6139;5898.056310990221;5903.822885313448;5972.283326000907;6026.879462410815;6115.571909966259;5670.546356291405;5735.856603584777;5782.5373970081455;5795.7391917362975;5796.1305804129715;5887.735051922759;5908.852278693067;5941.049432090845;5951.732172052355;5957.6127551709;5117.5394214520875;5120.385553733576;5131.384233891957;5138.409082955359;5154.871128221675;5271.4464981176425;5280.313559237275;5288.4182739897815;5310.176922577007;5340.305760251143 09:10:55 INFO - 2015-12-02 09:10:55,357 DEBUG : BROWSER_OUTPUT: |4;prototype.html;297.98808047678097;301.25589793210764;306.36429408976375;306.61060453224405;311.03113800511386;5487.094629386152;5565.972170139144;5569.025420551403;5581.2186293918885;5609.971950140254;5427.728613569326;5452.536534394571;5457.617966742329;5469.206964990074;5501.889962200754;4087.9386809197886;4240.363945408182;4257.340112282601;4258.339957306614;4264.680148988823;4130.524989626201;4141.378793181032;4177.916441671165;4180.372944058385;4215.451991241134;4112.773797441139;4130.8554200602985;4145.253854306224;4145.813438395265;4150.771707556083;4147.087640719037;4148.585141485873;4154.480689913761;4159.126583417486;4170.998960249549;3623.1123374773088;3627.7823330599986;3631.909202269938;3633.8364773585254;3657.3782456982112;5212.452692467275;5366.409694933554;5370.275012873251;5378.46215378463;5404.702741349224;4783.354247176656;4807.110684523374;4821.132196204681;4835.758212089417;4841.2012018016985;5819.476247137735;5823.9708801456145;5828.0966450200285;5836.883262334772;5845.09401042839;4022.557518672973;4027.6979226558124;4029.879103626896;4031.4355990161403;4034.394840773878;5877.735501902424;6058.121572372025;6068.089786532011;6069.332373438918;6069.393060693939;4108.506979162519;4111.403846442249;4115;4116.156187981456;4119.361498967664;4152.563980781974;4174.519930208005;4179.185058913544;4181.937270940938;4187.057911969782;4791;4800.95199048012;4804.543568361;4810.903781924412;4845.2732090186755;5675.262215911905;5786.218860453869;5800.651960882361;5810.12848072784;5817.941820581825;1437.73401920645;1441.8558144185497;1444.3572610188364;1444.7255021545873;1445.104035497998;921.4287141971886;929.2101713543434;933.7385532051037;934.0332755597924;945.5603144537823;5441.047816632074;5450.482204190595;5471.2887324647545;5481.177823326533;5522.779088836402;5847.707614619252;5942.524598032147;5965.910511342333;6088;6105.877882442415;5466.890662186814;5494.203340515683;5508.173773933861;5551.500364967173;5554;3297.0603378037144;3328.1014126185796;3334.5164951081956;3339.1652086978256;3342.147752323142;5992.43071908168;6045.516358691382;6057.151998720183;6064.75740970365;6119.938800612026;6159.384061593894;6171.290301615282;6173.166622505904;6178.505719542516;6240.126382306481;6042.909356359746;6067.1202675611785;6103.786367477117;6118.143459915705;6123.540734444934;6008.098785182257;6011.939880601138;6022.5784195105925;6036.094585811988;6052.273727152769;5800.767969281182;5914.852128696817;5943.227380440515;5973.074173503114;5994.67029313392;6091.421314975248;6094.299155597163;6094.512439004958;6135.049067394561;6142.57002009855;3824.521934758155;3862.633049860259;3877.1470276539117;3880.592537783492;3894.279558281727;5872.148538461985;5940.732667029907;6032.33644299118;6086.239220097488;6089.786857459968;5923;5923.466887980103;5925.525957923442;5949.732262048305;5977.671228082323;5907.3797251288;5910.970445147746;5917.940820591739;5928.614640048383;5967.46292833647;5573.637713548606;5742.626729262584;5748.712564371681;5751.424857514383;5806.738696758572;5851.765929362778;5914.172015917861;5915.438033386821;5916.023856063702;5947.732352044082;5563.248961390161;5780.566457515787;5797.4782269595935;5799.884002319845;5802.593818432669 09:10:55 INFO - 2015-12-02 09:10:55,358 DEBUG : BROWSER_OUTPUT: |5;yui.html;627.28802808812;665.8002599220233;672.3478226120661;690.4165979747112;702.2415790945776;12053.45759440825;12351.444185011673;12365.814512782315;12372.319522426264;12393.690157746061;11725.58960436385;11759.941200294008;11852.881471185307;11864.940675296612;11873.703157421069;655.5476721062475;674.3762020131384;766.5477368352671;819.983600327993;821.2977903892175;792.3581898662073;796.9721059762909;810.068421315486;813.4712436915993;819.6557445872718;858.4763294390417;870.1907226279558;870.4733636150133;879.6041781198454;880.4013270975734;850.31974420464;860.5267103093273;865.7056600755742;867.8394497018072;873.5544872115204;641.4483544152025;642.3351830855089;642.4474951541671;645.4255712415953;646.6249575246346;11029.227954043221;11122.666320010412;11171.44142792857;11266.887331126747;11272.774544509064;10004.59981600735;10246.590136394536;10433.79132417355;10751.408672523008;10952.123830093573;7905.565193914333;7909.96045019777;7981.441299109065;8131.06492753335;8145.837083258301;2989.387175628991;3024.9395012099853;3039.7720170987263;3098.070578826343;3130.796498227608;43601.12797744059;43673.34489982653;43745.343819842725;43783.68648940537;44061.33907991383;7722.3049925506975;8000.759977200693;8148.5518296494265;8365.58172091393;8551.273141782895;17896.55258618519;17922;18058;18064.36774712879;18076.638467230845;6190.350013248544;6446.129772480655;6498.772542961068;6601;6710.328967103251;3497.527833742463;3509.842057107436;3573.1424458129864;3591.2099338145567;3652.141746689526;2790.0932197036045;2819.379736457976;2841.6732075811133;2851.9429611407654;2858.7284208000624;397.2888529532105;399.5285563035646;403.67302484987255;404.8502054239891;408.9100397912454;384.4118498696998;489.36138339466623;490.07620635103086;491.79836267130304;515.6957395136887;6436.485081193493;6467.353264673589;6515.90762636936;6521.673916304166;6597.60414375139;433.9804708788112;435.45133132252954;453.2883373104195;527.5489456514701;536.7691892486268;3177.6345720242007;3279.212988882651;3293.357795229955;3684.318401095752;3686.944695829565;52267.21599176015;52705.47294527082;52743;52838;53311;45989.310160347624;46344.07311853744;46468.535314647095;46600.5339946603;46736.06527869424;41917.371239431435;41968.370474442905;42691;42966.570334296885;43485.130297394506;7177.677004534704;7260.89108663381;7330;7338.926610733824;7353.191148973501;30885.227869303446;31194;31272;31971.520427194075;31985.680143199203;38499.23001539898;38571.614283856805;39638.60361396349;42465.36301955411;42498.575014250695;6802.795916122524;6848.417884479676;6984.895226571504;7161.749338773118;7381.557106573623;9598.712038638852;9937.950310248403;10081.395116293046;10167.18662506983;10173.338732982333;8871.822563548822;9143.634254630006;9326.533673316442;9329.246178228457;9496.382735122195;9322.533873306173;9396.483193424427;9518.904810951803;9561.330706850455;9834.409935403899;8106.432549721463;8562.400631955703;8911.866322005304;9040.63837446521;9330.393524420891;7938.603069846369;7943.165967573322;8141.552214628252;8193.46742461738;8345.207205315486;7701.53790772533;8142.063662678867;8144.918550814416;8157.8368432632205;8386.454880432751 09:10:55 INFO - 2015-12-02 09:10:55,358 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:10:55 INFO - 2015-12-02 09:10:55,359 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:10:55 INFO - 2015-12-02 09:10:55,359 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,280 09:10:55 INFO - 2015-12-02 09:10:55,359 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:10:55 INFO - 2015-12-02 09:10:55,359 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076255344__endTimestamp 09:10:55 INFO - 2015-12-02 09:10:55,359 DEBUG : BROWSER_OUTPUT: 09:10:55 INFO - 2015-12-02 09:10:55,360 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:10:55 INFO - 2015-12-02 09:10:55,360 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:10:55 INFO - 2015-12-02 09:10:55,360 DEBUG : BROWSER_OUTPUT: 09:10:55 INFO - 2015-12-02 09:10:55,360 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4903.15 Median:5049.75 stddev:517.38 (10.2%) stddev-sans-first:494.70 09:10:55 INFO - 2015-12-02 09:10:55,362 DEBUG : BROWSER_OUTPUT: Values: 2906.9 2941.6 2951.7 2953.7 2971.4 4927.3 4933.1 5011.8 5016.6 5036.1 4992.8 4995.8 5011.1 5024.1 5088.5 4428.9 4525.7 4602.9 4643.6 4655.4 4469.8 4471.4 4505.0 4553.3 4607.8 4472.5 4482.6 4525.0 4529.5 4563.2 4384.2 4567.9 4622.4 4623.9 4642.7 4434.9 4473.2 4503.3 4552.7 4554.4 4789.6 4830.9 4929.8 4989.1 5049.7 5076.4 5166.6 5205.9 5291.4 5303.3 5316.0 5393.5 5445.3 5449.7 5455.9 5005.8 5026.2 5028.0 5047.8 5086.9 5117.8 5183.6 5265.9 5376.6 5492.8 5108.4 5110.7 5124.5 5168.1 5172.1 5226.2 5249.9 5257.8 5297.1 5306.9 5011.7 5131.2 5153.0 5162.7 5192.1 5242.7 5277.6 5284.2 5326.6 5344.2 4160.6 4197.6 4198.7 4211.6 4214.3 3580.8 3630.1 3671.2 3776.5 3779.4 4875.3 4887.0 4898.9 4913.8 4944.4 5287.0 5328.3 5335.6 5352.9 5366.5 4566.7 4707.3 4740.9 4862.3 4913.9 4627.4 4647.5 4682.5 4686.1 4722.4 5123.4 5308.2 5318.5 5367.2 5377.8 5238.7 5347.8 5375.2 5397.8 5421.5 5264.7 5285.9 5325.4 5333.1 5363.7 4950.1 5135.9 5178.3 5216.5 5221.2 4965.6 5154.9 5227.5 5265.9 5332.7 5205.4 5228.7 5231.5 5264.8 5275.2 5040.2 5077.8 5163.6 5189.8 5259.2 4950.4 4999.3 5036.7 5047.5 5049.9 5105.2 5148.9 5189.8 5192.1 5230.2 4921.4 5012.0 5086.4 5108.2 5108.8 09:10:55 INFO - 2015-12-02 09:10:55,362 DEBUG : BROWSER_OUTPUT: 09:10:55 INFO - 2015-12-02 09:10:55,362 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40148.87 Median:30520.27 stddev:63993.93 (209.7%) stddev-sans-first:64104.23 09:10:55 INFO - 2015-12-02 09:10:55,363 DEBUG : BROWSER_OUTPUT: Values: 506.5 515.1 525.1 526.1 539.0 32914.5 33784.5 33870.5 33883.8 34288.3 37447.4 38149.4 38154.0 38161.0 38192.6 8282.7 8297.3 8437.5 8438.9 8453.0 8283.7 8286.7 8353.7 8378.3 8395.5 8253.9 8276.6 8293.3 8355.3 8363.1 8186.5 8282.3 8374.6 8380.4 8403.4 8057.3 8178.6 8186.3 8265.0 8268.7 34522.5 34532.5 34964.8 35033.8 35060.6 2619.3 2642.3 2649.3 2687.8 2706.8 24536.6 25381.1 25480.7 25641.1 26297.5 2073.6 2074.5 2078.3 2087.1 2130.2 214422.0 216945.0 217487.0 217570.0 218239.9 50192.2 51696.5 51885.7 52335.5 56917.7 54692.7 54889.2 55123.0 55176.7 55257.0 15996.0 16026.5 16048.2 16202.8 16221.7 11951.2 12013.9 12090.7 12162.1 12178.3 17512.3 17598.3 17708.7 17752.3 17782.8 7359.0 7547.2 7592.2 7597.2 7642.7 819.3 911.0 1035.6 1052.1 1055.3 26355.9 26780.2 27539.6 28933.3 29105.9 980.2 988.7 994.6 1037.7 1052.2 13209.4 13562.9 13956.9 14634.7 14703.4 222141.0 227170.0 229519.0 229736.0 230020.0 50556.0 50684.2 50708.2 50821.2 51279.5 1256.5 1258.4 1305.6 1307.5 1308.7 26666.6 26826.6 27262.0 27392.3 27558.0 43534.0 43937.3 43977.8 44050.6 44141.6 282399.0 286754.0 286795.0 286937.0 287566.0 27824.4 28389.3 29439.9 29468.3 29754.7 34480.7 35292.0 35419.5 35488.8 36072.3 29202.6 29908.6 30201.7 30641.5 31968.0 29856.4 30224.0 30514.5 30526.0 30639.5 30881.1 30930.5 31119.8 32449.0 32930.2 28247.4 28301.7 28676.0 28962.4 29566.3 21869.5 22024.9 22236.4 22735.3 22770.4 09:10:55 INFO - 2015-12-02 09:10:55,364 DEBUG : BROWSER_OUTPUT: 09:10:55 INFO - 2015-12-02 09:10:55,364 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24501.65 Median:45942.40 stddev:80287.30 (174.8%) stddev-sans-first:80491.98 09:10:55 INFO - 2015-12-02 09:10:55,365 DEBUG : BROWSER_OUTPUT: Values: 311.4 314.6 317.4 324.3 325.2 10767.7 11126.4 15847.8 16458.2 16481.5 10816.8 10848.8 11130.6 11201.2 11203.6 3923.0 4026.2 4027.9 4036.0 4037.9 3946.9 4002.2 4016.2 4024.2 4075.2 3234.1 3324.2 4022.8 4023.6 4226.6 4341.6 4367.0 4378.5 4395.6 4398.3 3680.6 3713.4 3746.4 3748.4 3754.8 11673.6 11749.7 12028.9 12035.8 12079.8 1570.0 1668.9 1760.8 1787.0 1823.9 8556.4 8575.7 8686.0 8700.8 8948.1 1345.6 1363.7 1404.6 1432.1 1472.3 53044.2 54830.5 54964.5 55739.7 55968.7 6171.8 6188.4 6203.0 6224.7 6256.2 6805.6 7073.5 7110.9 7111.7 7171.5 5166.3 5189.7 5218.3 5219.3 5280.9 5562.9 5578.3 5583.9 5629.2 5658.4 2736.5 2768.2 2786.6 2787.1 2806.1 975.8 976.4 978.5 987.1 992.9 385.9 403.0 418.8 422.8 429.7 9285.0 11401.6 11458.5 11580.1 11644.2 419.8 421.8 423.0 427.0 445.9 5410.4 5547.6 5798.1 5934.2 6000.7 474907.0 483658.0 490401.0 495714.0 502123.0 67230.3 70603.0 70868.6 70890.6 72799.6 407.4 416.5 423.5 426.2 433.6 9239.4 9495.4 9702.2 9732.1 9935.2 32789.7 32977.5 33000.7 33023.3 33242.8 45011.5 45621.0 46263.8 46505.3 46601.5 7321.7 7346.9 7413.9 7496.1 7505.8 10568.7 10963.3 11173.9 11196.6 11217.8 9555.4 9642.5 9698.0 9741.0 9743.9 8345.2 8935.8 9146.5 9224.7 9307.0 9317.6 9430.2 9503.5 9515.8 9665.9 7242.9 7302.5 7427.9 7512.7 7532.2 9471.3 9619.5 9700.0 9717.2 9732.8 09:10:55 INFO - 2015-12-02 09:10:55,365 DEBUG : BROWSER_OUTPUT: 09:10:55 INFO - 2015-12-02 09:10:55,365 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4626.52 Median:5703.20 stddev:2326.96 (40.8%) stddev-sans-first:2321.17 09:10:55 INFO - 2015-12-02 09:10:55,365 DEBUG : BROWSER_OUTPUT: Values: 1440.1 1623.0 1655.7 1666.6 1680.9 5983.5 6117.2 6420.1 6821.4 6823.0 6403.1 6623.8 6709.6 6711.6 6715.2 1929.2 1940.9 1959.7 1960.3 1964.8 1963.1 1978.4 1998.7 2013.4 2018.1 1933.8 1937.8 1954.7 1959.8 1961.1 1894.2 1913.8 1920.9 1923.6 1923.6 1960.0 1992.5 1992.7 1993.0 1993.8 6638.7 6785.5 6788.4 6810.8 6840.6 4096.2 4163.9 4164.7 4171.7 4184.0 2442.3 2490.5 2492.6 2529.5 2537.5 747.2 750.0 750.2 769.1 780.8 8530.0 8540.4 8545.4 8564.3 8602.2 3694.5 3696.1 3716.5 3716.6 3729.8 7557.0 7575.0 7581.9 7587.9 7588.5 4206.1 4212.3 4213.3 4213.8 4241.9 3475.2 3555.6 3852.1 3854.1 3856.2 3079.9 3166.5 3204.3 3240.8 3245.4 1026.0 1035.4 1040.9 1044.4 1044.9 912.6 989.0 1049.8 1181.6 1193.7 5912.2 5943.3 6028.6 6029.3 6055.7 1045.3 1054.5 1056.0 1062.1 1067.9 4965.9 5123.3 5125.2 5126.8 5167.2 7719.5 7826.8 7917.6 7933.2 7939.0 7869.4 7872.7 7873.9 7879.3 7942.5 6333.8 6347.9 6369.0 6371.5 6378.5 6037.4 6073.9 6137.1 6137.6 6138.4 7028.4 7151.4 7160.4 7168.4 7232.2 7149.5 7287.6 7295.3 7342.6 7350.6 5499.9 5585.2 5998.3 6030.1 6052.2 5974.5 6081.8 6082.2 6132.1 6139.0 5898.1 5903.8 5972.3 6026.9 6115.6 5670.5 5735.9 5782.5 5795.7 5796.1 5887.7 5908.9 5941.0 5951.7 5957.6 5117.5 5120.4 5131.4 5138.4 5154.9 5271.4 5280.3 5288.4 5310.2 5340.3 09:10:55 INFO - 2015-12-02 09:10:55,366 DEBUG : BROWSER_OUTPUT: 09:10:55 INFO - 2015-12-02 09:10:55,367 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4854.88 Median:5558.62 stddev:1473.32 (26.5%) stddev-sans-first:1437.21 09:10:55 INFO - 2015-12-02 09:10:55,367 DEBUG : BROWSER_OUTPUT: Values: 298.0 301.3 306.4 306.6 311.0 5487.1 5566.0 5569.0 5581.2 5610.0 5427.7 5452.5 5457.6 5469.2 5501.9 4087.9 4240.4 4257.3 4258.3 4264.7 4130.5 4141.4 4177.9 4180.4 4215.5 4112.8 4130.9 4145.3 4145.8 4150.8 4147.1 4148.6 4154.5 4159.1 4171.0 3623.1 3627.8 3631.9 3633.8 3657.4 5212.5 5366.4 5370.3 5378.5 5404.7 4783.4 4807.1 4821.1 4835.8 4841.2 5819.5 5824.0 5828.1 5836.9 5845.1 4022.6 4027.7 4029.9 4031.4 4034.4 5877.7 6058.1 6068.1 6069.3 6069.4 4108.5 4111.4 4115.0 4116.2 4119.4 4152.6 4174.5 4179.2 4181.9 4187.1 4791.0 4801.0 4804.5 4810.9 4845.3 5675.3 5786.2 5800.7 5810.1 5817.9 1437.7 1441.9 1444.4 1444.7 1445.1 921.4 929.2 933.7 934.0 945.6 5441.0 5450.5 5471.3 5481.2 5522.8 5847.7 5942.5 5965.9 6088.0 6105.9 5466.9 5494.2 5508.2 5551.5 5554.0 3297.1 3328.1 3334.5 3339.2 3342.1 5992.4 6045.5 6057.2 6064.8 6119.9 6159.4 6171.3 6173.2 6178.5 6240.1 6042.9 6067.1 6103.8 6118.1 6123.5 6008.1 6011.9 6022.6 6036.1 6052.3 5800.8 5914.9 5943.2 5973.1 5994.7 6091.4 6094.3 6094.5 6135.0 6142.6 3824.5 3862.6 3877.1 3880.6 3894.3 5872.1 5940.7 6032.3 6086.2 6089.8 5923.0 5923.5 5925.5 5949.7 5977.7 5907.4 5911.0 5917.9 5928.6 5967.5 5573.6 5742.6 5748.7 5751.4 5806.7 5851.8 5914.2 5915.4 5916.0 5947.7 5563.2 5780.6 5797.5 5799.9 5802.6 09:10:55 INFO - 2015-12-02 09:10:55,367 DEBUG : BROWSER_OUTPUT: 09:10:55 INFO - 2015-12-02 09:10:55,368 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12145.79 Median:53074.50 stddev:14647.59 (27.6%) stddev-sans-first:14663.15 09:10:55 INFO - 2015-12-02 09:10:55,369 DEBUG : BROWSER_OUTPUT: Values: 627.3 665.8 672.3 690.4 702.2 12053.5 12351.4 12365.8 12372.3 12393.7 11725.6 11759.9 11852.9 11864.9 11873.7 655.5 674.4 766.5 820.0 821.3 792.4 797.0 810.1 813.5 819.7 858.5 870.2 870.5 879.6 880.4 850.3 860.5 865.7 867.8 873.6 641.4 642.3 642.4 645.4 646.6 11029.2 11122.7 11171.4 11266.9 11272.8 10004.6 10246.6 10433.8 10751.4 10952.1 7905.6 7910.0 7981.4 8131.1 8145.8 2989.4 3024.9 3039.8 3098.1 3130.8 43601.1 43673.3 43745.3 43783.7 44061.3 7722.3 8000.8 8148.6 8365.6 8551.3 17896.6 17922.0 18058.0 18064.4 18076.6 6190.4 6446.1 6498.8 6601.0 6710.3 3497.5 3509.8 3573.1 3591.2 3652.1 2790.1 2819.4 2841.7 2851.9 2858.7 397.3 399.5 403.7 404.9 408.9 384.4 489.4 490.1 491.8 515.7 6436.5 6467.4 6515.9 6521.7 6597.6 434.0 435.5 453.3 527.5 536.8 3177.6 3279.2 3293.4 3684.3 3686.9 52267.2 52705.5 52743.0 52838.0 53311.0 45989.3 46344.1 46468.5 46600.5 46736.1 41917.4 41968.4 42691.0 42966.6 43485.1 7177.7 7260.9 7330.0 7338.9 7353.2 30885.2 31194.0 31272.0 31971.5 31985.7 38499.2 38571.6 39638.6 42465.4 42498.6 6802.8 6848.4 6984.9 7161.7 7381.6 9598.7 9938.0 10081.4 10167.2 10173.3 8871.8 9143.6 9326.5 9329.2 9496.4 9322.5 9396.5 9518.9 9561.3 9834.4 8106.4 8562.4 8911.9 9040.6 9330.4 7938.6 7943.2 8141.6 8193.5 8345.2 7701.5 8142.1 8144.9 8157.8 8386.5 09:10:55 INFO - 2015-12-02 09:10:55,369 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:10:55 INFO - 2015-12-02 09:10:55,369 DEBUG : BROWSER_OUTPUT: 09:10:56 INFO - 2015-12-02 09:10:56,001 INFO : Browser exited with error code: 0 09:10:56 INFO - 2015-12-02 09:10:56,033 INFO : Completed test dromaeo_css (00:18:31) 09:10:56 INFO - 2015-12-02 09:10:56,033 INFO : Starting test kraken 09:10:56 INFO - 2015-12-02 09:10:56,033 DEBUG : operating with platform_type : mac_ 09:10:56 INFO - 2015-12-02 09:10:56,034 INFO : Initialising browser for kraken test... 09:10:56 INFO - 2015-12-02 09:10:56,048 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmp2dZIuY/profile http://localhost:49270/getInfo.html 09:10:58 INFO - 2015-12-02 09:10:58,899 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:10:58 INFO - 2015-12-02 09:10:58,899 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:10:58 INFO - 2015-12-02 09:10:58,899 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:10:58 INFO - 2015-12-02 09:10:58,899 DEBUG : BROWSER_OUTPUT: __metrics 09:10:59 INFO - 2015-12-02 09:10:59,505 INFO : Browser initialized. 09:10:59 INFO - 2015-12-02 09:10:59,506 INFO : Running cycle 1/1 for kraken test... 09:10:59 INFO - 2015-12-02 09:10:59,506 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmp2dZIuY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:11:11 INFO - 2015-12-02 09:11:11,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 209653760 09:11:11 INFO - 2015-12-02 09:11:11,477 DEBUG : BROWSER_OUTPUT: 09:11:14 INFO - 2015-12-02 09:11:14,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:15 INFO - 2015-12-02 09:11:15,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 229625856 09:11:15 INFO - 2015-12-02 09:11:15,020 DEBUG : BROWSER_OUTPUT: 09:11:17 INFO - 2015-12-02 09:11:17,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 09:11:18 INFO - 2015-12-02 09:11:18,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 236953600 09:11:18 INFO - 2015-12-02 09:11:18,515 DEBUG : BROWSER_OUTPUT: 09:11:21 INFO - 2015-12-02 09:11:21,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 09:11:22 INFO - 2015-12-02 09:11:22,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 237506560 09:11:22 INFO - 2015-12-02 09:11:22,258 DEBUG : BROWSER_OUTPUT: 09:11:24 INFO - 2015-12-02 09:11:24,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 09:11:24 INFO - 2015-12-02 09:11:24,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 237441024 09:11:24 INFO - 2015-12-02 09:11:24,984 DEBUG : BROWSER_OUTPUT: 09:11:27 INFO - 2015-12-02 09:11:27,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:27 INFO - 2015-12-02 09:11:27,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 237518848 09:11:27 INFO - 2015-12-02 09:11:27,886 DEBUG : BROWSER_OUTPUT: 09:11:31 INFO - 2015-12-02 09:11:31,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:31 INFO - 2015-12-02 09:11:31,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 235560960 09:11:31 INFO - 2015-12-02 09:11:31,806 DEBUG : BROWSER_OUTPUT: 09:11:35 INFO - 2015-12-02 09:11:35,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:35 INFO - 2015-12-02 09:11:35,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 236630016 09:11:35 INFO - 2015-12-02 09:11:35,805 DEBUG : BROWSER_OUTPUT: 09:11:38 INFO - 2015-12-02 09:11:38,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 09:11:39 INFO - 2015-12-02 09:11:39,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 235999232 09:11:39 INFO - 2015-12-02 09:11:39,559 DEBUG : BROWSER_OUTPUT: 09:11:41 INFO - 2015-12-02 09:11:41,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:41 INFO - 2015-12-02 09:11:41,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 237240320 09:11:41 INFO - 2015-12-02 09:11:41,860 DEBUG : BROWSER_OUTPUT: 09:11:43 INFO - 2015-12-02 09:11:43,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:44 INFO - 2015-12-02 09:11:44,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 237621248 09:11:44 INFO - 2015-12-02 09:11:44,420 DEBUG : BROWSER_OUTPUT: 09:11:46 INFO - 2015-12-02 09:11:46,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:47 INFO - 2015-12-02 09:11:47,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 237391872 09:11:47 INFO - 2015-12-02 09:11:47,247 DEBUG : BROWSER_OUTPUT: 09:11:50 INFO - 2015-12-02 09:11:50,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:50 INFO - 2015-12-02 09:11:50,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 237539328 09:11:50 INFO - 2015-12-02 09:11:50,630 DEBUG : BROWSER_OUTPUT: 09:11:53 INFO - 2015-12-02 09:11:53,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:54 INFO - 2015-12-02 09:11:54,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 238084096 09:11:54 INFO - 2015-12-02 09:11:54,034 DEBUG : BROWSER_OUTPUT: 09:11:55 INFO - 2015-12-02 09:11:55,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 09:11:56 INFO - 2015-12-02 09:11:56,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 237699072 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: |0;ai-astar;126;118;130;132;129;135;127;128;130;124 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;170;150;186;176;152;168;149;184;173;149 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: |2;audio-dft;186;191;191;185;191;193;185;191;194;188 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;83;90;127;76;77;81;81;131;76 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;101;146;100;105;103;143;102;103;140 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;136;136;130;142;144;136;137;143;143 09:11:56 INFO - 2015-12-02 09:11:56,111 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;142;148;148;148;142;149;148 09:11:56 INFO - 2015-12-02 09:11:56,112 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;124;122;122;121;121;122;122;122;121 09:11:56 INFO - 2015-12-02 09:11:56,112 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;73;75;78;78;78;80;85;71;71 09:11:56 INFO - 2015-12-02 09:11:56,112 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;77;80;77;80;78;78;74;72;74 09:11:56 INFO - 2015-12-02 09:11:56,112 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;97;98;98;96;97;99;97;98;97 09:11:56 INFO - 2015-12-02 09:11:56,112 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;141;144;155;141;154;139;150;145;142 09:11:56 INFO - 2015-12-02 09:11:56,112 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;171;179;172;165;173;172;174;169;174;165 09:11:56 INFO - 2015-12-02 09:11:56,112 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;77;79;84;82;80;81;81;79;79 09:11:56 INFO - 2015-12-02 09:11:56,113 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:11:56 INFO - 2015-12-02 09:11:56,113 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:11:56 INFO - 2015-12-02 09:11:56,113 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,701 09:11:56 INFO - 2015-12-02 09:11:56,113 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:11:56 INFO - 2015-12-02 09:11:56,113 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076316108__endTimestamp 09:11:56 INFO - 2015-12-02 09:11:56,114 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,114 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:11:56 INFO - 2015-12-02 09:11:56,114 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:11:56 INFO - 2015-12-02 09:11:56,114 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,114 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:127.90 Median:129.50 stddev:4.65 (3.6%) stddev-sans-first:4.88 09:11:56 INFO - 2015-12-02 09:11:56,114 DEBUG : BROWSER_OUTPUT: Values: 126.0 118.0 130.0 132.0 129.0 135.0 127.0 128.0 130.0 124.0 09:11:56 INFO - 2015-12-02 09:11:56,115 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,116 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:165.70 Median:171.50 stddev:14.61 (8.5%) stddev-sans-first:15.42 09:11:56 INFO - 2015-12-02 09:11:56,116 DEBUG : BROWSER_OUTPUT: Values: 170.0 150.0 186.0 176.0 152.0 168.0 149.0 184.0 173.0 149.0 09:11:56 INFO - 2015-12-02 09:11:56,116 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,116 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:189.50 Median:191.00 stddev:3.27 (1.7%) stddev-sans-first:3.22 09:11:56 INFO - 2015-12-02 09:11:56,116 DEBUG : BROWSER_OUTPUT: Values: 186.0 191.0 191.0 185.0 191.0 193.0 185.0 191.0 194.0 188.0 09:11:56 INFO - 2015-12-02 09:11:56,116 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,117 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.30 Median:81.00 stddev:20.82 (25.7%) stddev-sans-first:21.81 09:11:56 INFO - 2015-12-02 09:11:56,117 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 90.0 127.0 76.0 77.0 81.0 81.0 131.0 76.0 09:11:56 INFO - 2015-12-02 09:11:56,117 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,117 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.00 Median:122.50 stddev:20.17 (16.5%) stddev-sans-first:20.44 09:11:56 INFO - 2015-12-02 09:11:56,117 DEBUG : BROWSER_OUTPUT: Values: 97.0 101.0 146.0 100.0 105.0 103.0 143.0 102.0 103.0 140.0 09:11:56 INFO - 2015-12-02 09:11:56,118 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,118 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:138.30 Median:139.50 stddev:4.50 (3.2%) stddev-sans-first:4.69 09:11:56 INFO - 2015-12-02 09:11:56,118 DEBUG : BROWSER_OUTPUT: Values: 136.0 136.0 136.0 130.0 142.0 144.0 136.0 137.0 143.0 143.0 09:11:56 INFO - 2015-12-02 09:11:56,118 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,118 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:148.00 stddev:2.60 (1.8%) stddev-sans-first:2.73 09:11:56 INFO - 2015-12-02 09:11:56,118 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 142.0 148.0 148.0 148.0 142.0 149.0 148.0 09:11:56 INFO - 2015-12-02 09:11:56,118 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,119 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:121.90 Median:122.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 09:11:56 INFO - 2015-12-02 09:11:56,119 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 122.0 122.0 121.0 121.0 122.0 122.0 122.0 121.0 09:11:56 INFO - 2015-12-02 09:11:56,119 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,119 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.40 Median:78.00 stddev:5.64 (7.2%) stddev-sans-first:4.56 09:11:56 INFO - 2015-12-02 09:11:56,119 DEBUG : BROWSER_OUTPUT: Values: 65.0 73.0 75.0 78.0 78.0 78.0 80.0 85.0 71.0 71.0 09:11:56 INFO - 2015-12-02 09:11:56,119 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,120 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:76.20 Median:77.50 stddev:3.01 (3.9%) stddev-sans-first:2.78 09:11:56 INFO - 2015-12-02 09:11:56,120 DEBUG : BROWSER_OUTPUT: Values: 72.0 77.0 80.0 77.0 80.0 78.0 78.0 74.0 72.0 74.0 09:11:56 INFO - 2015-12-02 09:11:56,120 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,121 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.90 Median:97.50 stddev:1.91 (2.0%) stddev-sans-first:0.88 09:11:56 INFO - 2015-12-02 09:11:56,121 DEBUG : BROWSER_OUTPUT: Values: 92.0 97.0 98.0 98.0 96.0 97.0 99.0 97.0 98.0 97.0 09:11:56 INFO - 2015-12-02 09:11:56,121 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,121 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:144.50 stddev:6.21 (4.3%) stddev-sans-first:5.92 09:11:56 INFO - 2015-12-02 09:11:56,122 DEBUG : BROWSER_OUTPUT: Values: 137.0 141.0 144.0 155.0 141.0 154.0 139.0 150.0 145.0 142.0 09:11:56 INFO - 2015-12-02 09:11:56,122 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,122 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.50 stddev:4.25 (2.5%) stddev-sans-first:4.50 09:11:56 INFO - 2015-12-02 09:11:56,122 DEBUG : BROWSER_OUTPUT: Values: 171.0 179.0 172.0 165.0 173.0 172.0 174.0 169.0 174.0 165.0 09:11:56 INFO - 2015-12-02 09:11:56,122 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,122 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.70 Median:80.50 stddev:2.54 (3.2%) stddev-sans-first:2.05 09:11:56 INFO - 2015-12-02 09:11:56,122 DEBUG : BROWSER_OUTPUT: Values: 75.0 77.0 79.0 84.0 82.0 80.0 81.0 81.0 79.0 79.0 09:11:56 INFO - 2015-12-02 09:11:56,122 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:11:56 INFO - 2015-12-02 09:11:56,123 DEBUG : BROWSER_OUTPUT: 09:11:56 INFO - 2015-12-02 09:11:56,776 INFO : Browser exited with error code: 0 09:11:56 INFO - 2015-12-02 09:11:56,831 INFO : Completed test kraken (00:01:00) 09:11:56 INFO - 2015-12-02 09:11:56,831 INFO : Starting test v8_7 09:11:56 INFO - 2015-12-02 09:11:56,831 DEBUG : operating with platform_type : mac_ 09:11:56 INFO - 2015-12-02 09:11:56,832 INFO : Initialising browser for v8_7 test... 09:11:56 INFO - 2015-12-02 09:11:56,846 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmp7LXed7/profile http://localhost:49270/getInfo.html 09:11:59 INFO - 2015-12-02 09:11:59,592 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:11:59 INFO - 2015-12-02 09:11:59,592 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:11:59 INFO - 2015-12-02 09:11:59,592 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:11:59 INFO - 2015-12-02 09:11:59,592 DEBUG : BROWSER_OUTPUT: __metrics 09:12:00 INFO - 2015-12-02 09:12:00,206 INFO : Browser initialized. 09:12:00 INFO - 2015-12-02 09:12:00,206 INFO : Running cycle 1/1 for v8_7 test... 09:12:00 INFO - 2015-12-02 09:12:00,207 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmp7LXed7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:12:12 INFO - 2015-12-02 09:12:12,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 210554880 09:12:12 INFO - 2015-12-02 09:12:12,162 DEBUG : BROWSER_OUTPUT: 09:12:33 INFO - 2015-12-02 09:12:33,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/v8_7/run.html (next: http://localhost:49270/tests/v8_7/run.html) 09:12:34 INFO - 2015-12-02 09:12:34,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 230141952 09:12:34 INFO - 2015-12-02 09:12:34,095 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,095 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:12:34 INFO - 2015-12-02 09:12:34,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:12:34 INFO - 2015-12-02 09:12:34,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:12:34 INFO - 2015-12-02 09:12:34,095 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:12:34 INFO - 2015-12-02 09:12:34,095 DEBUG : BROWSER_OUTPUT: |0;Richards;186.42803877703207 09:12:34 INFO - 2015-12-02 09:12:34,095 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;227.42779167614282 09:12:34 INFO - 2015-12-02 09:12:34,096 DEBUG : BROWSER_OUTPUT: |2;Encrypt;360.62026685899747 09:12:34 INFO - 2015-12-02 09:12:34,096 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6986.111111111111 09:12:34 INFO - 2015-12-02 09:12:34,096 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1121.0762331838564 09:12:34 INFO - 2015-12-02 09:12:34,096 DEBUG : BROWSER_OUTPUT: |5;Earley;746.8259895444362 09:12:34 INFO - 2015-12-02 09:12:34,096 DEBUG : BROWSER_OUTPUT: |6;Boyer;14357.142857142857 09:12:34 INFO - 2015-12-02 09:12:34,096 DEBUG : BROWSER_OUTPUT: |7;RegExp;32218.75 09:12:34 INFO - 2015-12-02 09:12:34,097 DEBUG : BROWSER_OUTPUT: |8;Splay;639.386189258312 09:12:34 INFO - 2015-12-02 09:12:34,097 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6585.526315789473 09:12:34 INFO - 2015-12-02 09:12:34,097 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:12:34 INFO - 2015-12-02 09:12:34,097 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076354092__endTimestamp 09:12:34 INFO - 2015-12-02 09:12:34,097 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,097 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:12:34 INFO - 2015-12-02 09:12:34,098 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:12:34 INFO - 2015-12-02 09:12:34,098 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,098 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.43 Median:186.43 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,098 DEBUG : BROWSER_OUTPUT: Values: 186.4 09:12:34 INFO - 2015-12-02 09:12:34,098 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,098 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:227.43 Median:227.43 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: Values: 227.4 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:360.62 Median:360.62 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: Values: 360.6 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6986.11 Median:6986.11 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: Values: 6986.1 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1121.08 Median:1121.08 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: Values: 1121.1 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,099 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:746.83 Median:746.83 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: Values: 746.8 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14357.14 Median:14357.14 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: Values: 14357.1 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32218.75 Median:32218.75 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: Values: 32218.8 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:639.39 Median:639.39 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,100 DEBUG : BROWSER_OUTPUT: Values: 639.4 09:12:34 INFO - 2015-12-02 09:12:34,101 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,101 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6585.53 Median:6585.53 stddev:0.00 (0.0%) 09:12:34 INFO - 2015-12-02 09:12:34,101 DEBUG : BROWSER_OUTPUT: Values: 6585.5 09:12:34 INFO - 2015-12-02 09:12:34,101 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:12:34 INFO - 2015-12-02 09:12:34,101 DEBUG : BROWSER_OUTPUT: 09:12:34 INFO - 2015-12-02 09:12:34,714 INFO : Browser exited with error code: 0 09:12:34 INFO - 2015-12-02 09:12:34,737 INFO : Completed test v8_7 (00:00:37) 09:12:35 INFO - 2015-12-02 09:12:35,158 INFO : Completed test suite (00:20:10) 09:12:35 INFO - 2015-12-02 09:12:35,158 DEBUG : Working with test: dromaeo_css 09:12:35 INFO - 2015-12-02 09:12:35,158 DEBUG : Generating results file: dromaeo_css 09:12:35 INFO - 2015-12-02 09:12:35,159 DEBUG : Working with test: kraken 09:12:35 INFO - 2015-12-02 09:12:35,159 DEBUG : Generating results file: kraken 09:12:35 INFO - 2015-12-02 09:12:35,159 INFO : javascript benchmark 09:12:35 INFO - 2015-12-02 09:12:35,159 DEBUG : Working with test: v8_7 09:12:35 INFO - 2015-12-02 09:12:35,159 DEBUG : Generating results file: v8_7 09:12:35 INFO - 2015-12-02 09:12:35,159 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:12:35 INFO - 2015-12-02 09:12:35,215 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,57]] 09:12:35 INFO - 2015-12-02 09:12:35,215 DEBUG : process_Request line: dromaeo_css 5969.02 graph.html#tests=[[72,52,57]] 09:12:35 INFO - 2015-12-02 09:12:35,215 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:12:35 INFO - 2015-12-02 09:12:35,245 DEBUG : process_Request line: kraken 1738.90 graph.html#tests=[[232,52,57]] 09:12:35 INFO - 2015-12-02 09:12:35,246 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:12:35 INFO - 2015-12-02 09:12:35,279 DEBUG : process_Request line: v8_7 18024.71 graph.html#tests=[[230,52,57]] 09:12:35 INFO - 2015-12-02 09:12:35,280 INFO : javascript benchmark 09:12:35 INFO - 2015-12-02 09:12:35,282 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [311.4440723308894, 314.6114548532563, 317.3541842350817, 324.3448234566176, 325.2113624460682, 10767.676969690901, 11126.38804865732, 15847.84152158478, 16458.177091145426, 16481.50555483336, 10816.837747433794, 10848.837267440995, 11130.554777808899, 11201.159913006537, 11203.60787372442, 3922.9996350930546, 4026.1746341999965, 4027.8791636250958, 4036.011177261575, 4037.878863634081, 3946.861859834906, 4002.1995600879795, 4016.2369149861433, 4024.215278020787, 4075.1645912587846, 3234.110619579611, 3324.2188085799817, 4022.8189731462007, 4023.5976402359825, 4226.556211597784, 4341.587549182823, 4366.956330436703, 4378.540253273408, 4395.626371758372, 4398.274284743014, 3680.6319368063246, 3713.3687273163355, 3746.4380342948502, 3748.3815170496837, 3754.793486358249, 11673.649790506299, 11749.706257343549, 12028.939855300756, 12035.819462708067, 12079.758404831942, 1569.9529014129594, 1668.8664906807549, 1760.815114412981, 1786.9910650446664, 1823.8632102592358, 8556.401051926368, 8575.699850505265, 8686.0, 8700.825983480296, 8948.149925757043, 1345.5559665310523, 1363.7068030373516, 1404.6418163368378, 1432.10493441599, 1472.263868065967, 53044.20433693498, 54830.45169548293, 54964.45035549633, 55739.72130139364, 55968.720156399366, 6171.7531298748445, 6188.412100850412, 6202.968985155046, 6224.688765561704, 6256.186695729526, 6805.591664500146, 7073.504854660125, 7110.857782844314, 7111.679974401164, 7171.533850299714, 5166.250893620404, 5189.7405129743365, 5218.269442278084, 5219.347581552306, 5280.9207861882105, 5562.9443705563235, 5578.330600327987, 5583.916241256385, 5629.211910332557, 5658.405867383948, 2736.521108805991, 2768.224897028835, 2786.6098746175553, 2787.0941943868324, 2806.116073436902, 975.7658162041059, 976.4141515090888, 978.4814048554277, 987.0770829274508, 992.9375568142019, 385.89002134391563, 403.0005586146315, 418.7738621144609, 422.81818817908595, 429.6906227516183, 9285.0, 11401.600943966921, 11458.54165833374, 11580.131490138274, 11644.184907056595, 419.767029298736, 421.8144016632672, 422.9809658565372, 426.9786510674454, 445.9152760975404, 5410.404855465896, 5547.639403438763, 5798.072308430631, 5934.228550288522, 6000.729967151488, 474907.0, 483658.0, 490401.0, 495714.0, 502123.0, 67230.32769672338, 70603.0, 70868.64565677139, 70890.64554677194, 72799.63600181966, 407.4112906849574, 416.50851994646, 423.50872987335157, 426.17322394554463, 433.59458905923066, 9239.39943903644, 9495.43027418357, 9702.175315098295, 9732.12410883024, 9935.155511781579, 32789.67210327866, 32977.505337419476, 33000.66999330072, 33023.339533209684, 33242.83650072236, 45011.54988450074, 45621.034632748764, 46263.768681156376, 46505.302420464395, 46601.53398465972, 7321.707131714885, 7346.926530734624, 7413.851722965403, 7496.137944136276, 7505.812354691177, 10568.682939511827, 10963.342199468058, 11173.888261117285, 11196.608118715805, 11217.775644487228, 9555.426674399558, 9642.469664168539, 9697.951510242403, 9740.951295243762, 9743.853842192231, 8345.248927596545, 8935.776605584653, 9146.542672866462, 9224.723258302261, 9306.953465232631, 9317.580708868252, 9430.151286384258, 9503.524823758922, 9515.762105947406, 9665.9033409665, 7242.855142897007, 7302.488825782144, 7427.888581671171, 7512.699492020258, 7532.246775322424, 9471.337006409485, 9619.51902404863, 9700.029997000243, 9717.22262219035, 9732.80534389294], "dojo.html": [2906.9273268168295, 2941.558766185072, 2951.7343439090478, 2953.719396657318, 2971.4057188562288, 4927.310176575278, 4933.062718083562, 5011.799528018884, 5016.648834581581, 5036.068327359441, 4992.7753251103695, 4995.775190116445, 5011.148104822179, 5024.070546948817, 5088.49115088491, 4428.933565996513, 4525.728456292633, 4602.884927876813, 4643.628509719231, 4655.394798676184, 4469.798859051334, 4471.351654010166, 4504.977475112636, 4553.317002449626, 4607.792649330771, 4472.53038430965, 4482.596566309032, 4525.0, 4529.547045295477, 4563.201439748031, 4384.21084204843, 4567.908641827162, 4622.352870598119, 4623.930641040387, 4642.721436713774, 4434.911301773978, 4473.172463094338, 4503.324501324795, 4552.68131230814, 4554.407926969506, 4789.56893879549, 4830.879228019293, 4929.816843957425, 4989.126902791997, 5049.747512624354, 5076.36545431821, 5166.638335316529, 5205.895882082337, 5291.3650361956425, 5303.284056652341, 5315.973420132875, 5393.487618676219, 5445.319335083114, 5449.6730196187955, 5455.863603409907, 5005.849824505271, 5026.220935754964, 5027.974860125676, 5047.848564543069, 5086.923696144598, 5117.795288188505, 5183.585313174937, 5265.868353291122, 5376.623636345418, 5492.752826122754, 5108.361454818148, 5110.693358398508, 5124.538791508782, 5168.069747445421, 5172.120739474299, 5226.216067589892, 5249.947500525022, 5257.842264732064, 5297.125974214211, 5306.92039619406, 5011.674241174312, 5131.204663277198, 5152.974235128875, 5162.6902385856965, 5192.1173400522, 5242.659227150223, 5277.551408130275, 5284.233786100994, 5326.627136100513, 5344.225087362311, 4160.563140870226, 4197.622214000694, 4198.748075115503, 4211.557786432441, 4214.304639734471, 3580.838862251205, 3630.09247688078, 3671.2290419012306, 3776.4712940188397, 3779.3764028935466, 4875.317455556225, 4886.998165376161, 4898.926516102261, 4913.828016019494, 4944.431390390151, 5287.0, 5328.280682107943, 5335.573154147659, 5352.866178345573, 5366.463353664602, 4566.725996440225, 4707.270373092176, 4740.881477963009, 4862.319275301461, 4913.901721965541, 4627.3521706961055, 4647.535246475393, 4682.531746825291, 4686.133065382915, 4722.433308003062, 5123.38519377677, 5308.2464379526755, 5318.494742999409, 5367.1680889462195, 5377.838664840061, 5238.738063096906, 5347.839564813062, 5375.247465354775, 5397.757100930389, 5421.457854214547, 5264.736763161904, 5285.9471405286995, 5325.440828713085, 5333.066713325075, 5363.651362661414, 4950.133726597759, 5135.87160320995, 5178.300929374486, 5216.530512253916, 5221.216817477409, 4965.602751779921, 5154.871128221825, 5227.451117632746, 5265.921011184912, 5332.653377530448, 5205.375354957429, 5228.71242081674, 5231.503007214308, 5264.789408423773, 5275.208718692227, 5040.16837221869, 5077.796888124433, 5163.561097306771, 5189.818356357509, 5259.21111833228, 4950.430700469492, 4999.250112483157, 5036.722980236123, 5047.4952504749235, 5049.8737531562, 5105.183170692671, 5148.897022059613, 5189.844304670866, 5192.117340052125, 5230.163173892159, 4921.360223170965, 5011.9976004798455, 5086.3896332440345, 5108.208227724708, 5108.79564817418], "mootools.html": [1440.1287221231148, 1622.95942601435, 1655.693696666117, 1666.6000159961604, 1680.9495715128544, 5983.521318294537, 6117.204763380765, 6420.133282006927, 6821.420179284761, 6823.0, 6403.103565500822, 6623.768168114117, 6709.597424154555, 6711.563748356366, 6715.160604924385, 1929.2090243000373, 1940.8544359173047, 1959.7452331196996, 1960.2649006622516, 1964.8329891959202, 1963.0773536437923, 1978.4361456984761, 1998.6902030185272, 2013.4060452166646, 2018.1322031526438, 1933.787283398825, 1937.8449724022114, 1954.7067939809, 1959.823615874571, 1961.1272983522338, 1894.2328357015363, 1913.808619138089, 1920.8655394122418, 1923.5671973805852, 1923.5864289177894, 1960.0, 1992.5417154054503, 1992.671209250472, 1993.0333788112753, 1993.8404927605757, 6638.73445062197, 6785.525013249075, 6788.355106264897, 6810.761623343209, 6840.623765692885, 4096.201240758053, 4163.854265100707, 4164.708470407073, 4171.749695018309, 4184.037671335579, 2442.2795275393623, 2490.4645501217324, 2492.6385674077155, 2529.5320365732214, 2537.4671319023028, 747.1706405889458, 750.0, 750.2497502497503, 769.0809482668213, 780.8243145292321, 8530.0, 8540.359473039547, 8545.401821872472, 8564.272036876873, 8602.225799677997, 3694.5012423323046, 3696.1129328960856, 3716.4611131385795, 3716.572594151707, 3729.7948612826553, 7557.0, 7574.977378053893, 7581.886271705929, 7587.886181707278, 7588.468807183554, 4206.053637931441, 4212.347086201644, 4213.2837417639075, 4213.810378532973, 4241.851535196253, 3475.2007038380807, 3555.591107022674, 3852.114013776847, 3854.0557563396587, 3856.1709232515145, 3079.892203772857, 3166.493361062265, 3204.3110731192905, 3240.756943229267, 3245.4158251514955, 1025.9846102308472, 1035.3684252605904, 1040.9011143941314, 1044.368157264859, 1044.9216308776872, 912.5574096563162, 989.010989010989, 1049.7585555322319, 1181.6041626055196, 1193.7433451807904, 5912.201852749909, 5943.286805583271, 6028.608140470856, 6029.276486821609, 6055.666938318434, 1045.3153184663904, 1054.4674939155677, 1055.9736006599896, 1062.1184416934082, 1067.8611780468646, 4965.925511117336, 5123.257127716461, 5125.154349532286, 5126.769295381717, 5167.224916262516, 7719.498232614975, 7826.804329891798, 7917.643706033243, 7933.206679332021, 7939.0, 7869.449138560361, 7872.685092596346, 7873.881891771628, 7879.330256928225, 7942.483738556975, 6333.841653958688, 6347.904781428282, 6368.968155159195, 6371.490280777527, 6378.52161087911, 6037.396260374103, 6073.878522429438, 6137.140800287874, 6137.60105593135, 6138.355472675484, 7028.367446929801, 7151.392131668867, 7160.355567998905, 7168.390686791681, 7232.168300645493, 7149.463790215858, 7287.562746235243, 7295.306945840137, 7342.596157211405, 7350.558966462029, 5499.927514134865, 5585.2180694701965, 5998.280206375263, 6030.065339872327, 6052.182955300978, 5974.522038237017, 6081.756729730761, 6082.239720034996, 6132.141500190066, 6139.0, 5898.056310990221, 5903.822885313448, 5972.283326000907, 6026.879462410815, 6115.571909966259, 5670.546356291405, 5735.856603584777, 5782.5373970081455, 5795.7391917362975, 5796.1305804129715, 5887.735051922759, 5908.852278693067, 5941.049432090845, 5951.732172052355, 5957.6127551709, 5117.5394214520875, 5120.385553733576, 5131.384233891957, 5138.409082955359, 5154.871128221675, 5271.4464981176425, 5280.313559237275, 5288.4182739897815, 5310.176922577007, 5340.305760251143], "ext.html": [506.5188071332233, 515.0934355534259, 525.0968334464719, 526.1187510919209, 539.0109149710281, 32914.50628240578, 33784.49323260153, 33870.49194262088, 33883.83058084709, 34288.31423371531, 37447.43828842569, 38149.42775858357, 38154.0, 38161.0, 38192.618073819256, 8282.668693252263, 8297.253247207751, 8437.493750374966, 8438.915610843906, 8452.957735211347, 8283.668653253862, 8286.668533258662, 8353.707620233294, 8378.329733621325, 8395.496270223775, 8253.876191857127, 8276.627551760184, 8293.253607175353, 8355.289800366945, 8363.080061193265, 8186.508809471451, 8282.254597086292, 8374.623141958597, 8380.413371064027, 8403.41176117672, 8057.274845263954, 8178.550179740112, 8186.345092392594, 8265.0, 8268.710595129141, 34522.48216276758, 34532.482012769826, 34964.82517587396, 35033.824830875936, 35060.64939350599, 2619.3320703220556, 2642.2733748219202, 2649.2714503511497, 2687.8252913560555, 2706.7563919247364, 24536.631950520758, 25381.111661091774, 25480.745192548024, 25641.102561410447, 26297.474050518882, 2073.6060148571873, 2074.471009892483, 2078.251829341436, 2087.081684059024, 2130.243763463979, 214422.0, 216945.0, 217487.0, 217570.0, 218239.90880045656, 50192.247116293285, 51696.48303516916, 51885.740571296905, 52335.47664523306, 56917.71541142268, 54692.72653636707, 54889.176662350095, 55123.0, 55176.72411637996, 55257.0, 15996.0, 16026.519204423887, 16048.19759012068, 16202.837971620369, 16221.675566488604, 11951.16341856079, 12013.939930300467, 12090.69773255658, 12162.148649594443, 12178.330191839357, 17512.299508019536, 17598.29606815713, 17708.734368984475, 17752.28990840352, 17782.822171778116, 7359.0, 7547.16981132075, 7592.240775922363, 7597.164311925684, 7642.7325043623205, 819.3158712475031, 910.9706032183723, 1035.632350515556, 1052.1109662335314, 1055.3351388625117, 26355.86822065916, 26780.19659410221, 27539.586906196022, 28933.276668083465, 29105.85447072751, 980.1927646297277, 988.7330420786348, 994.5872462927948, 1037.6990672704983, 1052.1793001458875, 13209.40557674907, 13562.93218533901, 13956.860431395758, 14634.707305853823, 14703.41186352534, 222141.0, 227170.0, 229519.0, 229736.0, 230020.0, 50556.0, 50684.239736403986, 50708.23937640939, 50821.23768143481, 51279.46161615157, 1256.5288016993627, 1258.4022589270023, 1305.6213698027655, 1307.5162189989574, 1308.7305313845554, 26666.600001000388, 26826.59760103561, 27262.011787034106, 27392.315192120357, 27558.0, 43534.0, 43937.34093988529, 43977.78011109924, 44050.55949440593, 44141.558584413746, 282399.0, 286754.0, 286795.0, 286937.0, 287566.0, 27824.44351113007, 28389.290267743472, 29439.85280073586, 29468.263293417836, 29754.70245297606, 34480.65519344775, 35292.0, 35419.468707969914, 35488.822555887054, 36072.27855442824, 29202.561961571017, 29908.551371729878, 30201.697983020767, 30641.54037689481, 31968.0, 29856.402871942875, 30224.0, 30514.542281865346, 30526.0, 30639.54040689436, 30881.073567793002, 30930.536041958938, 31119.844400777853, 32449.0, 32930.17674558155, 28247.43505129845, 28301.71698282991, 28676.0, 28962.420751585272, 29566.260843479085, 21869.453263668536, 22024.889875551162, 22236.444088897908, 22735.317940461813, 22770.43073923165], "prototype.html": [297.98808047678097, 301.25589793210764, 306.36429408976375, 306.61060453224405, 311.03113800511386, 5487.094629386152, 5565.972170139144, 5569.025420551403, 5581.2186293918885, 5609.971950140254, 5427.728613569326, 5452.536534394571, 5457.617966742329, 5469.206964990074, 5501.889962200754, 4087.9386809197886, 4240.363945408182, 4257.340112282601, 4258.339957306614, 4264.680148988823, 4130.524989626201, 4141.378793181032, 4177.916441671165, 4180.372944058385, 4215.451991241134, 4112.773797441139, 4130.8554200602985, 4145.253854306224, 4145.813438395265, 4150.771707556083, 4147.087640719037, 4148.585141485873, 4154.480689913761, 4159.126583417486, 4170.998960249549, 3623.1123374773088, 3627.7823330599986, 3631.909202269938, 3633.8364773585254, 3657.3782456982112, 5212.452692467275, 5366.409694933554, 5370.275012873251, 5378.46215378463, 5404.702741349224, 4783.354247176656, 4807.110684523374, 4821.132196204681, 4835.758212089417, 4841.2012018016985, 5819.476247137735, 5823.9708801456145, 5828.0966450200285, 5836.883262334772, 5845.09401042839, 4022.557518672973, 4027.6979226558124, 4029.879103626896, 4031.4355990161403, 4034.394840773878, 5877.735501902424, 6058.121572372025, 6068.089786532011, 6069.332373438918, 6069.393060693939, 4108.506979162519, 4111.403846442249, 4115.0, 4116.156187981456, 4119.361498967664, 4152.563980781974, 4174.519930208005, 4179.185058913544, 4181.937270940938, 4187.057911969782, 4791.0, 4800.95199048012, 4804.543568361, 4810.903781924412, 4845.2732090186755, 5675.262215911905, 5786.218860453869, 5800.651960882361, 5810.12848072784, 5817.941820581825, 1437.73401920645, 1441.8558144185497, 1444.3572610188364, 1444.7255021545873, 1445.104035497998, 921.4287141971886, 929.2101713543434, 933.7385532051037, 934.0332755597924, 945.5603144537823, 5441.047816632074, 5450.482204190595, 5471.2887324647545, 5481.177823326533, 5522.779088836402, 5847.707614619252, 5942.524598032147, 5965.910511342333, 6088.0, 6105.877882442415, 5466.890662186814, 5494.203340515683, 5508.173773933861, 5551.500364967173, 5554.0, 3297.0603378037144, 3328.1014126185796, 3334.5164951081956, 3339.1652086978256, 3342.147752323142, 5992.43071908168, 6045.516358691382, 6057.151998720183, 6064.75740970365, 6119.938800612026, 6159.384061593894, 6171.290301615282, 6173.166622505904, 6178.505719542516, 6240.126382306481, 6042.909356359746, 6067.1202675611785, 6103.786367477117, 6118.143459915705, 6123.540734444934, 6008.098785182257, 6011.939880601138, 6022.5784195105925, 6036.094585811988, 6052.273727152769, 5800.767969281182, 5914.852128696817, 5943.227380440515, 5973.074173503114, 5994.67029313392, 6091.421314975248, 6094.299155597163, 6094.512439004958, 6135.049067394561, 6142.57002009855, 3824.521934758155, 3862.633049860259, 3877.1470276539117, 3880.592537783492, 3894.279558281727, 5872.148538461985, 5940.732667029907, 6032.33644299118, 6086.239220097488, 6089.786857459968, 5923.0, 5923.466887980103, 5925.525957923442, 5949.732262048305, 5977.671228082323, 5907.3797251288, 5910.970445147746, 5917.940820591739, 5928.614640048383, 5967.46292833647, 5573.637713548606, 5742.626729262584, 5748.712564371681, 5751.424857514383, 5806.738696758572, 5851.765929362778, 5914.172015917861, 5915.438033386821, 5916.023856063702, 5947.732352044082, 5563.248961390161, 5780.566457515787, 5797.4782269595935, 5799.884002319845, 5802.593818432669], "yui.html": [627.28802808812, 665.8002599220233, 672.3478226120661, 690.4165979747112, 702.2415790945776, 12053.45759440825, 12351.444185011673, 12365.814512782315, 12372.319522426264, 12393.690157746061, 11725.58960436385, 11759.941200294008, 11852.881471185307, 11864.940675296612, 11873.703157421069, 655.5476721062475, 674.3762020131384, 766.5477368352671, 819.983600327993, 821.2977903892175, 792.3581898662073, 796.9721059762909, 810.068421315486, 813.4712436915993, 819.6557445872718, 858.4763294390417, 870.1907226279558, 870.4733636150133, 879.6041781198454, 880.4013270975734, 850.31974420464, 860.5267103093273, 865.7056600755742, 867.8394497018072, 873.5544872115204, 641.4483544152025, 642.3351830855089, 642.4474951541671, 645.4255712415953, 646.6249575246346, 11029.227954043221, 11122.666320010412, 11171.44142792857, 11266.887331126747, 11272.774544509064, 10004.59981600735, 10246.590136394536, 10433.79132417355, 10751.408672523008, 10952.123830093573, 7905.565193914333, 7909.96045019777, 7981.441299109065, 8131.06492753335, 8145.837083258301, 2989.387175628991, 3024.9395012099853, 3039.7720170987263, 3098.070578826343, 3130.796498227608, 43601.12797744059, 43673.34489982653, 43745.343819842725, 43783.68648940537, 44061.33907991383, 7722.3049925506975, 8000.759977200693, 8148.5518296494265, 8365.58172091393, 8551.273141782895, 17896.55258618519, 17922.0, 18058.0, 18064.36774712879, 18076.638467230845, 6190.350013248544, 6446.129772480655, 6498.772542961068, 6601.0, 6710.328967103251, 3497.527833742463, 3509.842057107436, 3573.1424458129864, 3591.2099338145567, 3652.141746689526, 2790.0932197036045, 2819.379736457976, 2841.6732075811133, 2851.9429611407654, 2858.7284208000624, 397.2888529532105, 399.5285563035646, 403.67302484987255, 404.8502054239891, 408.9100397912454, 384.4118498696998, 489.36138339466623, 490.07620635103086, 491.79836267130304, 515.6957395136887, 6436.485081193493, 6467.353264673589, 6515.90762636936, 6521.673916304166, 6597.60414375139, 433.9804708788112, 435.45133132252954, 453.2883373104195, 527.5489456514701, 536.7691892486268, 3177.6345720242007, 3279.212988882651, 3293.357795229955, 3684.318401095752, 3686.944695829565, 52267.21599176015, 52705.47294527082, 52743.0, 52838.0, 53311.0, 45989.310160347624, 46344.07311853744, 46468.535314647095, 46600.5339946603, 46736.06527869424, 41917.371239431435, 41968.370474442905, 42691.0, 42966.570334296885, 43485.130297394506, 7177.677004534704, 7260.89108663381, 7330.0, 7338.926610733824, 7353.191148973501, 30885.227869303446, 31194.0, 31272.0, 31971.520427194075, 31985.680143199203, 38499.23001539898, 38571.614283856805, 39638.60361396349, 42465.36301955411, 42498.575014250695, 6802.795916122524, 6848.417884479676, 6984.895226571504, 7161.749338773118, 7381.557106573623, 9598.712038638852, 9937.950310248403, 10081.395116293046, 10167.18662506983, 10173.338732982333, 8871.822563548822, 9143.634254630006, 9326.533673316442, 9329.246178228457, 9496.382735122195, 9322.533873306173, 9396.483193424427, 9518.904810951803, 9561.330706850455, 9834.409935403899, 8106.432549721463, 8562.400631955703, 8911.866322005304, 9040.63837446521, 9330.393524420891, 7938.603069846369, 7943.165967573322, 8141.552214628252, 8193.46742461738, 8345.207205315486, 7701.53790772533, 8142.063662678867, 8144.918550814416, 8157.8368432632205, 8386.454880432751]}, "summary": {"suite": 5969.015140118402, "subtests": {"jquery.html": {"filtered": 6164.554458159371, "value": 6164.554458159371}, "dojo.html": {"filtered": 4871.126350932384, "value": 4871.126350932384}, "mootools.html": {"filtered": 3844.318050130624, "value": 3844.318050130624}, "ext.html": {"filtered": 16578.009251662526, "value": 16578.009251662526}, "prototype.html": {"filtered": 4369.92718071377, "value": 4369.92718071377}, "yui.html": {"filtered": 5407.757405046147, "value": 5407.757405046147}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0018.e"}, "testrun": {"date": 1449075144, "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": "20151202071122", "branch": "Mozilla-Aurora", "revision": "bd29d7c987b554842ccee62dad4dec506e98227e"}}, {"talos_counters": {}, "results": {"audio-dft": [186.0, 191.0, 191.0, 185.0, 191.0, 193.0, 185.0, 191.0, 194.0, 188.0], "ai-astar": [126.0, 118.0, 130.0, 132.0, 129.0, 135.0, 127.0, 128.0, 130.0, 124.0], "imaging-gaussian-blur": [136.0, 136.0, 136.0, 130.0, 142.0, 144.0, 136.0, 137.0, 143.0, 143.0], "audio-beat-detection": [170.0, 150.0, 186.0, 176.0, 152.0, 168.0, 149.0, 184.0, 173.0, 149.0], "json-stringify-tinderbox": [72.0, 77.0, 80.0, 77.0, 80.0, 78.0, 78.0, 74.0, 72.0, 74.0], "stanford-crypto-pbkdf2": [171.0, 179.0, 172.0, 165.0, 173.0, 172.0, 174.0, 169.0, 174.0, 165.0], "json-parse-financial": [65.0, 73.0, 75.0, 78.0, 78.0, 78.0, 80.0, 85.0, 71.0, 71.0], "stanford-crypto-sha256-iterative": [75.0, 77.0, 79.0, 84.0, 82.0, 80.0, 81.0, 81.0, 79.0, 79.0], "audio-fft": [81.0, 83.0, 90.0, 127.0, 76.0, 77.0, 81.0, 81.0, 131.0, 76.0], "imaging-darkroom": [148.0, 148.0, 148.0, 142.0, 148.0, 148.0, 148.0, 142.0, 149.0, 148.0], "stanford-crypto-ccm": [137.0, 141.0, 144.0, 155.0, 141.0, 154.0, 139.0, 150.0, 145.0, 142.0], "audio-oscillator": [97.0, 101.0, 146.0, 100.0, 105.0, 103.0, 143.0, 102.0, 103.0, 140.0], "stanford-crypto-aes": [92.0, 97.0, 98.0, 98.0, 96.0, 97.0, 99.0, 97.0, 98.0, 97.0], "imaging-desaturate": [122.0, 124.0, 122.0, 122.0, 121.0, 121.0, 122.0, 122.0, 122.0, 121.0]}, "summary": {"suite": 1738.9000000000003, "subtests": {"audio-fft": {"filtered": 90.3, "value": 90.3}, "stanford-crypto-pbkdf2": {"filtered": 171.4, "value": 171.4}, "audio-beat-detection": {"filtered": 165.7, "value": 165.7}, "stanford-crypto-ccm": {"filtered": 144.8, "value": 144.8}, "imaging-darkroom": {"filtered": 146.9, "value": 146.9}, "json-parse-financial": {"filtered": 75.4, "value": 75.4}, "audio-oscillator": {"filtered": 114.0, "value": 114.0}, "ai-astar": {"filtered": 127.9, "value": 127.9}, "audio-dft": {"filtered": 189.5, "value": 189.5}, "stanford-crypto-sha256-iterative": {"filtered": 79.7, "value": 79.7}, "json-stringify-tinderbox": {"filtered": 76.2, "value": 76.2}, "imaging-gaussian-blur": {"filtered": 138.3, "value": 138.3}, "stanford-crypto-aes": {"filtered": 96.9, "value": 96.9}, "imaging-desaturate": {"filtered": 121.9, "value": 121.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0018.e"}, "testrun": {"date": 1449075144, "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": "20151202071122", "branch": "Mozilla-Aurora", "revision": "bd29d7c987b554842ccee62dad4dec506e98227e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [227.42779167614282], "Encrypt": [360.62026685899747], "NavierStokes": [6585.526315789473], "Decrypt": [6986.111111111111], "Splay": [639.386189258312], "Richards": [186.42803877703207], "RegExp": [32218.75], "Earley": [746.8259895444362], "Boyer": [14357.142857142857], "RayTrace": [1121.0762331838564]}, "summary": {"suite": 18024.705697320464, "subtests": {"DeltaBlue": {"filtered": 290.720846, "value": 290.720846}, "Encrypt": {"filtered": 738.1199129999998, "value": 738.1199129999998}, "NavierStokes": {"filtered": 225.34265734265745, "value": 225.34265734265745}, "Decrypt": {"filtered": 38.10145526838965, "value": 38.10145526838965}, "Splay": {"filtered": 127.45192400000002, "value": 127.45192400000002}, "RegExp": {"filtered": 28.27499515033945, "value": 28.27499515033945}, "Richards": {"filtered": 189.3599279999999, "value": 189.3599279999999}, "Earley": {"filtered": 892.3939569999998, "value": 892.3939569999998}, "Boyer": {"filtered": 46.42030845771142, "value": 46.42030845771142}, "RayTrace": {"filtered": 660.070188, "value": 660.070188}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0018.e"}, "testrun": {"date": 1449075144, "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": "20151202071122", "branch": "Mozilla-Aurora", "revision": "bd29d7c987b554842ccee62dad4dec506e98227e"}}] 09:12:35 INFO - RETURN: dromaeo_css: 5969.02 09:12:35 INFO - RETURN: kraken: 1738.90 09:12:35 INFO - RETURN: v8_7: 18024.71 09:12:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,57]]", "result": "18024.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,57]]", "result": "1738.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,57]]", "result": "5969.02"}}} 09:12:35 INFO - Return code: 0 09:12:35 INFO - # TBPL SUCCESS # 09:12:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:12:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:12:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:12:35 INFO - 2015-12-02 09:12:35.420 screenresolution[1666:10764] starting screenresolution argv=screenresolution get 09:12:35 INFO - 2015-12-02 09:12:35.423 screenresolution[1666:10764] Display 0: 1600x1200x32@60 09:12:35 INFO - 2015-12-02 09:12:35.429 screenresolution[1667:10767] starting screenresolution argv=screenresolution list 09:12:35 INFO - Available Modes on Display 0 09:12:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:12:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:12:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:12:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:12:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:12:35 INFO - Intel HD Graphics 3000: 09:12:35 INFO - Chipset Model: Intel HD Graphics 3000 09:12:35 INFO - Type: GPU 09:12:35 INFO - Bus: Built-In 09:12:35 INFO - VRAM (Total): 512 MB 09:12:35 INFO - VRAM (Dynamic, Max): 10 09:12:35 INFO - Vendor: Intel (0x8086) 09:12:35 INFO - Device ID: 0x0116 09:12:35 INFO - Revision ID: 0x0009 09:12:35 INFO - Displays: 09:12:35 INFO - Display: 09:12:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:12:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:12:35 INFO - Display Serial Number: 1600x1200 60 09:12:35 INFO - Main Display: Yes 09:12:35 INFO - Mirror: Off 09:12:35 INFO - Online: Yes 09:12:35 INFO - Rotation: Supported 09:12:35 INFO - Return code: 0 09:12:35 INFO - Running post-action listener: _resource_record_post_action 09:12:35 INFO - Running post-run listener: _resource_record_post_run 09:12:36 INFO - Total resource usage - Wall time: 1252s; CPU: 30.0%; Read bytes: 39154688; Write bytes: 688362496; Read time: 4458; Write time: 49351 09:12:36 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 342628864; Write bytes: 347963392; Read time: 35467; Write time: 8511 09:12:36 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 37028864; Write bytes: 339010560; Read time: 4035; Write time: 40822 09:12:36 INFO - Running post-run listener: _upload_blobber_files 09:12:36 INFO - Blob upload gear active. 09:12:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:12:36 INFO - Copying logs to upload dir... 09:12:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1310.826854 ========= master_lag: 2.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-12-02 09:12:39.475908) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 09:12:39.484486) ========= 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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010071 build_url: 'https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.42 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 09:12:39.918470) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 09:12:39.918852) ========= 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.9Jz5mUnRRT/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.p5LCNWjGun/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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.005399 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 09:12:39.934702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 09:12:39.935040) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 09:12:39.935479) ========= ========= Total master_lag: 3.18 =========