builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0101 starttime: 1449008874.9 results: success (0) buildid: 20151201121222 builduid: 4e5f1a9905ed47f98e8a3fff9cf4c39f revision: c69240d397da029511266b5c5024116472568dc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:54.904265) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:54.904705) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:54.904998) ========= 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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.005449 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:54.956066) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:54.956366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:54.971948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:54.972329) ========= 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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.018461 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.020771) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.021081) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.021429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.021695) ========= 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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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-01 14:27:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-12-01 14:27:55 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191145 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.227197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.227653) ========= 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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.071841 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.310599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.310942) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c69240d397da029511266b5c5024116472568dc4 --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 c69240d397da029511266b5c5024116472568dc4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7M7cvGpTsu/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.kSaB4IWAqL/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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-01 14:27:55,396 truncating revision to first 12 chars 2015-12-01 14:27:55,396 Setting DEBUG logging. 2015-12-01 14:27:55,396 attempt 1/10 2015-12-01 14:27:55,396 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c69240d397da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-01 14:27:55,644 unpacking tar archive at: mozilla-aurora-c69240d397da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522718 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.847155) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.847473) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.861741) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.862103) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 14:27:55.862518) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-12-01 14:27:55.862795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7M7cvGpTsu/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.kSaB4IWAqL/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:27:56 INFO - MultiFileLogger online at 20151201 14:27:56 in /builds/slave/test 14:27:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:27:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:27:56 INFO - {'append_to_log': False, 14:27:56 INFO - 'base_work_dir': '/builds/slave/test', 14:27:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:27:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:27:56 INFO - 'branch': 'Mozilla-Aurora', 14:27:56 INFO - 'buildbot_json_path': 'buildprops.json', 14:27:56 INFO - 'config_files': ('talos/mac_config.py',), 14:27:56 INFO - 'default_actions': ('clobber', 14:27:56 INFO - 'read-buildbot-config', 14:27:56 INFO - 'download-and-extract', 14:27:56 INFO - 'populate-webroot', 14:27:56 INFO - 'create-virtualenv', 14:27:56 INFO - 'install', 14:27:56 INFO - 'run-tests'), 14:27:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:27:56 INFO - 'download_minidump_stackwalk': True, 14:27:56 INFO - 'download_symbols': 'ondemand', 14:27:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:27:56 INFO - 'tooltool.py': '/tools/tooltool.py', 14:27:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:27:56 INFO - '/tools/misc-python/virtualenv.py')}, 14:27:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:27:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:27:56 INFO - 'installer_path': 'installer.exe', 14:27:56 INFO - 'log_level': 'info', 14:27:56 INFO - 'log_name': 'talos', 14:27:56 INFO - 'log_to_console': True, 14:27:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:27:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:27:56 INFO - 'opt_config_files': (), 14:27:56 INFO - 'pip_index': False, 14:27:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:27:56 INFO - 'cmd': ('bash', 14:27:56 INFO - '-c', 14:27:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:27:56 INFO - 'enabled': True, 14:27:56 INFO - 'halt_on_failure': False, 14:27:56 INFO - 'name': 'check_screen_resolution'},), 14:27:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:27:56 INFO - 'cmd': ('bash', 14:27:56 INFO - '-c', 14:27:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:27:56 INFO - 'enabled': True, 14:27:56 INFO - 'halt_on_failure': False, 14:27:56 INFO - 'name': 'check_screen_resolution'},), 14:27:56 INFO - 'run_cmd_checks_enabled': True, 14:27:56 INFO - 'sps_profile': False, 14:27:56 INFO - 'sps_profile_interval': 0, 14:27:56 INFO - 'suite': 'dromaeojs', 14:27:56 INFO - 'system_bits': '64', 14:27:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:27:56 INFO - 'title': 't-yosemite-r5-0101', 14:27:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:27:56 INFO - 'use_talos_json': True, 14:27:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:27:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:27:56 INFO - 'work_dir': 'build'} 14:27:56 INFO - ##### 14:27:56 INFO - ##### Running clobber step. 14:27:56 INFO - ##### 14:27:56 INFO - Running pre-action listener: _resource_record_pre_action 14:27:56 INFO - Running main action method: clobber 14:27:56 INFO - rmtree: /builds/slave/test/build 14:27:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:28:00 INFO - Running post-action listener: _resource_record_post_action 14:28:00 INFO - ##### 14:28:00 INFO - ##### Running read-buildbot-config step. 14:28:00 INFO - ##### 14:28:00 INFO - Running pre-action listener: _resource_record_pre_action 14:28:00 INFO - Running main action method: read_buildbot_config 14:28:00 INFO - Using buildbot properties: 14:28:00 INFO - { 14:28:00 INFO - "properties": { 14:28:00 INFO - "buildnumber": 289, 14:28:00 INFO - "product": "firefox", 14:28:00 INFO - "script_repo_revision": "production", 14:28:00 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 14:28:00 INFO - "repository": "", 14:28:00 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 14:28:00 INFO - "buildid": "20151201121222", 14:28:00 INFO - "slavename": "t-yosemite-r5-0101", 14:28:00 INFO - "pgo_build": "False", 14:28:00 INFO - "basedir": "/builds/slave/test", 14:28:00 INFO - "project": "", 14:28:00 INFO - "platform": "yosemite", 14:28:00 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:28:00 INFO - "slavebuilddir": "test", 14:28:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:28:00 INFO - "branch": "mozilla-aurora", 14:28:00 INFO - "repo_path": "releases/mozilla-aurora", 14:28:00 INFO - "stage_platform": "macosx64", 14:28:00 INFO - "builduid": "4e5f1a9905ed47f98e8a3fff9cf4c39f", 14:28:00 INFO - "revision": "c69240d397da029511266b5c5024116472568dc4" 14:28:00 INFO - }, 14:28:00 INFO - "sourcestamp": { 14:28:00 INFO - "repository": "", 14:28:00 INFO - "hasPatch": false, 14:28:00 INFO - "project": "", 14:28:00 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:28:00 INFO - "changes": [ 14:28:00 INFO - { 14:28:00 INFO - "category": null, 14:28:00 INFO - "files": [ 14:28:00 INFO - { 14:28:00 INFO - "url": null, 14:28:00 INFO - "name": "https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 14:28:00 INFO - } 14:28:00 INFO - ], 14:28:00 INFO - "repository": "", 14:28:00 INFO - "rev": "c69240d397da029511266b5c5024116472568dc4", 14:28:00 INFO - "who": "eakhgari@mozilla.com", 14:28:00 INFO - "when": 1449008029, 14:28:00 INFO - "number": 6729617, 14:28:00 INFO - "comments": "Bug 1226686 - Enable service workers on release builds for desktop and Android; r=baku a=ritu\n", 14:28:00 INFO - "project": "", 14:28:00 INFO - "at": "Tue 01 Dec 2015 14:13:49", 14:28:00 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:28:00 INFO - "revlink": "", 14:28:00 INFO - "properties": [ 14:28:00 INFO - [ 14:28:00 INFO - "buildid", 14:28:00 INFO - "20151201121222", 14:28:00 INFO - "Change" 14:28:00 INFO - ], 14:28:00 INFO - [ 14:28:00 INFO - "builduid", 14:28:00 INFO - "4e5f1a9905ed47f98e8a3fff9cf4c39f", 14:28:00 INFO - "Change" 14:28:00 INFO - ], 14:28:00 INFO - [ 14:28:00 INFO - "pgo_build", 14:28:00 INFO - "False", 14:28:00 INFO - "Change" 14:28:00 INFO - ] 14:28:00 INFO - ], 14:28:00 INFO - "revision": "c69240d397da029511266b5c5024116472568dc4" 14:28:00 INFO - } 14:28:00 INFO - ], 14:28:00 INFO - "revision": "c69240d397da029511266b5c5024116472568dc4" 14:28:00 INFO - } 14:28:00 INFO - } 14:28:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 14:28:00 INFO - Running post-action listener: _resource_record_post_action 14:28:00 INFO - ##### 14:28:00 INFO - ##### Running download-and-extract step. 14:28:00 INFO - ##### 14:28:00 INFO - Running pre-action listener: _resource_record_pre_action 14:28:00 INFO - Running main action method: download_and_extract 14:28:00 INFO - mkdir: /builds/slave/test/build/tests 14:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:00 INFO - https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:28:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/test_packages.json 14:28:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/test_packages.json 14:28:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:28:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:28:00 INFO - Downloaded 1149 bytes. 14:28:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:28:00 INFO - Using the following test package requirements: 14:28:00 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:28:00 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:28:00 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 14:28:00 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:28:00 INFO - u'jsshell-mac.zip'], 14:28:00 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:28:00 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 14:28:00 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:28:00 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:28:00 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 14:28:00 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:28:00 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 14:28:00 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:28:00 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 14:28:00 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:28:00 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:28:00 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 14:28:00 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:00 INFO - https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:28:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:28:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:28:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/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 14:28:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/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 14:28:01 INFO - Downloaded 17490180 bytes. 14:28:01 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 14:28:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:28:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:28:07 INFO - Return code: 0 14:28:07 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 14:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:07 INFO - https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:28:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:28:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:28:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/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 14:28:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/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 14:28:08 INFO - Downloaded 17490180 bytes. 14:28:08 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 14:28:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:28:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:28:14 INFO - Return code: 0 14:28:14 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')]} 14:28:14 INFO - https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:28:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:28:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:28:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/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 14:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/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 14:28:15 INFO - Downloaded 11131307 bytes. 14:28:15 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 14:28:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:28:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 14:28:15 INFO - Return code: 0 14:28: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')]} 14:28:15 INFO - https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 14:28:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:28:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:28:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 14:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/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 14:28:19 INFO - Downloaded 108650898 bytes. 14:28:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:28:19 INFO - mkdir: /builds/slave/test/properties 14:28:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:28:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:28:19 INFO - Contents: 14:28:19 INFO - build_url:https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:28:19 INFO - Running post-action listener: _resource_record_post_action 14:28:19 INFO - Running post-action listener: set_extra_try_arguments 14:28:19 INFO - ##### 14:28:19 INFO - ##### Running populate-webroot step. 14:28:19 INFO - ##### 14:28:19 INFO - Running pre-action listener: _resource_record_pre_action 14:28:19 INFO - Running main action method: populate_webroot 14:28:19 INFO - Guessing talos json url... 14:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:19 INFO - https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 14:28:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:28:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:28:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eAEoZz4dTYSrPa27ZXGsWA/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 14:28:19 INFO - Downloaded 107 bytes. 14:28:19 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:28:19 INFO - Contents: 14:28:19 INFO - 20151201121222 14:28:19 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/c69240d397da029511266b5c5024116472568dc4 14:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:19 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/c69240d397/testing/talos/talos.json 14:28:19 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/c69240d397/testing/talos/talos.json to /builds/slave/test/build/talos.json 14:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/c69240d397/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 14:28:20 INFO - Downloaded 4264 bytes. 14:28:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:28:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:28:20 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:28:20 INFO - '../fennec_ids.txt'], 14:28:20 INFO - 'tests': ['tcheck2']}, 14:28:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:28:20 INFO - '--tppagecycles', 14:28:20 INFO - '7'], 14:28:20 INFO - 'tests': ['tsvgm']}}, 14:28:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:28:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:28:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:28:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:28:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:28:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:28:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:20 INFO - 'talos_options': ['--e10s'], 14:28:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:20 INFO - 'tests': ['damp', 'tps']}, 14:28:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:20 INFO - 'talos_options': ['--e10s'], 14:28:20 INFO - 'tests': ['damp', 'tps']}, 14:28:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:28:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:28:20 INFO - 'other': {'tests': ['a11yr', 14:28:20 INFO - 'ts_paint', 14:28:20 INFO - 'tpaint', 14:28:20 INFO - 'sessionrestore', 14:28:20 INFO - 'sessionrestore_no_auto_restore']}, 14:28:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:28:20 INFO - 'tests': ['a11yr', 14:28:20 INFO - 'ts_paint', 14:28:20 INFO - 'tpaint', 14:28:20 INFO - 'sessionrestore', 14:28:20 INFO - 'sessionrestore_no_auto_restore']}, 14:28:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:28:20 INFO - 'tests': ['a11yr', 14:28:20 INFO - 'ts_paint', 14:28:20 INFO - 'tpaint', 14:28:20 INFO - 'sessionrestore', 14:28:20 INFO - 'sessionrestore_no_auto_restore']}, 14:28:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:28:20 INFO - 'tests': ['a11yr', 14:28:20 INFO - 'ts_paint', 14:28:20 INFO - 'tpaint', 14:28:20 INFO - 'sessionrestore', 14:28:20 INFO - 'sessionrestore_no_auto_restore']}, 14:28:20 INFO - 'other_l64': {'tests': ['a11yr', 14:28:20 INFO - 'ts_paint', 14:28:20 INFO - 'tpaint', 14:28:20 INFO - 'sessionrestore', 14:28:20 INFO - 'sessionrestore_no_auto_restore']}, 14:28:20 INFO - 'other_nol64': {'tests': ['a11yr', 14:28:20 INFO - 'ts_paint', 14:28:20 INFO - 'tpaint', 14:28:20 INFO - 'sessionrestore', 14:28:20 INFO - 'sessionrestore_no_auto_restore']}, 14:28:20 INFO - 'svgr': {'tests': ['tsvgx', 14:28:20 INFO - 'tsvgr_opacity', 14:28:20 INFO - 'tart', 14:28:20 INFO - 'tscrollx', 14:28:20 INFO - 'cart']}, 14:28:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:28:20 INFO - 'tests': ['tsvgx', 14:28:20 INFO - 'tsvgr_opacity', 14:28:20 INFO - 'tart', 14:28:20 INFO - 'tscrollx', 14:28:20 INFO - 'cart']}, 14:28:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:20 INFO - 'tests': ['tp5o']}, 14:28:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:20 INFO - 'talos_options': ['--e10s'], 14:28:20 INFO - 'tests': ['tp5o']}, 14:28:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:20 INFO - 'talos_options': ['--xperf_path', 14:28:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:20 INFO - 'tests': ['tp5n']}, 14:28:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:20 INFO - 'talos_options': ['--e10s', 14:28:20 INFO - '--xperf_path', 14:28:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 14:28:20 INFO - 'C:/slave/talos-data/talos/xperf.config'], 14:28:20 INFO - 'tests': ['tp5n']}}, 14:28:20 INFO - 'talos.zip': {'path': '', 14:28:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:28:20 INFO - Running post-action listener: _resource_record_post_action 14:28:20 INFO - ##### 14:28:20 INFO - ##### Running create-virtualenv step. 14:28:20 INFO - ##### 14:28:20 INFO - Running pre-action listener: _resource_record_pre_action 14:28:20 INFO - Running main action method: create_virtualenv 14:28:20 INFO - Creating virtualenv /builds/slave/test/build/venv 14:28:20 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 14:28:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:28:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:28:20 INFO - Using real prefix '/tools/python27' 14:28:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:28:21 INFO - Installing distribute.............................................................................................................................................................................................done. 14:28:25 INFO - Installing pip.................done. 14:28:25 INFO - Return code: 0 14:28:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10209d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09d001840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe59f0>, '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 0x101d44cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101faf990>, '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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:28: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', 'pip>=1.5'] in /builds/slave/test/build 14:28: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 pip>=1.5 14:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7M7cvGpTsu/Render', 14:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:25 INFO - 'HOME': '/Users/cltbld', 14:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:25 INFO - 'LOGNAME': 'cltbld', 14:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:25 INFO - 'MOZ_NO_REMOTE': '1', 14:28:25 INFO - 'NO_EM_RESTART': '1', 14:28:25 INFO - 'PAGER': '/bin/cat', 14:28:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:25 INFO - 'PWD': '/builds/slave/test', 14:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:25 INFO - 'SHELL': '/bin/bash', 14:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSaB4IWAqL/Listeners', 14:28:25 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:25 INFO - 'USER': 'cltbld', 14:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:25 INFO - 'XPC_FLAGS': '0x0', 14:28:25 INFO - 'XPC_SERVICE_NAME': '0', 14:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:26 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 14:28:26 INFO - Cleaning up... 14:28:26 INFO - Return code: 0 14:28:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:28:26 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')]} 14:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:26 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')]} 14:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:26 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 0x102030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10209d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09d001840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe59f0>, '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 0x101d44cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101faf990>, '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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:28:26 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 14:28:26 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 14:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7M7cvGpTsu/Render', 14:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:26 INFO - 'HOME': '/Users/cltbld', 14:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:26 INFO - 'LOGNAME': 'cltbld', 14:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:26 INFO - 'MOZ_NO_REMOTE': '1', 14:28:26 INFO - 'NO_EM_RESTART': '1', 14:28:26 INFO - 'PAGER': '/bin/cat', 14:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:26 INFO - 'PWD': '/builds/slave/test', 14:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:26 INFO - 'SHELL': '/bin/bash', 14:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSaB4IWAqL/Listeners', 14:28:26 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:26 INFO - 'USER': 'cltbld', 14:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:26 INFO - 'XPC_FLAGS': '0x0', 14:28:26 INFO - 'XPC_SERVICE_NAME': '0', 14:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:26 INFO - Downloading/unpacking psutil>=0.7.1 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:28:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:28:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:29 INFO - Installing collected packages: psutil 14:28:29 INFO - Running setup.py install for psutil 14:28:29 INFO - building 'psutil._psutil_osx' extension 14:28:29 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 14:28:32 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 14:28:32 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 14:28:32 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 14:28:32 INFO - building 'psutil._psutil_posix' extension 14:28:32 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 14:28:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:28:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:28:32 INFO - ^ 14:28:32 INFO - 1 warning generated. 14:28:32 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 14:28:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:32 INFO - Successfully installed psutil 14:28:32 INFO - Cleaning up... 14:28:32 INFO - Return code: 0 14:28:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:32 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 0x102030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10209d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09d001840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe59f0>, '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 0x101d44cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101faf990>, '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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:28:32 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 14:28:32 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 14:28:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7M7cvGpTsu/Render', 14:28:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:32 INFO - 'HOME': '/Users/cltbld', 14:28:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:32 INFO - 'LOGNAME': 'cltbld', 14:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:32 INFO - 'MOZ_NO_REMOTE': '1', 14:28:32 INFO - 'NO_EM_RESTART': '1', 14:28:32 INFO - 'PAGER': '/bin/cat', 14:28:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:32 INFO - 'PWD': '/builds/slave/test', 14:28:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:32 INFO - 'SHELL': '/bin/bash', 14:28:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSaB4IWAqL/Listeners', 14:28:32 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:28:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:32 INFO - 'USER': 'cltbld', 14:28:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:32 INFO - 'XPC_FLAGS': '0x0', 14:28:32 INFO - 'XPC_SERVICE_NAME': '0', 14:28:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:28:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:28:36 INFO - Installing collected packages: mozsystemmonitor 14:28:36 INFO - Running setup.py install for mozsystemmonitor 14:28:36 INFO - Successfully installed mozsystemmonitor 14:28:36 INFO - Cleaning up... 14:28:36 INFO - Return code: 0 14:28:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:36 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 0x102030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10209d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09d001840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe59f0>, '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 0x101d44cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101faf990>, '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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:28:36 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 14:28:36 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 14:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7M7cvGpTsu/Render', 14:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:36 INFO - 'HOME': '/Users/cltbld', 14:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:36 INFO - 'LOGNAME': 'cltbld', 14:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:36 INFO - 'MOZ_NO_REMOTE': '1', 14:28:36 INFO - 'NO_EM_RESTART': '1', 14:28:36 INFO - 'PAGER': '/bin/cat', 14:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:36 INFO - 'PWD': '/builds/slave/test', 14:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:36 INFO - 'SHELL': '/bin/bash', 14:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSaB4IWAqL/Listeners', 14:28:36 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:36 INFO - 'USER': 'cltbld', 14:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:36 INFO - 'XPC_FLAGS': '0x0', 14:28:36 INFO - 'XPC_SERVICE_NAME': '0', 14:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:36 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:36 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 14:28:36 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 14:28:36 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 14:28:36 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 14:28:36 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 14:28:36 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 14:28:39 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:40 INFO - Downloading docopt-0.6.1.tar.gz 14:28:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:40 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:40 INFO - Running setup.py install for blobuploader 14:28:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:41 INFO - Running setup.py install for requests 14:28:41 INFO - Running setup.py install for docopt 14:28:41 INFO - Successfully installed blobuploader requests docopt 14:28:41 INFO - Cleaning up... 14:28:41 INFO - Return code: 0 14:28:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:41 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 0x102030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10209d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09d001840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe59f0>, '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 0x101d44cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101faf990>, '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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:28:41 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 14:28:41 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 14:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7M7cvGpTsu/Render', 14:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:41 INFO - 'HOME': '/Users/cltbld', 14:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:41 INFO - 'LOGNAME': 'cltbld', 14:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:41 INFO - 'MOZ_NO_REMOTE': '1', 14:28:41 INFO - 'NO_EM_RESTART': '1', 14:28:41 INFO - 'PAGER': '/bin/cat', 14:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:41 INFO - 'PWD': '/builds/slave/test', 14:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:41 INFO - 'SHELL': '/bin/bash', 14:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSaB4IWAqL/Listeners', 14:28:41 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:41 INFO - 'USER': 'cltbld', 14:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:41 INFO - 'XPC_FLAGS': '0x0', 14:28:41 INFO - 'XPC_SERVICE_NAME': '0', 14:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:42 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-4YESTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:42 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-WF_wxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:42 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-cI2ljZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:42 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ZcKNcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:42 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Ij8oQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:42 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-bKE4Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:43 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-dDaA9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:43 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-YWhQwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:43 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Op9LQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:43 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-dGYu3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:43 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-gkhZv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:43 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-D2Tl4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:43 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ghO7ZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:44 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-DT1TaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:44 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-jAPp6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:44 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-V6EwMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:44 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-T381ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:44 INFO - Running setup.py install for manifestparser 14:28:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:44 INFO - Running setup.py install for mozcrash 14:28:44 INFO - Running setup.py install for mozdebug 14:28:45 INFO - Running setup.py install for mozdevice 14:28:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:28:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:45 INFO - Running setup.py install for mozfile 14:28:45 INFO - Running setup.py install for mozhttpd 14:28:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:45 INFO - Running setup.py install for mozinfo 14:28:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:45 INFO - Running setup.py install for mozInstall 14:28:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:46 INFO - Running setup.py install for mozleak 14:28:46 INFO - Running setup.py install for mozlog 14:28:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:46 INFO - Running setup.py install for moznetwork 14:28:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:46 INFO - Running setup.py install for mozprocess 14:28:46 INFO - Running setup.py install for mozprofile 14:28:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:47 INFO - Running setup.py install for mozrunner 14:28:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:47 INFO - Running setup.py install for mozscreenshot 14:28:47 INFO - Running setup.py install for moztest 14:28:47 INFO - Running setup.py install for mozversion 14:28:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:47 INFO - Cleaning up... 14:28:47 INFO - Return code: 0 14:28:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 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 0x102030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10209d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09d001840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe59f0>, '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 0x101d44cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101faf990>, '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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:28:47 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 14:28:47 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 14:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7M7cvGpTsu/Render', 14:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:47 INFO - 'HOME': '/Users/cltbld', 14:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:47 INFO - 'LOGNAME': 'cltbld', 14:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:47 INFO - 'MOZ_NO_REMOTE': '1', 14:28:47 INFO - 'NO_EM_RESTART': '1', 14:28:47 INFO - 'PAGER': '/bin/cat', 14:28:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:47 INFO - 'PWD': '/builds/slave/test', 14:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:47 INFO - 'SHELL': '/bin/bash', 14:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSaB4IWAqL/Listeners', 14:28:47 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:47 INFO - 'USER': 'cltbld', 14:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:47 INFO - 'XPC_FLAGS': '0x0', 14:28:47 INFO - 'XPC_SERVICE_NAME': '0', 14:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-uSj440-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:48 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)) 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-aInKvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:48 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)) 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-5HJi0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:48 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)) 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-8jRqvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:48 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)) 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-6q97H1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:49 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)) 14:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:49 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-tUiXlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:49 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)) 14:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:49 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-LBWPit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:49 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)) 14:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:49 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ZqbmnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:49 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)) 14:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:49 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-0LygLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:49 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)) 14:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:49 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Tvt780-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:49 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)) 14:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:49 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-6ovfMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:49 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)) 14:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:49 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-pWwlpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:49 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)) 14:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:50 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-GTPhTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:50 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)) 14:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:50 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-AJWAg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:50 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)) 14:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:50 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-gE7QMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:50 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)) 14:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:50 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-kn4xIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:50 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)) 14:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:50 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Bh89Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:50 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)) 14:28:50 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)) 14:28:50 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)) 14:28:50 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)) 14:28:50 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)) 14:28:50 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)) 14:28:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:50 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 14:28:50 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 14:28:50 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 14:28:50 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 14:28:50 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 14:28:50 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 14:28:53 INFO - Downloading blessings-1.5.1.tar.gz 14:28:53 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 14:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:53 INFO - Installing collected packages: blessings 14:28:53 INFO - Running setup.py install for blessings 14:28:53 INFO - Successfully installed blessings 14:28:53 INFO - Cleaning up... 14:28:53 INFO - Return code: 0 14:28:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:28:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:54 INFO - Reading from file tmpfile_stdout 14:28:54 INFO - Current package versions: 14:28:54 INFO - blessings == 1.5.1 14:28:54 INFO - blobuploader == 1.2.4 14:28:54 INFO - docopt == 0.6.1 14:28:54 INFO - manifestparser == 1.1 14:28:54 INFO - mozInstall == 1.12 14:28:54 INFO - mozcrash == 0.16 14:28:54 INFO - mozdebug == 0.1 14:28:54 INFO - mozdevice == 0.46 14:28:54 INFO - mozfile == 1.2 14:28:54 INFO - mozhttpd == 0.7 14:28:54 INFO - mozinfo == 0.8 14:28:54 INFO - mozleak == 0.1 14:28:54 INFO - mozlog == 3.0 14:28:54 INFO - moznetwork == 0.27 14:28:54 INFO - mozprocess == 0.22 14:28:54 INFO - mozprofile == 0.27 14:28:54 INFO - mozrunner == 6.11 14:28:54 INFO - mozscreenshot == 0.1 14:28:54 INFO - mozsystemmonitor == 0.0 14:28:54 INFO - moztest == 0.7 14:28:54 INFO - mozversion == 1.4 14:28:54 INFO - psutil == 3.1.1 14:28:54 INFO - requests == 1.2.3 14:28:54 INFO - wsgiref == 0.1.2 14:28:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:54 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')]} 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:54 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')]} 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:54 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 0x102030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10209d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09d001840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe59f0>, '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 0x101d44cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101faf990>, '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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:28:54 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 14:28:54 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 14:28:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7M7cvGpTsu/Render', 14:28:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:54 INFO - 'HOME': '/Users/cltbld', 14:28:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:54 INFO - 'LOGNAME': 'cltbld', 14:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:54 INFO - 'MOZ_NO_REMOTE': '1', 14:28:54 INFO - 'NO_EM_RESTART': '1', 14:28:54 INFO - 'PAGER': '/bin/cat', 14:28:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:54 INFO - 'PWD': '/builds/slave/test', 14:28:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:54 INFO - 'SHELL': '/bin/bash', 14:28:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSaB4IWAqL/Listeners', 14:28:54 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:28:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:54 INFO - 'USER': 'cltbld', 14:28:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:54 INFO - 'XPC_FLAGS': '0x0', 14:28:54 INFO - 'XPC_SERVICE_NAME': '0', 14:28:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:54 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)) 14:28:54 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)) 14:28:54 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)) 14:28:54 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)) 14:28:54 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)) 14:28:54 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)) 14:28:54 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)) 14:28:54 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)) 14:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:28:54 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)) 14:28:54 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)) 14:28:54 INFO - Cleaning up... 14:28:54 INFO - Return code: 0 14:28:54 INFO - Running post-action listener: _resource_record_post_action 14:28:54 INFO - Running post-action listener: _start_resource_monitoring 14:28:54 INFO - Starting resource monitoring. 14:28:54 INFO - ##### 14:28:54 INFO - ##### Running install step. 14:28:54 INFO - ##### 14:28:54 INFO - Running pre-action listener: _resource_record_pre_action 14:28:54 INFO - Running main action method: install 14:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:54 INFO - Reading from file tmpfile_stdout 14:28:54 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:28:55 INFO - Reading from file tmpfile_stdout 14:28:55 INFO - Output received: 14:28:55 INFO - Usage: mozinstall [options] installer 14:28:55 INFO - Options: 14:28:55 INFO - -h, --help show this help message and exit 14:28:55 INFO - -d DEST, --destination=DEST 14:28:55 INFO - Directory to install application into. [default: 14:28:55 INFO - "/builds/slave/test"] 14:28:55 INFO - --app=APP Application being installed. [default: firefox] 14:28:55 INFO - mkdir: /builds/slave/test/build/application 14:28:55 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'] 14:28:55 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 14:29:36 INFO - Reading from file tmpfile_stdout 14:29:36 INFO - Output received: 14:29:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:29:36 INFO - Running post-action listener: _resource_record_post_action 14:29:36 INFO - ##### 14:29:36 INFO - ##### Running run-tests step. 14:29:36 INFO - ##### 14:29:36 INFO - Running pre-action listener: _resource_record_pre_action 14:29:36 INFO - Running main action method: run_tests 14:29:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:29:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:29:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:29:36 INFO - 2015-12-01 14:29:36.898 screenresolution[1629:7584] starting screenresolution argv=screenresolution get 14:29:36 INFO - 2015-12-01 14:29:36.901 screenresolution[1629:7584] Display 0: 1600x1200x32@60 14:29:36 INFO - 2015-12-01 14:29:36.909 screenresolution[1630:7586] starting screenresolution argv=screenresolution list 14:29:36 INFO - Available Modes on Display 0 14:29:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:29:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:29:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:29:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:29:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:29:37 INFO - Intel HD Graphics 3000: 14:29:37 INFO - Chipset Model: Intel HD Graphics 3000 14:29:37 INFO - Type: GPU 14:29:37 INFO - Bus: Built-In 14:29:37 INFO - VRAM (Total): 512 MB 14:29:37 INFO - VRAM (Dynamic, Max): 10 14:29:37 INFO - Vendor: Intel (0x8086) 14:29:37 INFO - Device ID: 0x0116 14:29:37 INFO - Revision ID: 0x0009 14:29:37 INFO - Displays: 14:29:37 INFO - Display: 14:29:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:29:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:29:37 INFO - Display Serial Number: 1600x1200 60 14:29:37 INFO - Main Display: Yes 14:29:37 INFO - Mirror: Off 14:29:37 INFO - Online: Yes 14:29:37 INFO - Rotation: Supported 14:29:37 INFO - Return code: 0 14:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:29:37 INFO - Python 2.7.3 14:29:37 INFO - Return code: 0 14:29:37 INFO - grabbing minidump binary from tooltool 14:29: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')]} 14:29:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe59f0>, '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 0x101d44cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101faf990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:29:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:29:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:29:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:29:37 INFO - Return code: 0 14:29:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:29:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:29:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:29:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:29:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] in /builds/slave/test/build 14:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0101 --webServer localhost 14:29:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7M7cvGpTsu/Render', 14:29:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:29:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:29:37 INFO - 'HOME': '/Users/cltbld', 14:29:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:29:37 INFO - 'LOGNAME': 'cltbld', 14:29:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:29:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:37 INFO - 'MOZ_NO_REMOTE': '1', 14:29:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:29:37 INFO - 'NO_EM_RESTART': '1', 14:29:37 INFO - 'PAGER': '/bin/cat', 14:29:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:37 INFO - 'PWD': '/builds/slave/test', 14:29:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:29:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:29:37 INFO - 'SHELL': '/bin/bash', 14:29:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSaB4IWAqL/Listeners', 14:29:37 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:29:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:29:37 INFO - 'USER': 'cltbld', 14:29:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:29:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:37 INFO - 'XPC_FLAGS': '0x0', 14:29:37 INFO - 'XPC_SERVICE_NAME': '0', 14:29:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:29:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] with output_timeout 3600 14:29:37 INFO - mozversion INFO | application_buildid: 20151201121222 14:29:37 INFO - mozversion INFO | application_changeset: c69240d397da029511266b5c5024116472568dc4 14:29:37 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 14:29:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:29:37 INFO - mozversion INFO | application_name: Firefox 14:29:37 INFO - mozversion INFO | application_remotingname: firefox-dev 14:29:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:29:37 INFO - mozversion INFO | application_vendor: Mozilla 14:29:37 INFO - mozversion INFO | application_version: 44.0a2 14:29:37 INFO - mozversion INFO | platform_buildid: 20151201121222 14:29:37 INFO - mozversion INFO | platform_changeset: c69240d397da029511266b5c5024116472568dc4 14:29:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:29:37 INFO - mozversion INFO | platform_version: 44.0a2 14:29:37 INFO - 2015-12-01 14:29:37,672 DEBUG : using testdate: 1449008977 14:29:37 INFO - 2015-12-01 14:29:37,672 DEBUG : actual date: 1449008977 14:29:37 INFO - 2015-12-01 14:29:37,721 INFO : starting webserver on 'localhost:49267' 14:29:37 INFO - 2015-12-01 14:29:37,722 INFO : Starting test suite t-yosemite-r5-0101 14:29:37 INFO - 2015-12-01 14:29:37,723 INFO : Starting test dromaeo_css 14:29:37 INFO - 2015-12-01 14:29:37,723 DEBUG : operating with platform_type : mac_ 14:29:37 INFO - 2015-12-01 14:29:37,724 INFO : Initialising browser for dromaeo_css test... 14:29:37 INFO - 2015-12-01 14:29:37,756 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpNuEDL4/profile http://localhost:49267/getInfo.html 14:29:40 INFO - 2015-12-01 14:29:40,733 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:29:40 INFO - 2015-12-01 14:29:40,733 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:29:40 INFO - 2015-12-01 14:29:40,733 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:29:40 INFO - 2015-12-01 14:29:40,733 DEBUG : BROWSER_OUTPUT: __metrics 14:29:40 INFO - 2015-12-01 14:29:40,750 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:29:41 INFO - 2015-12-01 14:29:41,445 INFO : Browser initialized. 14:29:41 INFO - 2015-12-01 14:29:41,445 INFO : Running cycle 1/1 for dromaeo_css test... 14:29:41 INFO - 2015-12-01 14:29:41,446 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpNuEDL4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:29:53 INFO - 2015-12-01 14:29:53,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 197255168 14:29:53 INFO - 2015-12-01 14:29:53,477 DEBUG : BROWSER_OUTPUT: 14:30:45 INFO - 2015-12-01 14:30:45,148 DEBUG : BROWSER_OUTPUT: 1449009045144 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] 14:32:55 INFO - 2015-12-01 14:32:55,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 14:32:56 INFO - 2015-12-01 14:32:56,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 323489792 14:32:56 INFO - 2015-12-01 14:32:56,768 DEBUG : BROWSER_OUTPUT: 14:35:59 INFO - 2015-12-01 14:35:59,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 14:36:00 INFO - 2015-12-01 14:36:00,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 345034752 14:36:00 INFO - 2015-12-01 14:36:00,236 DEBUG : BROWSER_OUTPUT: 14:39:02 INFO - 2015-12-01 14:39:02,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 14:39:03 INFO - 2015-12-01 14:39:03,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 315207680 14:39:03 INFO - 2015-12-01 14:39:03,102 DEBUG : BROWSER_OUTPUT: 14:42:05 INFO - 2015-12-01 14:42:05,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 14:42:05 INFO - 2015-12-01 14:42:05,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 302051328 14:42:05 INFO - 2015-12-01 14:42:05,754 DEBUG : BROWSER_OUTPUT: 14:45:09 INFO - 2015-12-01 14:45:09,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 14:45:09 INFO - 2015-12-01 14:45:09,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 301838336 14:45:09 INFO - 2015-12-01 14:45:09,785 DEBUG : BROWSER_OUTPUT: 14:48:12 INFO - 2015-12-01 14:48:12,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 14:48:12 INFO - 2015-12-01 14:48:12,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 346017792 14:48:12 INFO - 2015-12-01 14:48:12,562 DEBUG : BROWSER_OUTPUT: 14:48:12 INFO - 2015-12-01 14:48:12,562 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:48:12 INFO - 2015-12-01 14:48:12,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:48:12 INFO - 2015-12-01 14:48:12,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:48:12 INFO - 2015-12-01 14:48:12,563 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:48:12 INFO - 2015-12-01 14:48:12,563 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2687.623732677425;2742.3281296082464;2778.0832325332644;2778.1110044785664;2779.666440027197;4616.422947131608;4689.882752931178;4698.989717210799;4700.083483720676;4724.480307166217;4660.976695116528;4663.300504924263;4671.322658214565;4697.17799385108;4704.858854234379;4243.915121697564;4302.419173411597;4307.93538096928;4309.849155279566;4362.367456718774;4333.176696427684;4386.254336762742;4392.912141757163;4403.537628549005;4405.05291362357;4205.264078786216;4262.424572682695;4341.826326946918;4356.760378179215;4381;4286.507051689049;4376.912461750779;4382.276924307485;4390.385346051556;4412.007298357876;4167.854125105637;4373.125374925028;4376.978115109436;4403.713758605681;4404.933925991113;4493.258612328962;4550.954490455086;4567.817287308504;4631.374764406795;4683.110209060302;4943.332650092228;4944.406671199443;4979.850604481835;5026.145555255615;5057.69653820772;4980.5019498049905;5010.72441015744;5036.521530454601;5070.69575825448;5073.39119305682;4540.160070386989;4551.977240113812;4590.311453282035;4593.839215627437;4670.883227919295;5167.276581278624;5220.321358223407;5254.9752798204745;5268.552173065255;5285.9735701322015;4979.1577116466415;4981;5036.874078148002;5057.089723849743;5058.215976523645;4868.464468908417;4870.683405578626;4919.508049195052;4998.325226094504;5004.924926126111;4908.190148625436;4951.207806750903;4957.231629097496;4966.553010229024;4981.975090124599;4888.242322439956;4951.678140920829;4957.603391728653;4962.454130045692;4976.751162441936;3675.1547144156993;3699.3156266090323;3765.2281282337053;3860.749051311712;3899.3566061600086;3540.238848647553;3544.1494041430387;3545.2377738786286;3551.8401671924826;3575.2491976685187;4580.0610874771255;4617.2612382018715;4632.073585282957;4675.836345727883;4692.671512994058;4789.688670236424;4830.227163653799;4911.017796440726;4925.556699897026;4965.1311020571975;4547.681662283675;4598.770061496912;4634.745089020069;4642.9535704643195;4663.673542851968;4341.6526677865695;4365;4366.410534577855;4369.060651959844;4403.141387429485;4737.620990320766;4935.16102262609;4935.457099718957;5001.8499445016705;5224.764885580082;5016.974915125547;5058.671186372874;5135.897282054263;5170.560502357342;5190.480951904779;5140.665856719302;5145.228215767665;5152.76812543444;5219.060569097447;5221.347331583552;4769.332293478847;4818.373611430632;4938.580220681139;4943.060818444484;5047.949520504748;4744.146053710365;4949.604031677529;5002.824901128443;5051.141305978066;5063.392392912874;4895.926561101515;4903.5586797188425;4910.484399138039;4938.135826230324;4949.133901567283;4744;4773.618110551078;4804.183288840835;4830.6135509159885;4925.532074452921;4760.166970780169;4787.329773831597;4787.736674482937;4824.300476430968;4839.661223714447;4863.10032643962;4869.95130048695;4870.732109733857;4872.123017856678;4946.505349465025;4580.129775342674;4645.86062418128;4658.254679251304;4658.534146585314;4761.285807128958 14:48:12 INFO - 2015-12-01 14:48:12,563 DEBUG : BROWSER_OUTPUT: |1;ext.html;486.36043602662494;488.08484092326887;499.91501444754385;504.40480233324683;521.2572084779189;28048;29557.261068473297;33682.32635347295;34102;34143;37708;38512.61487385126;38528.42207366892;38529.614703853025;38539.61460385395;7422.294881986203;7889.40829437793;7991.160928102553;8065.112837587861;8085.070216925041;7555.659995300197;9590.80818383632;9690.370125941827;9742.805143897118;9790.265730070238;9553.761155971088;9584.904150958506;9716.465594392306;9726.951365243163;9758.560864761102;7464.290892365217;7798.688052477894;9465.858012129824;9554.378965367228;9650.227981761478;9453.810923781555;9461.24310055194;9466.526673666289;9595;9637.951810240904;35694.82152589246;35808.64191358105;35850.64149358499;36156.45765313522;36395.454068189;2515.408878913472;2556.6676332076713;2581.3288544978254;2587.45663410684;2981.1503721439503;24632.384190395205;24639.38401539958;25165.119220827182;25197.37006574832;25466.87266563674;2041.203930467119;2046.5395286060666;2061.938141855747;2087.697283893827;2128.17001369466;227739;231128;232662;235356;236457.99999999828;52140.739296303276;54449.72775136178;54851.72574137104;55172.72413637906;55482;50037.24944125841;63255.683721581096;65761;66876.6656166716;66989.33010669831;14587.781183282259;14990.250487475801;15065.246737663074;15121.621959450882;15235.314410851539;11317.717057073474;11417.885821141848;11473.426328683532;11494.482748276349;11547.018503427134;18153.63692726138;18154.18306176199;18320;18419.631607367777;18722.531936701693;7203.279672032755;7402.1487528933785;7434.925650743423;7463;7514.4364172687265;800.2477670989251;879.5997820991433;903.304455569208;933.178802653674;968.9612415503301;24974.375640608767;26451.867740661175;26557.33606659849;26887.327816804736;26902.86548567284;862.1809281182901;912.1471424218377;928.6378312458147;989.2827699917646;1023.976023976024;11187.888121118847;12602.306873121883;13087.77390500169;13162.078654494286;13333.26667033303;297470;304192;304654;309487;310909;42919.7854010728;43710.7814460932;50506;50569;50889;1233.8396008519014;1250.9437075331632;1256.0642321470564;1277.5081593586535;1278.6803299175206;23560.175393861133;24285.150019749224;25831.741682582935;26245;26558.468830623668;40785.59214407937;41497.170056598094;43211.35182972195;51057.74471127621;52211.216831748316;234654;237065;237474;238812;241335;28747.856260718563;28755;29140.271493211992;29461;29546.409071818012;37845.05387365338;38170.236595267386;38666.42000370053;39013.21973560569;39093.89514100979;29590.743093044763;29897.252568685955;33084.834575826964;34224.82887585546;34500;29733.256668583457;31426.842865785526;31750.206244844063;31863.68136318607;32212.83893580517;29713.702862971957;29780.255493612833;30056.849715751283;30320.5451918217;30368.544471833382;23684.88157559201;24012.87993560021;25851.482970340112;26012;26214.86892565525;20273.49316267046;20791;21027.27933199955;22568.435789105402;22917.31248062494 14:48:12 INFO - 2015-12-01 14:48:12,563 DEBUG : BROWSER_OUTPUT: |2;jquery.html;292.6751306050285;300.4951681175624;301.9245188702824;303.0937496884315;306.1199052723422;12092.516299348015;12969.675758106028;14767.187804670739;14928.626784330383;15360.07839529629;13628.114172578775;14789.704205915876;15351.232438378065;15476.303566339513;15695;4020.798960051986;4077.2049450357194;4088.284550203717;4444.288913773797;4588.49526552079;2997.5503674448896;3082.7071428214285;3140.7801453898237;4116.217918595472;4120.670346372298;3916.70624703147;3922.1175235572055;4040.7373520721058;4111.856085037024;4122.361034039729;4046.4537287466255;4056.9857535616097;4060.8578699745663;4080.163566468867;4106.815193316308;3376.7805092669146;3432.8626854925774;3438.8796392126405;3475.9050898966743;3497.5278337424375;10998;11044.889551104467;11084.944575277153;11264.493097810619;11277.041451476634;1566.7414876545356;1619.0690353047046;1700.319872051177;1707.795064592257;1731.4805558332575;5677.261955945742;5776.797812076557;5787.334456537468;7489.812754681122;8284.212999765012;1238.876112388763;1305.2168698780752;1323.5830713325367;1337.0440135303209;1381.8825399841026;50858.491415085744;54027.72986135044;54365.72817135889;54605.726971365286;54936;5486.149646804752;5571.359293681197;5616.2698849150165;5667.518260947783;5727.140928860705;6189.96905015472;6299.779507717208;6339.809805705836;6368.617882926947;6401.263854656681;4707.882302942454;4790.520947905182;4836.903261934742;4912.828051018198;4929.457759646436;5152.098382782998;5162.92255616166;5210.270562121306;5226.320578324793;5286.867828304246;2527.292358139724;2545.46545225501;2563.4360440703017;2575.9356016099746;2586.3016985413833;866.4584634603373;889.3018980100719;910.7267819654078;933.7432206143229;965.6089283840056;330.5289961804467;337.83783783783923;343.7301718151239;358.5010299477122;362.2609875853282;8090.433669643068;8400.369972251983;8779;8891.155340242667;9364.812703745887;350.9210427653758;354.964503549643;360.70061848665546;364.7064113388748;379.13367954224464;4665.136949664323;4693.366395536627;4753.786079626425;4813.4945830687975;4814.927776083362;500485;506515;507886;520078;520440;63118.36881631217;63528;64558;64865.351346486874;65658.34341656523;346.1519277769475;347.56901442211984;349.47229683178585;351.8065064214672;352.96999755021113;7845.215478452337;8114.188581141839;8207.507549547046;8259.669613215405;8476.40665153458;30699.539506906967;30990.69009309878;31393.8430307847;31436.214094647818;31488.527672084478;39310.80344598259;40166.19667606573;40197;40252;40831;5129.179331306973;5197.584193264605;5367.865803354947;5427.810026649048;5525.419830917695;10007.799844003224;10210.897891021292;10243.282970192015;10290.331128476626;10403.739906502398;8514.276286515715;8683.956580217311;8840.867386989328;8866.157715017063;9046.502442365732;8555.230029297392;8598.269147122564;8609.053004169411;8615.310775137848;8662.480251184948;7701.383889288955;7733.7679869604;8792.340574456814;8879.689210877588;8972.327075469497;5380.43505431924;5386.380566234933;5411.6211865170635;5443.510084092292;5447.536959358499;8299.336053115858;8459.788505287417;8764.386492945432;8856.202941735275;8861.91138088611 14:48:12 INFO - 2015-12-01 14:48:12,564 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1127.0926903842403;1486.9330880110394;1560.9609759756013;1561.8125824901012;1568.827428982812;5572.136318870572;6005.309389420218;6059.545534084945;6151.292601350846;6272.59228150171;6160.291566469846;6269.404406581368;6289.308176100625;6297.370262973712;6298.685065746706;1822.489702883188;1833.2392057296206;1841.5672317005492;1846.4460661801472;1850.2968871828687;1795.3626462605782;1830.9655044899655;1863;1870.1490821676105;1896.7913529511743;1805.9367922122728;1820.1991123905505;1840.8251216134445;1842.981570184301;1849.093943967453;1734.1329335332334;1737.0880287848854;1751.8510926571257;1759.9824001759946;1760.8503277221453;1812.0667856054142;1844.861635377352;1860.9348672796523;1864.645717313706;1869.6634605770955;5631.183478395651;6143.84640383994;6158.507319414436;6231.127642130105;6235.812925612239;3584.8566057357675;3654.26914617075;3797.9810100949594;3871.3031654302213;3955.8417663293435;2332.8133749300014;2403.495265994143;2409.3735628736654;2442.792362649177;2446.3150317911013;748.9700411983514;759.7227012140584;765.1850778920432;765.9080910290745;768.6925229908026;8233.17668233178;8299.211574900375;8361.540115293717;8361.95819020901;8366.874496882552;3377.9493307600405;3532;3538.840752166159;3574.749767516249;3612.8012959287494;7316.341529262392;7366.263373662591;7385.8153546161775;7433;7437.181909989897;3914.158455931988;3975.4831871856472;3975.662068724133;3980.641742243212;3981.442598036277;3506.579210494757;3559.7330200235087;3625.075605720577;3629.9818500907854;3638.1450359165574;2873.1524200360527;2898.4058268054996;2900.753435957967;2928.341123247252;2965.9555106673415;915.5651065743718;920.1810388754014;928.8328100941895;936.7517607833929;942.8727121838464;1060.7825395793843;1066.3495267886583;1070.282910449985;1100.867895852503;1148.1561052626314;5967.1347654589845;6028.3971602839365;6115.724792384353;6119.785807496716;6143.84640383994;409.47587088526734;1003.2375394699934;1050.3435352904435;1073.3935326540636;1098.0831006109988;4803.879903002453;4881.072596206709;4930.827421040246;4936.03747269279;4941.629377796679;6771.153605799275;7153.749618763319;7403.370713489306;7406.481546291816;7438.5908775016815;7303.817404564928;7362.44781641379;7373.77878663641;7386.150592681803;7403.481756277117;5633.549316054706;5898.557608179403;5911.970440147772;5937.970310148422;6041.093835924647;5985.371535988658;6021.578489505692;6043.8186854394435;6097.542684298606;6103.938960610515;6737.629430381376;6757;6773.6951837168435;6793.116894803644;6894.8621027578165;6804.829879253059;6968.965155174192;6986.790396288119;7022.297770223141;7050.753223637148;5595.944040559705;5743.540516758733;5772.336181339199;5792.362840087502;5800.796972105956;5713.600047996601;6072.119542666377;6119.694015299307;6170.629762214281;6180.381961803963;5620.269364982526;5669.5180909621495;5680;5690.345610254708;5761.481466667852;5373.435789242073;5424.1321388577635;5449.2371068049715;5568.387477377404;5602.215689803349;5624;5675.460831221028;5751.396103409082;5757.683327417032;5769.68266745333;4930.556249937523;4981.551660350586;5062.392512898328;5069.898602028013;5076.923846142237;5022.773975171199;5060.089183946925;5068.518490743373;5115.104856650146;5149.897002059863 14:48:12 INFO - 2015-12-01 14:48:12,564 DEBUG : BROWSER_OUTPUT: |4;prototype.html;262.13103561692975;263.4323033862028;269.8569758028244;282.57613579630555;290.7020304188207;5120.385553733548;5194.168932970725;5237.685738855666;5242.659227150232;5275.6043296752805;4933.555979961803;5028.622853286;5090.872728181788;5096.311997880285;5112.642115051948;3897.8051097445154;3906.257811015912;3945.506811648544;3946.4869566956254;3985.641292283694;3815.7328986970924;3874.593167717391;3890.0080479477692;3948.13141108957;3953.169834334793;3813.923721525568;3856.2865869814036;3913.4521167036496;3917.5886531914166;3919.176972835708;3842.519685039342;3864.613538646141;3919.2161567686576;3926.4699265599065;3930.390789427643;3345.1469875181915;3349.1459677782254;3384.560007199073;3400.60892997306;3402.4896265560114;4958.950410495885;4994.800207991676;5019.598432125421;5079.619028572872;5086.77109530072;4385.671074669381;4418.536053714346;4484.461864576239;4509.526499717548;4528.41130653013;5454.563634909197;5455.699936503491;5457.481539253765;5471.808486702986;5474.260974768435;3660.8535658573624;3719.051641831316;3725.7578257413184;3728.1425272187275;3730.08612889841;5602.1036634138345;5675.659460432428;5687.687177205252;5696.202531645573;5713.228714123582;3505.1762835733584;3608.1701208721615;3731.9440208396895;3733.51464309638;3784.829682664287;3727.2545490901384;3757;3762.698984081267;3767.7174211934216;3845.134844659929;4385.912281754347;4410.184115938561;4416.757078360721;4423.292273236331;4425.800838962255;5327.121025030827;5352.652077614943;5418.458154184629;5419.539339156216;5430.456954304617;1343.7446885091802;1359.9592012239648;1371.8765311122047;1379.2069560003038;1387.3132799264429;849.827882960415;885.6678745470449;890.3767362846033;897.6454300551246;905.42053086025;5134.075866344094;5201.08980928336;5220.556252718486;5226.346706661668;5258.07983602868;5622.437756224344;5656.8868622627315;5723.7996670116345;5728.455796699307;5757.481826635623;5167.612429067835;5172.146595811724;5211.895762084813;5215.53060224574;5229.790808367698;3067.585875906724;3074.5234488654296;3115.6261248650308;3121.250899784081;3163.5254711792954;5711.286089238845;5804.506616937608;5821.243238378984;5832.037713777264;5842.386549412336;5805.622634528742;5866.882662346729;5874.03078492044;5876.294844618673;5886.676232807151;5638.23883775685;5683.488486036276;5725.341585717612;5794.768209271666;5821.010428227211;5632.352279487747;5731.283589551306;5735.512481439125;5737.5983681141915;5747.885042299215;5523.337199536081;5538.363088244742;5609.859753506195;5621.213030175861;5641.746121424464;5710.714464276686;5792.768289268551;5794.015017447128;5797.101449275369;5809.390014048633;3620.4388319810473;3635.7091432684792;3779.6598306152578;3799.905002374963;3837.0599203195397;5532.170174473861;5542.7782888684005;5620.578456615852;5639.2668953035845;5721.427857214246;5470.480304371078;5513.448655134454;5553.4724201200825;5577.107662773937;5591.776328946959;5454.236406902957;5469.808556700496;5558.916616250679;5569;5572.4148964358155;5226.189940559219;5334.146536554133;5401.270828438268;5433.755481003285;5446.074167391632;5429.375621803543;5498.835034948958;5599.608027438203;5613.522850557748;5614.747336369955;5442.863928401822;5512.007838589093;5513.944860551504;5524.171374293888;5538.335399752055 14:48:12 INFO - 2015-12-01 14:48:12,568 DEBUG : BROWSER_OUTPUT: |5;yui.html;579.1891352107046;645.7029766307498;649.3344322069875;659.0641289369096;661.1108059659757;11601.941990290057;11678.240914340562;11685;11837.408129593528;11839.348835814028;11023.393713345762;11269.211155219138;11834.467448964795;12003.159778815487;12190.69523261919;608.6439432931718;762.3443838299058;765.674588299973;769.6421164158666;774.9690012399525;620.5687047501988;729.1796728680234;744.3226663735974;754.641545265997;756.3344257053812;770.8843673448971;783.9098503672066;786.2294950948075;786.4023342259895;795.5346122518305;618.3198481670172;648.3419329380682;762.6644276518314;781.3280578702312;796.4783067091065;561.0826299001162;561.7303694226753;564.3509963541918;564.7882044233412;566.6684989281234;11139.331640101538;11257.774844503147;11338.773224535464;11370.772584548262;11564.768704625945;8229.917700822974;8270;8289.668413263462;8382.580870956428;8735.781605459915;7549.433792465587;7727.613619319068;7992.440529162961;8024.558649274288;8072.757817265491;2471.9258422247362;2501.7873480754156;2506.7994560435304;2547.681539807524;2613.1899111275375;39804.800975995226;40804.38793418101;40818;41269.58730412687;41570.999999999694;5470.890582188414;5502.532284755761;5523.392426833045;5528.640638358494;5716.056850619601;9450.149486546245;9462.101100395452;9497.810043799085;9506.667266645634;9510.28672849539;4990.2764099205415;5040.017196646619;5065.468125846733;5075.923861142086;5175.948240517622;3286.983565082159;3318.20363112856;3425.72594192464;3446.3451944130534;3480.7215422766117;2208.3485371815354;2239.1603148819195;2278.2709532949298;2281.7490076091617;2282.463621049052;321.57230882925654;340.9676080772323;341.3156620974979;341.54233327341484;342.17706416069393;439.8108813210286;463.60593495529207;465.2509459769768;480.668338846202;517.169942242695;5713.457221563945;6038.154658347835;6093.75624974996;6203.6587987660205;6236.18929539157;436.6223216917407;441.06054104756663;475.05701183151416;504.8106959890041;512.989410860604;2908.6800451950267;2949.616549848506;3432.2963792422493;3551.396262635358;3561.857525698943;52382;52936.735316323175;53048.73475632675;54266;54456.18315725267;44684;44810;44910.55089449064;45078;45692.77153614277;42337.364939525934;42766;42862.999999999374;43012.78493607512;43525.564744352785;6483.578567393104;6488.480921526361;6492.285848556749;6499.610023398422;6667.599944003376;30907;31109.68890311068;31159;31624.051278461684;31645.841770791918;38420.231595368496;39225;39225.607743923334;42910.356344655476;42964;6276.8430789228805;6469;6572.8356791080605;6602.1747281589805;6656.201255849329;8431.662733490592;8909.643614255358;9009.324300677345;9032.187103160748;9153.038930912158;8966.193042626195;9029.187373136449;9046.683366082156;9088.272938164799;9099.49952752605;9215.400998935047;9235.815283694423;9241.075892410705;9270.44377337362;9356.111169438893;7710.67008919214;8751.168638979287;8751.956240218758;8761.211490965843;8780.692675756318;7741.142537132289;8051.677932882853;8093.838123237385;8317.95841020791;8444.071152173134;7789.649465774167;7850.214978502333;7862.72480463181;7940.642671079931;8285.171482851667 14:48:12 INFO - 2015-12-01 14:48:12,568 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:48:12 INFO - 2015-12-01 14:48:12,568 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:48:12 INFO - 2015-12-01 14:48:12,568 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 14:48:12 INFO - 2015-12-01 14:48:12,568 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:48:12 INFO - 2015-12-01 14:48:12,568 DEBUG : BROWSER_OUTPUT: __startTimestamp1449010092552__endTimestamp 14:48:12 INFO - 2015-12-01 14:48:12,569 DEBUG : BROWSER_OUTPUT: 14:48:12 INFO - 2015-12-01 14:48:12,569 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:48:12 INFO - 2015-12-01 14:48:12,569 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:48:12 INFO - 2015-12-01 14:48:12,569 DEBUG : BROWSER_OUTPUT: 14:48:12 INFO - 2015-12-01 14:48:12,569 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4641.56 Median:4760.17 stddev:501.19 (10.5%) stddev-sans-first:478.71 14:48:12 INFO - 2015-12-01 14:48:12,569 DEBUG : BROWSER_OUTPUT: Values: 2687.6 2742.3 2778.1 2778.1 2779.7 4616.4 4689.9 4699.0 4700.1 4724.5 4661.0 4663.3 4671.3 4697.2 4704.9 4243.9 4302.4 4307.9 4309.8 4362.4 4333.2 4386.3 4392.9 4403.5 4405.1 4205.3 4262.4 4341.8 4356.8 4381.0 4286.5 4376.9 4382.3 4390.4 4412.0 4167.9 4373.1 4377.0 4403.7 4404.9 4493.3 4551.0 4567.8 4631.4 4683.1 4943.3 4944.4 4979.9 5026.1 5057.7 4980.5 5010.7 5036.5 5070.7 5073.4 4540.2 4552.0 4590.3 4593.8 4670.9 5167.3 5220.3 5255.0 5268.6 5286.0 4979.2 4981.0 5036.9 5057.1 5058.2 4868.5 4870.7 4919.5 4998.3 5004.9 4908.2 4951.2 4957.2 4966.6 4982.0 4888.2 4951.7 4957.6 4962.5 4976.8 3675.2 3699.3 3765.2 3860.7 3899.4 3540.2 3544.1 3545.2 3551.8 3575.2 4580.1 4617.3 4632.1 4675.8 4692.7 4789.7 4830.2 4911.0 4925.6 4965.1 4547.7 4598.8 4634.7 4643.0 4663.7 4341.7 4365.0 4366.4 4369.1 4403.1 4737.6 4935.2 4935.5 5001.8 5224.8 5017.0 5058.7 5135.9 5170.6 5190.5 5140.7 5145.2 5152.8 5219.1 5221.3 4769.3 4818.4 4938.6 4943.1 5047.9 4744.1 4949.6 5002.8 5051.1 5063.4 4895.9 4903.6 4910.5 4938.1 4949.1 4744.0 4773.6 4804.2 4830.6 4925.5 4760.2 4787.3 4787.7 4824.3 4839.7 4863.1 4870.0 4870.7 4872.1 4946.5 4580.1 4645.9 4658.3 4658.5 4761.3 14:48:12 INFO - 2015-12-01 14:48:12,570 DEBUG : BROWSER_OUTPUT: 14:48:12 INFO - 2015-12-01 14:48:12,570 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41546.72 Median:171167.92 stddev:68223.95 (39.9%) stddev-sans-first:68345.68 14:48:12 INFO - 2015-12-01 14:48:12,571 DEBUG : BROWSER_OUTPUT: Values: 486.4 488.1 499.9 504.4 521.3 28048.0 29557.3 33682.3 34102.0 34143.0 37708.0 38512.6 38528.4 38529.6 38539.6 7422.3 7889.4 7991.2 8065.1 8085.1 7555.7 9590.8 9690.4 9742.8 9790.3 9553.8 9584.9 9716.5 9727.0 9758.6 7464.3 7798.7 9465.9 9554.4 9650.2 9453.8 9461.2 9466.5 9595.0 9638.0 35694.8 35808.6 35850.6 36156.5 36395.5 2515.4 2556.7 2581.3 2587.5 2981.2 24632.4 24639.4 25165.1 25197.4 25466.9 2041.2 2046.5 2061.9 2087.7 2128.2 227739.0 231128.0 232662.0 235356.0 236458.0 52140.7 54449.7 54851.7 55172.7 55482.0 50037.2 63255.7 65761.0 66876.7 66989.3 14587.8 14990.3 15065.2 15121.6 15235.3 11317.7 11417.9 11473.4 11494.5 11547.0 18153.6 18154.2 18320.0 18419.6 18722.5 7203.3 7402.1 7434.9 7463.0 7514.4 800.2 879.6 903.3 933.2 969.0 24974.4 26451.9 26557.3 26887.3 26902.9 862.2 912.1 928.6 989.3 1024.0 11187.9 12602.3 13087.8 13162.1 13333.3 297470.0 304192.0 304654.0 309487.0 310909.0 42919.8 43710.8 50506.0 50569.0 50889.0 1233.8 1250.9 1256.1 1277.5 1278.7 23560.2 24285.2 25831.7 26245.0 26558.5 40785.6 41497.2 43211.4 51057.7 52211.2 234654.0 237065.0 237474.0 238812.0 241335.0 28747.9 28755.0 29140.3 29461.0 29546.4 37845.1 38170.2 38666.4 39013.2 39093.9 29590.7 29897.3 33084.8 34224.8 34500.0 29733.3 31426.8 31750.2 31863.7 32212.8 29713.7 29780.3 30056.8 30320.5 30368.5 23684.9 24012.9 25851.5 26012.0 26214.9 20273.5 20791.0 21027.3 22568.4 22917.3 14:48:12 INFO - 2015-12-01 14:48:12,571 DEBUG : BROWSER_OUTPUT: 14:48:12 INFO - 2015-12-01 14:48:12,571 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24261.73 Median:4679.25 stddev:83753.03 (1789.9%) stddev-sans-first:83968.64 14:48:12 INFO - 2015-12-01 14:48:12,573 DEBUG : BROWSER_OUTPUT: Values: 292.7 300.5 301.9 303.1 306.1 12092.5 12969.7 14767.2 14928.6 15360.1 13628.1 14789.7 15351.2 15476.3 15695.0 4020.8 4077.2 4088.3 4444.3 4588.5 2997.6 3082.7 3140.8 4116.2 4120.7 3916.7 3922.1 4040.7 4111.9 4122.4 4046.5 4057.0 4060.9 4080.2 4106.8 3376.8 3432.9 3438.9 3475.9 3497.5 10998.0 11044.9 11084.9 11264.5 11277.0 1566.7 1619.1 1700.3 1707.8 1731.5 5677.3 5776.8 5787.3 7489.8 8284.2 1238.9 1305.2 1323.6 1337.0 1381.9 50858.5 54027.7 54365.7 54605.7 54936.0 5486.1 5571.4 5616.3 5667.5 5727.1 6190.0 6299.8 6339.8 6368.6 6401.3 4707.9 4790.5 4836.9 4912.8 4929.5 5152.1 5162.9 5210.3 5226.3 5286.9 2527.3 2545.5 2563.4 2575.9 2586.3 866.5 889.3 910.7 933.7 965.6 330.5 337.8 343.7 358.5 362.3 8090.4 8400.4 8779.0 8891.2 9364.8 350.9 355.0 360.7 364.7 379.1 4665.1 4693.4 4753.8 4813.5 4814.9 500485.0 506515.0 507886.0 520078.0 520440.0 63118.4 63528.0 64558.0 64865.4 65658.3 346.2 347.6 349.5 351.8 353.0 7845.2 8114.2 8207.5 8259.7 8476.4 30699.5 30990.7 31393.8 31436.2 31488.5 39310.8 40166.2 40197.0 40252.0 40831.0 5129.2 5197.6 5367.9 5427.8 5525.4 10007.8 10210.9 10243.3 10290.3 10403.7 8514.3 8684.0 8840.9 8866.2 9046.5 8555.2 8598.3 8609.1 8615.3 8662.5 7701.4 7733.8 8792.3 8879.7 8972.3 5380.4 5386.4 5411.6 5443.5 5447.5 8299.3 8459.8 8764.4 8856.2 8861.9 14:48:12 INFO - 2015-12-01 14:48:12,573 DEBUG : BROWSER_OUTPUT: 14:48:12 INFO - 2015-12-01 14:48:12,573 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4405.14 Median:5599.08 stddev:2235.99 (39.9%) stddev-sans-first:2228.68 14:48:12 INFO - 2015-12-01 14:48:12,574 DEBUG : BROWSER_OUTPUT: Values: 1127.1 1486.9 1561.0 1561.8 1568.8 5572.1 6005.3 6059.5 6151.3 6272.6 6160.3 6269.4 6289.3 6297.4 6298.7 1822.5 1833.2 1841.6 1846.4 1850.3 1795.4 1831.0 1863.0 1870.1 1896.8 1805.9 1820.2 1840.8 1843.0 1849.1 1734.1 1737.1 1751.9 1760.0 1760.9 1812.1 1844.9 1860.9 1864.6 1869.7 5631.2 6143.8 6158.5 6231.1 6235.8 3584.9 3654.3 3798.0 3871.3 3955.8 2332.8 2403.5 2409.4 2442.8 2446.3 749.0 759.7 765.2 765.9 768.7 8233.2 8299.2 8361.5 8362.0 8366.9 3377.9 3532.0 3538.8 3574.7 3612.8 7316.3 7366.3 7385.8 7433.0 7437.2 3914.2 3975.5 3975.7 3980.6 3981.4 3506.6 3559.7 3625.1 3630.0 3638.1 2873.2 2898.4 2900.8 2928.3 2966.0 915.6 920.2 928.8 936.8 942.9 1060.8 1066.3 1070.3 1100.9 1148.2 5967.1 6028.4 6115.7 6119.8 6143.8 409.5 1003.2 1050.3 1073.4 1098.1 4803.9 4881.1 4930.8 4936.0 4941.6 6771.2 7153.7 7403.4 7406.5 7438.6 7303.8 7362.4 7373.8 7386.2 7403.5 5633.5 5898.6 5912.0 5938.0 6041.1 5985.4 6021.6 6043.8 6097.5 6103.9 6737.6 6757.0 6773.7 6793.1 6894.9 6804.8 6969.0 6986.8 7022.3 7050.8 5595.9 5743.5 5772.3 5792.4 5800.8 5713.6 6072.1 6119.7 6170.6 6180.4 5620.3 5669.5 5680.0 5690.3 5761.5 5373.4 5424.1 5449.2 5568.4 5602.2 5624.0 5675.5 5751.4 5757.7 5769.7 4930.6 4981.6 5062.4 5069.9 5076.9 5022.8 5060.1 5068.5 5115.1 5149.9 14:48:12 INFO - 2015-12-01 14:48:12,574 DEBUG : BROWSER_OUTPUT: 14:48:12 INFO - 2015-12-01 14:48:12,575 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4552.99 Median:5228.07 stddev:1398.33 (26.7%) stddev-sans-first:1364.66 14:48:12 INFO - 2015-12-01 14:48:12,576 DEBUG : BROWSER_OUTPUT: Values: 262.1 263.4 269.9 282.6 290.7 5120.4 5194.2 5237.7 5242.7 5275.6 4933.6 5028.6 5090.9 5096.3 5112.6 3897.8 3906.3 3945.5 3946.5 3985.6 3815.7 3874.6 3890.0 3948.1 3953.2 3813.9 3856.3 3913.5 3917.6 3919.2 3842.5 3864.6 3919.2 3926.5 3930.4 3345.1 3349.1 3384.6 3400.6 3402.5 4959.0 4994.8 5019.6 5079.6 5086.8 4385.7 4418.5 4484.5 4509.5 4528.4 5454.6 5455.7 5457.5 5471.8 5474.3 3660.9 3719.1 3725.8 3728.1 3730.1 5602.1 5675.7 5687.7 5696.2 5713.2 3505.2 3608.2 3731.9 3733.5 3784.8 3727.3 3757.0 3762.7 3767.7 3845.1 4385.9 4410.2 4416.8 4423.3 4425.8 5327.1 5352.7 5418.5 5419.5 5430.5 1343.7 1360.0 1371.9 1379.2 1387.3 849.8 885.7 890.4 897.6 905.4 5134.1 5201.1 5220.6 5226.3 5258.1 5622.4 5656.9 5723.8 5728.5 5757.5 5167.6 5172.1 5211.9 5215.5 5229.8 3067.6 3074.5 3115.6 3121.3 3163.5 5711.3 5804.5 5821.2 5832.0 5842.4 5805.6 5866.9 5874.0 5876.3 5886.7 5638.2 5683.5 5725.3 5794.8 5821.0 5632.4 5731.3 5735.5 5737.6 5747.9 5523.3 5538.4 5609.9 5621.2 5641.7 5710.7 5792.8 5794.0 5797.1 5809.4 3620.4 3635.7 3779.7 3799.9 3837.1 5532.2 5542.8 5620.6 5639.3 5721.4 5470.5 5513.4 5553.5 5577.1 5591.8 5454.2 5469.8 5558.9 5569.0 5572.4 5226.2 5334.1 5401.3 5433.8 5446.1 5429.4 5498.8 5599.6 5613.5 5614.7 5442.9 5512.0 5513.9 5524.2 5538.3 14:48:12 INFO - 2015-12-01 14:48:12,576 DEBUG : BROWSER_OUTPUT: 14:48:12 INFO - 2015-12-01 14:48:12,576 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11471.73 Median:563.04 stddev:14543.22 (2583.0%) stddev-sans-first:14561.02 14:48:12 INFO - 2015-12-01 14:48:12,578 DEBUG : BROWSER_OUTPUT: Values: 579.2 645.7 649.3 659.1 661.1 11601.9 11678.2 11685.0 11837.4 11839.3 11023.4 11269.2 11834.5 12003.2 12190.7 608.6 762.3 765.7 769.6 775.0 620.6 729.2 744.3 754.6 756.3 770.9 783.9 786.2 786.4 795.5 618.3 648.3 762.7 781.3 796.5 561.1 561.7 564.4 564.8 566.7 11139.3 11257.8 11338.8 11370.8 11564.8 8229.9 8270.0 8289.7 8382.6 8735.8 7549.4 7727.6 7992.4 8024.6 8072.8 2471.9 2501.8 2506.8 2547.7 2613.2 39804.8 40804.4 40818.0 41269.6 41571.0 5470.9 5502.5 5523.4 5528.6 5716.1 9450.1 9462.1 9497.8 9506.7 9510.3 4990.3 5040.0 5065.5 5075.9 5175.9 3287.0 3318.2 3425.7 3446.3 3480.7 2208.3 2239.2 2278.3 2281.7 2282.5 321.6 341.0 341.3 341.5 342.2 439.8 463.6 465.3 480.7 517.2 5713.5 6038.2 6093.8 6203.7 6236.2 436.6 441.1 475.1 504.8 513.0 2908.7 2949.6 3432.3 3551.4 3561.9 52382.0 52936.7 53048.7 54266.0 54456.2 44684.0 44810.0 44910.6 45078.0 45692.8 42337.4 42766.0 42863.0 43012.8 43525.6 6483.6 6488.5 6492.3 6499.6 6667.6 30907.0 31109.7 31159.0 31624.1 31645.8 38420.2 39225.0 39225.6 42910.4 42964.0 6276.8 6469.0 6572.8 6602.2 6656.2 8431.7 8909.6 9009.3 9032.2 9153.0 8966.2 9029.2 9046.7 9088.3 9099.5 9215.4 9235.8 9241.1 9270.4 9356.1 7710.7 8751.2 8752.0 8761.2 8780.7 7741.1 8051.7 8093.8 8318.0 8444.1 7789.6 7850.2 7862.7 7940.6 8285.2 14:48:12 INFO - 2015-12-01 14:48:12,578 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:48:12 INFO - 2015-12-01 14:48:12,578 DEBUG : BROWSER_OUTPUT: 14:48:13 INFO - 2015-12-01 14:48:13,258 INFO : Browser exited with error code: 0 14:48:13 INFO - 2015-12-01 14:48:13,291 INFO : Completed test dromaeo_css (00:18:35) 14:48:13 INFO - 2015-12-01 14:48:13,291 INFO : Starting test kraken 14:48:13 INFO - 2015-12-01 14:48:13,291 DEBUG : operating with platform_type : mac_ 14:48:13 INFO - 2015-12-01 14:48:13,291 INFO : Initialising browser for kraken test... 14:48:13 INFO - 2015-12-01 14:48:13,306 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpU0G6Jy/profile http://localhost:49267/getInfo.html 14:48:15 INFO - 2015-12-01 14:48:15,770 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:48:15 INFO - 2015-12-01 14:48:15,770 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:48:15 INFO - 2015-12-01 14:48:15,770 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:48:15 INFO - 2015-12-01 14:48:15,770 DEBUG : BROWSER_OUTPUT: __metrics 14:48:15 INFO - 2015-12-01 14:48:15,775 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:48:16 INFO - 2015-12-01 14:48:16,500 INFO : Browser initialized. 14:48:16 INFO - 2015-12-01 14:48:16,500 INFO : Running cycle 1/1 for kraken test... 14:48:16 INFO - 2015-12-01 14:48:16,501 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpU0G6Jy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:48:28 INFO - 2015-12-01 14:48:28,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 197861376 14:48:28 INFO - 2015-12-01 14:48:28,479 DEBUG : BROWSER_OUTPUT: 14:48:31 INFO - 2015-12-01 14:48:31,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 14:48:32 INFO - 2015-12-01 14:48:32,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 264024064 14:48:32 INFO - 2015-12-01 14:48:32,010 DEBUG : BROWSER_OUTPUT: 14:48:35 INFO - 2015-12-01 14:48:35,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 14:48:35 INFO - 2015-12-01 14:48:35,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 276258816 14:48:35 INFO - 2015-12-01 14:48:35,636 DEBUG : BROWSER_OUTPUT: 14:48:38 INFO - 2015-12-01 14:48:38,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 14:48:39 INFO - 2015-12-01 14:48:39,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 264105984 14:48:39 INFO - 2015-12-01 14:48:39,462 DEBUG : BROWSER_OUTPUT: 14:48:41 INFO - 2015-12-01 14:48:41,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 14:48:42 INFO - 2015-12-01 14:48:42,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 265650176 14:48:42 INFO - 2015-12-01 14:48:42,399 DEBUG : BROWSER_OUTPUT: 14:48:44 INFO - 2015-12-01 14:48:44,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:48:45 INFO - 2015-12-01 14:48:45,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 265347072 14:48:45 INFO - 2015-12-01 14:48:45,457 DEBUG : BROWSER_OUTPUT: 14:48:48 INFO - 2015-12-01 14:48:48,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 14:48:49 INFO - 2015-12-01 14:48:49,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 262836224 14:48:49 INFO - 2015-12-01 14:48:49,548 DEBUG : BROWSER_OUTPUT: 14:48:53 INFO - 2015-12-01 14:48:53,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 14:48:53 INFO - 2015-12-01 14:48:53,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 261558272 14:48:53 INFO - 2015-12-01 14:48:53,761 DEBUG : BROWSER_OUTPUT: 14:48:57 INFO - 2015-12-01 14:48:57,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 14:48:57 INFO - 2015-12-01 14:48:57,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 263389184 14:48:57 INFO - 2015-12-01 14:48:57,645 DEBUG : BROWSER_OUTPUT: 14:48:59 INFO - 2015-12-01 14:48:59,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:59 INFO - 2015-12-01 14:48:59,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 297480192 14:48:59 INFO - 2015-12-01 14:48:59,984 DEBUG : BROWSER_OUTPUT: 14:49:01 INFO - 2015-12-01 14:49:01,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:49:02 INFO - 2015-12-01 14:49:02,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 298233856 14:49:02 INFO - 2015-12-01 14:49:02,611 DEBUG : BROWSER_OUTPUT: 14:49:04 INFO - 2015-12-01 14:49:04,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:49:05 INFO - 2015-12-01 14:49:05,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 304148480 14:49:05 INFO - 2015-12-01 14:49:05,496 DEBUG : BROWSER_OUTPUT: 14:49:08 INFO - 2015-12-01 14:49:08,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:49:08 INFO - 2015-12-01 14:49:08,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 305528832 14:49:08 INFO - 2015-12-01 14:49:08,993 DEBUG : BROWSER_OUTPUT: 14:49:11 INFO - 2015-12-01 14:49:11,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:49:12 INFO - 2015-12-01 14:49:12,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 305094656 14:49:12 INFO - 2015-12-01 14:49:12,487 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 14:49:14 INFO - 2015-12-01 14:49:14,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 365191168 14:49:14 INFO - 2015-12-01 14:49:14,665 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,666 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:49:14 INFO - 2015-12-01 14:49:14,666 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:49:14 INFO - 2015-12-01 14:49:14,666 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:49:14 INFO - 2015-12-01 14:49:14,666 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:49:14 INFO - 2015-12-01 14:49:14,666 DEBUG : BROWSER_OUTPUT: |0;ai-astar;124;130;125;132;133;136;118;125;127;124 14:49:14 INFO - 2015-12-01 14:49:14,666 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;180;157;192;181;153;177;151;190;187;159 14:49:14 INFO - 2015-12-01 14:49:14,666 DEBUG : BROWSER_OUTPUT: |2;audio-dft;186;195;197;195;188;218;197;196;189;188 14:49:14 INFO - 2015-12-01 14:49:14,666 DEBUG : BROWSER_OUTPUT: |3;audio-fft;92;92;93;147;82;85;87;87;145;84 14:49:14 INFO - 2015-12-01 14:49:14,666 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;114;114;157;107;110;108;156;108;107;153 14:49:14 INFO - 2015-12-01 14:49:14,667 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;140;142;150;142;142;142;142;140;136;142 14:49:14 INFO - 2015-12-01 14:49:14,667 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;153;153;150;146;154;153;147;153;153 14:49:14 INFO - 2015-12-01 14:49:14,667 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;123;124;124;124;124;123;123;124;123 14:49:14 INFO - 2015-12-01 14:49:14,667 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;71;73;74;73;73;73;86;72;71 14:49:14 INFO - 2015-12-01 14:49:14,667 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;72;76;80;79;80;80;80;77;77 14:49:14 INFO - 2015-12-01 14:49:14,668 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;96;100;100;101;101;100;105;99;101 14:49:14 INFO - 2015-12-01 14:49:14,668 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;144;157;156;144;153;149;155;145;149;153 14:49:14 INFO - 2015-12-01 14:49:14,668 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;169;175;182;182;179;171;170;171;178;165 14:49:14 INFO - 2015-12-01 14:49:14,668 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;78;79;80;85;85;84;83;86;81 14:49:14 INFO - 2015-12-01 14:49:14,668 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:49:14 INFO - 2015-12-01 14:49:14,668 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:49:14 INFO - 2015-12-01 14:49:14,668 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,953 14:49:14 INFO - 2015-12-01 14:49:14,669 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:49:14 INFO - 2015-12-01 14:49:14,669 DEBUG : BROWSER_OUTPUT: __startTimestamp1449010154663__endTimestamp 14:49:14 INFO - 2015-12-01 14:49:14,669 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,669 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:49:14 INFO - 2015-12-01 14:49:14,669 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:49:14 INFO - 2015-12-01 14:49:14,670 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,670 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:127.40 Median:128.50 stddev:5.34 (4.2%) stddev-sans-first:5.52 14:49:14 INFO - 2015-12-01 14:49:14,670 DEBUG : BROWSER_OUTPUT: Values: 124.0 130.0 125.0 132.0 133.0 136.0 118.0 125.0 127.0 124.0 14:49:14 INFO - 2015-12-01 14:49:14,670 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,671 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:172.70 Median:180.50 stddev:16.02 (8.9%) stddev-sans-first:16.77 14:49:14 INFO - 2015-12-01 14:49:14,672 DEBUG : BROWSER_OUTPUT: Values: 180.0 157.0 192.0 181.0 153.0 177.0 151.0 190.0 187.0 159.0 14:49:14 INFO - 2015-12-01 14:49:14,672 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,672 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:194.90 Median:195.50 stddev:9.15 (4.7%) stddev-sans-first:9.12 14:49:14 INFO - 2015-12-01 14:49:14,672 DEBUG : BROWSER_OUTPUT: Values: 186.0 195.0 197.0 195.0 188.0 218.0 197.0 196.0 189.0 188.0 14:49:14 INFO - 2015-12-01 14:49:14,672 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,672 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:99.40 Median:87.00 stddev:24.83 (28.5%) stddev-sans-first:26.20 14:49:14 INFO - 2015-12-01 14:49:14,673 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 93.0 147.0 82.0 85.0 87.0 87.0 145.0 84.0 14:49:14 INFO - 2015-12-01 14:49:14,673 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,673 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:123.40 Median:114.00 stddev:22.20 (19.5%) stddev-sans-first:23.29 14:49:14 INFO - 2015-12-01 14:49:14,673 DEBUG : BROWSER_OUTPUT: Values: 114.0 114.0 157.0 107.0 110.0 108.0 156.0 108.0 107.0 153.0 14:49:14 INFO - 2015-12-01 14:49:14,673 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,673 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:141.80 Median:142.00 stddev:3.46 (2.4%) stddev-sans-first:3.61 14:49:14 INFO - 2015-12-01 14:49:14,674 DEBUG : BROWSER_OUTPUT: Values: 140.0 142.0 150.0 142.0 142.0 142.0 142.0 140.0 136.0 142.0 14:49:14 INFO - 2015-12-01 14:49:14,674 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,675 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:150.90 Median:153.00 stddev:3.11 (2.0%) stddev-sans-first:2.96 14:49:14 INFO - 2015-12-01 14:49:14,675 DEBUG : BROWSER_OUTPUT: Values: 147.0 153.0 153.0 150.0 146.0 154.0 153.0 147.0 153.0 153.0 14:49:14 INFO - 2015-12-01 14:49:14,675 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,676 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:123.40 Median:124.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 14:49:14 INFO - 2015-12-01 14:49:14,676 DEBUG : BROWSER_OUTPUT: Values: 122.0 123.0 124.0 124.0 124.0 124.0 123.0 123.0 124.0 123.0 14:49:14 INFO - 2015-12-01 14:49:14,676 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,676 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:73.00 stddev:5.77 (7.9%) stddev-sans-first:4.61 14:49:14 INFO - 2015-12-01 14:49:14,676 DEBUG : BROWSER_OUTPUT: Values: 62.0 71.0 73.0 74.0 73.0 73.0 73.0 86.0 72.0 71.0 14:49:14 INFO - 2015-12-01 14:49:14,676 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,676 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:77.20 Median:79.50 stddev:3.36 (4.2%) stddev-sans-first:2.71 14:49:14 INFO - 2015-12-01 14:49:14,677 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 76.0 80.0 79.0 80.0 80.0 80.0 77.0 77.0 14:49:14 INFO - 2015-12-01 14:49:14,677 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,677 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:99.10 Median:103.00 stddev:4.48 (4.4%) stddev-sans-first:2.35 14:49:14 INFO - 2015-12-01 14:49:14,677 DEBUG : BROWSER_OUTPUT: Values: 88.0 96.0 100.0 100.0 101.0 101.0 100.0 105.0 99.0 101.0 14:49:14 INFO - 2015-12-01 14:49:14,677 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,678 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:153.00 stddev:4.99 (3.3%) stddev-sans-first:4.71 14:49:14 INFO - 2015-12-01 14:49:14,678 DEBUG : BROWSER_OUTPUT: Values: 144.0 157.0 156.0 144.0 153.0 149.0 155.0 145.0 149.0 153.0 14:49:14 INFO - 2015-12-01 14:49:14,678 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,679 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:176.50 stddev:5.87 (3.3%) stddev-sans-first:5.91 14:49:14 INFO - 2015-12-01 14:49:14,679 DEBUG : BROWSER_OUTPUT: Values: 169.0 175.0 182.0 182.0 179.0 171.0 170.0 171.0 178.0 165.0 14:49:14 INFO - 2015-12-01 14:49:14,680 DEBUG : BROWSER_OUTPUT: 14:49:14 INFO - 2015-12-01 14:49:14,680 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.50 Median:83.50 stddev:3.81 (4.6%) stddev-sans-first:2.92 14:49:14 INFO - 2015-12-01 14:49:14,680 DEBUG : BROWSER_OUTPUT: Values: 74.0 78.0 79.0 80.0 85.0 85.0 84.0 83.0 86.0 81.0 14:49:14 INFO - 2015-12-01 14:49:14,680 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:49:14 INFO - 2015-12-01 14:49:14,680 DEBUG : BROWSER_OUTPUT: 14:49:15 INFO - 2015-12-01 14:49:15,309 INFO : Browser exited with error code: 0 14:49:15 INFO - 2015-12-01 14:49:15,364 INFO : Completed test kraken (00:01:02) 14:49:15 INFO - 2015-12-01 14:49:15,364 INFO : Starting test v8_7 14:49:15 INFO - 2015-12-01 14:49:15,365 DEBUG : operating with platform_type : mac_ 14:49:15 INFO - 2015-12-01 14:49:15,365 INFO : Initialising browser for v8_7 test... 14:49:15 INFO - 2015-12-01 14:49:15,380 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp1WMJBo/profile http://localhost:49267/getInfo.html 14:49:17 INFO - 2015-12-01 14:49:17,831 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:49:17 INFO - 2015-12-01 14:49:17,832 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:49:17 INFO - 2015-12-01 14:49:17,832 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:49:17 INFO - 2015-12-01 14:49:17,832 DEBUG : BROWSER_OUTPUT: __metrics 14:49:17 INFO - 2015-12-01 14:49:17,848 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:49:18 INFO - 2015-12-01 14:49:18,522 INFO : Browser initialized. 14:49:18 INFO - 2015-12-01 14:49:18,523 INFO : Running cycle 1/1 for v8_7 test... 14:49:18 INFO - 2015-12-01 14:49:18,523 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp1WMJBo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:49:30 INFO - 2015-12-01 14:49:30,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 198844416 14:49:30 INFO - 2015-12-01 14:49:30,524 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 14:49:53 INFO - 2015-12-01 14:49:53,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 516698112 14:49:53 INFO - 2015-12-01 14:49:53,397 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,397 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:49:53 INFO - 2015-12-01 14:49:53,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:49:53 INFO - 2015-12-01 14:49:53,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:49:53 INFO - 2015-12-01 14:49:53,397 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:49:53 INFO - 2015-12-01 14:49:53,397 DEBUG : BROWSER_OUTPUT: |0;Richards;193.01293186643505 14:49:53 INFO - 2015-12-01 14:49:53,398 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;214.86892995272885 14:49:53 INFO - 2015-12-01 14:49:53,398 DEBUG : BROWSER_OUTPUT: |2;Encrypt;374.251497005988 14:49:53 INFO - 2015-12-01 14:49:53,398 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7049.295774647887 14:49:53 INFO - 2015-12-01 14:49:53,398 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1210.3990326481257 14:49:53 INFO - 2015-12-01 14:49:53,398 DEBUG : BROWSER_OUTPUT: |5;Earley;823.7232289950576 14:49:53 INFO - 2015-12-01 14:49:53,398 DEBUG : BROWSER_OUTPUT: |6;Boyer;14955.223880597016 14:49:53 INFO - 2015-12-01 14:49:53,398 DEBUG : BROWSER_OUTPUT: |7;RegExp;34542.372881355936 14:49:53 INFO - 2015-12-01 14:49:53,398 DEBUG : BROWSER_OUTPUT: |8;Splay;690.1311249137336 14:49:53 INFO - 2015-12-01 14:49:53,399 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6673.333333333333 14:49:53 INFO - 2015-12-01 14:49:53,399 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:49:53 INFO - 2015-12-01 14:49:53,399 DEBUG : BROWSER_OUTPUT: __startTimestamp1449010193390__endTimestamp 14:49:53 INFO - 2015-12-01 14:49:53,399 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,399 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:49:53 INFO - 2015-12-01 14:49:53,399 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:49:53 INFO - 2015-12-01 14:49:53,399 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,399 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:193.01 Median:193.01 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,400 DEBUG : BROWSER_OUTPUT: Values: 193.0 14:49:53 INFO - 2015-12-01 14:49:53,400 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,400 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:214.87 Median:214.87 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,400 DEBUG : BROWSER_OUTPUT: Values: 214.9 14:49:53 INFO - 2015-12-01 14:49:53,400 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,400 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:374.25 Median:374.25 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,400 DEBUG : BROWSER_OUTPUT: Values: 374.3 14:49:53 INFO - 2015-12-01 14:49:53,400 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,401 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7049.30 Median:7049.30 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,401 DEBUG : BROWSER_OUTPUT: Values: 7049.3 14:49:53 INFO - 2015-12-01 14:49:53,401 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,401 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1210.40 Median:1210.40 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,401 DEBUG : BROWSER_OUTPUT: Values: 1210.4 14:49:53 INFO - 2015-12-01 14:49:53,401 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,401 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:823.72 Median:823.72 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,401 DEBUG : BROWSER_OUTPUT: Values: 823.7 14:49:53 INFO - 2015-12-01 14:49:53,402 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,402 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14955.22 Median:14955.22 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,402 DEBUG : BROWSER_OUTPUT: Values: 14955.2 14:49:53 INFO - 2015-12-01 14:49:53,402 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,402 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34542.37 Median:34542.37 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,402 DEBUG : BROWSER_OUTPUT: Values: 34542.4 14:49:53 INFO - 2015-12-01 14:49:53,402 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,402 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:690.13 Median:690.13 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,403 DEBUG : BROWSER_OUTPUT: Values: 690.1 14:49:53 INFO - 2015-12-01 14:49:53,403 DEBUG : BROWSER_OUTPUT: 14:49:53 INFO - 2015-12-01 14:49:53,403 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6673.33 Median:6673.33 stddev:0.00 (0.0%) 14:49:53 INFO - 2015-12-01 14:49:53,403 DEBUG : BROWSER_OUTPUT: Values: 6673.3 14:49:53 INFO - 2015-12-01 14:49:53,403 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:49:53 INFO - 2015-12-01 14:49:53,403 DEBUG : BROWSER_OUTPUT: 14:49:54 INFO - 2015-12-01 14:49:54,087 INFO : Browser exited with error code: 0 14:49:54 INFO - 2015-12-01 14:49:54,111 INFO : Completed test v8_7 (00:00:38) 14:49:54 INFO - 2015-12-01 14:49:54,389 INFO : Completed test suite (00:20:16) 14:49:54 INFO - 2015-12-01 14:49:54,389 DEBUG : Working with test: dromaeo_css 14:49:54 INFO - 2015-12-01 14:49:54,389 DEBUG : Generating results file: dromaeo_css 14:49:54 INFO - 2015-12-01 14:49:54,390 DEBUG : Working with test: kraken 14:49:54 INFO - 2015-12-01 14:49:54,390 DEBUG : Generating results file: kraken 14:49:54 INFO - 2015-12-01 14:49:54,390 INFO : javascript benchmark 14:49:54 INFO - 2015-12-01 14:49:54,390 DEBUG : Working with test: v8_7 14:49:54 INFO - 2015-12-01 14:49:54,390 DEBUG : Generating results file: v8_7 14:49:54 INFO - 2015-12-01 14:49:54,390 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:49:54 INFO - 2015-12-01 14:49:54,437 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 14:49:54 INFO - 2015-12-01 14:49:54,437 DEBUG : process_Request line: dromaeo_css 5622.39 graph.html#tests=[[72,52,55]] 14:49:54 INFO - 2015-12-01 14:49:54,437 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:49:54 INFO - 2015-12-01 14:49:54,462 DEBUG : process_Request line: kraken 1789.20 graph.html#tests=[[232,52,55]] 14:49:54 INFO - 2015-12-01 14:49:54,462 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:49:54 INFO - 2015-12-01 14:49:54,488 DEBUG : process_Request line: v8_7 17324.10 graph.html#tests=[[230,52,55]] 14:49:54 INFO - 2015-12-01 14:49:54,488 INFO : javascript benchmark 14:49:54 INFO - 2015-12-01 14:49:54,491 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [292.6751306050285, 300.4951681175624, 301.9245188702824, 303.0937496884315, 306.1199052723422, 12092.516299348015, 12969.675758106028, 14767.187804670739, 14928.626784330383, 15360.07839529629, 13628.114172578775, 14789.704205915876, 15351.232438378065, 15476.303566339513, 15695.0, 4020.798960051986, 4077.2049450357194, 4088.284550203717, 4444.288913773797, 4588.49526552079, 2997.5503674448896, 3082.7071428214285, 3140.7801453898237, 4116.217918595472, 4120.670346372298, 3916.70624703147, 3922.1175235572055, 4040.7373520721058, 4111.856085037024, 4122.361034039729, 4046.4537287466255, 4056.9857535616097, 4060.8578699745663, 4080.163566468867, 4106.815193316308, 3376.7805092669146, 3432.8626854925774, 3438.8796392126405, 3475.9050898966743, 3497.5278337424375, 10998.0, 11044.889551104467, 11084.944575277153, 11264.493097810619, 11277.041451476634, 1566.7414876545356, 1619.0690353047046, 1700.319872051177, 1707.795064592257, 1731.4805558332575, 5677.261955945742, 5776.797812076557, 5787.334456537468, 7489.812754681122, 8284.212999765012, 1238.876112388763, 1305.2168698780752, 1323.5830713325367, 1337.0440135303209, 1381.8825399841026, 50858.491415085744, 54027.72986135044, 54365.72817135889, 54605.726971365286, 54936.0, 5486.149646804752, 5571.359293681197, 5616.2698849150165, 5667.518260947783, 5727.140928860705, 6189.96905015472, 6299.779507717208, 6339.809805705836, 6368.617882926947, 6401.263854656681, 4707.882302942454, 4790.520947905182, 4836.903261934742, 4912.828051018198, 4929.457759646436, 5152.098382782998, 5162.92255616166, 5210.270562121306, 5226.320578324793, 5286.867828304246, 2527.292358139724, 2545.46545225501, 2563.4360440703017, 2575.9356016099746, 2586.3016985413833, 866.4584634603373, 889.3018980100719, 910.7267819654078, 933.7432206143229, 965.6089283840056, 330.5289961804467, 337.83783783783923, 343.7301718151239, 358.5010299477122, 362.2609875853282, 8090.433669643068, 8400.369972251983, 8779.0, 8891.155340242667, 9364.812703745887, 350.9210427653758, 354.964503549643, 360.70061848665546, 364.7064113388748, 379.13367954224464, 4665.136949664323, 4693.366395536627, 4753.786079626425, 4813.4945830687975, 4814.927776083362, 500485.0, 506515.0, 507886.0, 520078.0, 520440.0, 63118.36881631217, 63528.0, 64558.0, 64865.351346486874, 65658.34341656523, 346.1519277769475, 347.56901442211984, 349.47229683178585, 351.8065064214672, 352.96999755021113, 7845.215478452337, 8114.188581141839, 8207.507549547046, 8259.669613215405, 8476.40665153458, 30699.539506906967, 30990.69009309878, 31393.8430307847, 31436.214094647818, 31488.527672084478, 39310.80344598259, 40166.19667606573, 40197.0, 40252.0, 40831.0, 5129.179331306973, 5197.584193264605, 5367.865803354947, 5427.810026649048, 5525.419830917695, 10007.799844003224, 10210.897891021292, 10243.282970192015, 10290.331128476626, 10403.739906502398, 8514.276286515715, 8683.956580217311, 8840.867386989328, 8866.157715017063, 9046.502442365732, 8555.230029297392, 8598.269147122564, 8609.053004169411, 8615.310775137848, 8662.480251184948, 7701.383889288955, 7733.7679869604, 8792.340574456814, 8879.689210877588, 8972.327075469497, 5380.43505431924, 5386.380566234933, 5411.6211865170635, 5443.510084092292, 5447.536959358499, 8299.336053115858, 8459.788505287417, 8764.386492945432, 8856.202941735275, 8861.91138088611], "dojo.html": [2687.623732677425, 2742.3281296082464, 2778.0832325332644, 2778.1110044785664, 2779.666440027197, 4616.422947131608, 4689.882752931178, 4698.989717210799, 4700.083483720676, 4724.480307166217, 4660.976695116528, 4663.300504924263, 4671.322658214565, 4697.17799385108, 4704.858854234379, 4243.915121697564, 4302.419173411597, 4307.93538096928, 4309.849155279566, 4362.367456718774, 4333.176696427684, 4386.254336762742, 4392.912141757163, 4403.537628549005, 4405.05291362357, 4205.264078786216, 4262.424572682695, 4341.826326946918, 4356.760378179215, 4381.0, 4286.507051689049, 4376.912461750779, 4382.276924307485, 4390.385346051556, 4412.007298357876, 4167.854125105637, 4373.125374925028, 4376.978115109436, 4403.713758605681, 4404.933925991113, 4493.258612328962, 4550.954490455086, 4567.817287308504, 4631.374764406795, 4683.110209060302, 4943.332650092228, 4944.406671199443, 4979.850604481835, 5026.145555255615, 5057.69653820772, 4980.5019498049905, 5010.72441015744, 5036.521530454601, 5070.69575825448, 5073.39119305682, 4540.160070386989, 4551.977240113812, 4590.311453282035, 4593.839215627437, 4670.883227919295, 5167.276581278624, 5220.321358223407, 5254.9752798204745, 5268.552173065255, 5285.9735701322015, 4979.1577116466415, 4981.0, 5036.874078148002, 5057.089723849743, 5058.215976523645, 4868.464468908417, 4870.683405578626, 4919.508049195052, 4998.325226094504, 5004.924926126111, 4908.190148625436, 4951.207806750903, 4957.231629097496, 4966.553010229024, 4981.975090124599, 4888.242322439956, 4951.678140920829, 4957.603391728653, 4962.454130045692, 4976.751162441936, 3675.1547144156993, 3699.3156266090323, 3765.2281282337053, 3860.749051311712, 3899.3566061600086, 3540.238848647553, 3544.1494041430387, 3545.2377738786286, 3551.8401671924826, 3575.2491976685187, 4580.0610874771255, 4617.2612382018715, 4632.073585282957, 4675.836345727883, 4692.671512994058, 4789.688670236424, 4830.227163653799, 4911.017796440726, 4925.556699897026, 4965.1311020571975, 4547.681662283675, 4598.770061496912, 4634.745089020069, 4642.9535704643195, 4663.673542851968, 4341.6526677865695, 4365.0, 4366.410534577855, 4369.060651959844, 4403.141387429485, 4737.620990320766, 4935.16102262609, 4935.457099718957, 5001.8499445016705, 5224.764885580082, 5016.974915125547, 5058.671186372874, 5135.897282054263, 5170.560502357342, 5190.480951904779, 5140.665856719302, 5145.228215767665, 5152.76812543444, 5219.060569097447, 5221.347331583552, 4769.332293478847, 4818.373611430632, 4938.580220681139, 4943.060818444484, 5047.949520504748, 4744.146053710365, 4949.604031677529, 5002.824901128443, 5051.141305978066, 5063.392392912874, 4895.926561101515, 4903.5586797188425, 4910.484399138039, 4938.135826230324, 4949.133901567283, 4744.0, 4773.618110551078, 4804.183288840835, 4830.6135509159885, 4925.532074452921, 4760.166970780169, 4787.329773831597, 4787.736674482937, 4824.300476430968, 4839.661223714447, 4863.10032643962, 4869.95130048695, 4870.732109733857, 4872.123017856678, 4946.505349465025, 4580.129775342674, 4645.86062418128, 4658.254679251304, 4658.534146585314, 4761.285807128958], "mootools.html": [1127.0926903842403, 1486.9330880110394, 1560.9609759756013, 1561.8125824901012, 1568.827428982812, 5572.136318870572, 6005.309389420218, 6059.545534084945, 6151.292601350846, 6272.59228150171, 6160.291566469846, 6269.404406581368, 6289.308176100625, 6297.370262973712, 6298.685065746706, 1822.489702883188, 1833.2392057296206, 1841.5672317005492, 1846.4460661801472, 1850.2968871828687, 1795.3626462605782, 1830.9655044899655, 1863.0, 1870.1490821676105, 1896.7913529511743, 1805.9367922122728, 1820.1991123905505, 1840.8251216134445, 1842.981570184301, 1849.093943967453, 1734.1329335332334, 1737.0880287848854, 1751.8510926571257, 1759.9824001759946, 1760.8503277221453, 1812.0667856054142, 1844.861635377352, 1860.9348672796523, 1864.645717313706, 1869.6634605770955, 5631.183478395651, 6143.84640383994, 6158.507319414436, 6231.127642130105, 6235.812925612239, 3584.8566057357675, 3654.26914617075, 3797.9810100949594, 3871.3031654302213, 3955.8417663293435, 2332.8133749300014, 2403.495265994143, 2409.3735628736654, 2442.792362649177, 2446.3150317911013, 748.9700411983514, 759.7227012140584, 765.1850778920432, 765.9080910290745, 768.6925229908026, 8233.17668233178, 8299.211574900375, 8361.540115293717, 8361.95819020901, 8366.874496882552, 3377.9493307600405, 3532.0, 3538.840752166159, 3574.749767516249, 3612.8012959287494, 7316.341529262392, 7366.263373662591, 7385.8153546161775, 7433.0, 7437.181909989897, 3914.158455931988, 3975.4831871856472, 3975.662068724133, 3980.641742243212, 3981.442598036277, 3506.579210494757, 3559.7330200235087, 3625.075605720577, 3629.9818500907854, 3638.1450359165574, 2873.1524200360527, 2898.4058268054996, 2900.753435957967, 2928.341123247252, 2965.9555106673415, 915.5651065743718, 920.1810388754014, 928.8328100941895, 936.7517607833929, 942.8727121838464, 1060.7825395793843, 1066.3495267886583, 1070.282910449985, 1100.867895852503, 1148.1561052626314, 5967.1347654589845, 6028.3971602839365, 6115.724792384353, 6119.785807496716, 6143.84640383994, 409.47587088526734, 1003.2375394699934, 1050.3435352904435, 1073.3935326540636, 1098.0831006109988, 4803.879903002453, 4881.072596206709, 4930.827421040246, 4936.03747269279, 4941.629377796679, 6771.153605799275, 7153.749618763319, 7403.370713489306, 7406.481546291816, 7438.5908775016815, 7303.817404564928, 7362.44781641379, 7373.77878663641, 7386.150592681803, 7403.481756277117, 5633.549316054706, 5898.557608179403, 5911.970440147772, 5937.970310148422, 6041.093835924647, 5985.371535988658, 6021.578489505692, 6043.8186854394435, 6097.542684298606, 6103.938960610515, 6737.629430381376, 6757.0, 6773.6951837168435, 6793.116894803644, 6894.8621027578165, 6804.829879253059, 6968.965155174192, 6986.790396288119, 7022.297770223141, 7050.753223637148, 5595.944040559705, 5743.540516758733, 5772.336181339199, 5792.362840087502, 5800.796972105956, 5713.600047996601, 6072.119542666377, 6119.694015299307, 6170.629762214281, 6180.381961803963, 5620.269364982526, 5669.5180909621495, 5680.0, 5690.345610254708, 5761.481466667852, 5373.435789242073, 5424.1321388577635, 5449.2371068049715, 5568.387477377404, 5602.215689803349, 5624.0, 5675.460831221028, 5751.396103409082, 5757.683327417032, 5769.68266745333, 4930.556249937523, 4981.551660350586, 5062.392512898328, 5069.898602028013, 5076.923846142237, 5022.773975171199, 5060.089183946925, 5068.518490743373, 5115.104856650146, 5149.897002059863], "ext.html": [486.36043602662494, 488.08484092326887, 499.91501444754385, 504.40480233324683, 521.2572084779189, 28048.0, 29557.261068473297, 33682.32635347295, 34102.0, 34143.0, 37708.0, 38512.61487385126, 38528.42207366892, 38529.614703853025, 38539.61460385395, 7422.294881986203, 7889.40829437793, 7991.160928102553, 8065.112837587861, 8085.070216925041, 7555.659995300197, 9590.80818383632, 9690.370125941827, 9742.805143897118, 9790.265730070238, 9553.761155971088, 9584.904150958506, 9716.465594392306, 9726.951365243163, 9758.560864761102, 7464.290892365217, 7798.688052477894, 9465.858012129824, 9554.378965367228, 9650.227981761478, 9453.810923781555, 9461.24310055194, 9466.526673666289, 9595.0, 9637.951810240904, 35694.82152589246, 35808.64191358105, 35850.64149358499, 36156.45765313522, 36395.454068189, 2515.408878913472, 2556.6676332076713, 2581.3288544978254, 2587.45663410684, 2981.1503721439503, 24632.384190395205, 24639.38401539958, 25165.119220827182, 25197.37006574832, 25466.87266563674, 2041.203930467119, 2046.5395286060666, 2061.938141855747, 2087.697283893827, 2128.17001369466, 227739.0, 231128.0, 232662.0, 235356.0, 236457.99999999828, 52140.739296303276, 54449.72775136178, 54851.72574137104, 55172.72413637906, 55482.0, 50037.24944125841, 63255.683721581096, 65761.0, 66876.6656166716, 66989.33010669831, 14587.781183282259, 14990.250487475801, 15065.246737663074, 15121.621959450882, 15235.314410851539, 11317.717057073474, 11417.885821141848, 11473.426328683532, 11494.482748276349, 11547.018503427134, 18153.63692726138, 18154.18306176199, 18320.0, 18419.631607367777, 18722.531936701693, 7203.279672032755, 7402.1487528933785, 7434.925650743423, 7463.0, 7514.4364172687265, 800.2477670989251, 879.5997820991433, 903.304455569208, 933.178802653674, 968.9612415503301, 24974.375640608767, 26451.867740661175, 26557.33606659849, 26887.327816804736, 26902.86548567284, 862.1809281182901, 912.1471424218377, 928.6378312458147, 989.2827699917646, 1023.976023976024, 11187.888121118847, 12602.306873121883, 13087.77390500169, 13162.078654494286, 13333.26667033303, 297470.0, 304192.0, 304654.0, 309487.0, 310909.0, 42919.7854010728, 43710.7814460932, 50506.0, 50569.0, 50889.0, 1233.8396008519014, 1250.9437075331632, 1256.0642321470564, 1277.5081593586535, 1278.6803299175206, 23560.175393861133, 24285.150019749224, 25831.741682582935, 26245.0, 26558.468830623668, 40785.59214407937, 41497.170056598094, 43211.35182972195, 51057.74471127621, 52211.216831748316, 234654.0, 237065.0, 237474.0, 238812.0, 241335.0, 28747.856260718563, 28755.0, 29140.271493211992, 29461.0, 29546.409071818012, 37845.05387365338, 38170.236595267386, 38666.42000370053, 39013.21973560569, 39093.89514100979, 29590.743093044763, 29897.252568685955, 33084.834575826964, 34224.82887585546, 34500.0, 29733.256668583457, 31426.842865785526, 31750.206244844063, 31863.68136318607, 32212.83893580517, 29713.702862971957, 29780.255493612833, 30056.849715751283, 30320.5451918217, 30368.544471833382, 23684.88157559201, 24012.87993560021, 25851.482970340112, 26012.0, 26214.86892565525, 20273.49316267046, 20791.0, 21027.27933199955, 22568.435789105402, 22917.31248062494], "prototype.html": [262.13103561692975, 263.4323033862028, 269.8569758028244, 282.57613579630555, 290.7020304188207, 5120.385553733548, 5194.168932970725, 5237.685738855666, 5242.659227150232, 5275.6043296752805, 4933.555979961803, 5028.622853286, 5090.872728181788, 5096.311997880285, 5112.642115051948, 3897.8051097445154, 3906.257811015912, 3945.506811648544, 3946.4869566956254, 3985.641292283694, 3815.7328986970924, 3874.593167717391, 3890.0080479477692, 3948.13141108957, 3953.169834334793, 3813.923721525568, 3856.2865869814036, 3913.4521167036496, 3917.5886531914166, 3919.176972835708, 3842.519685039342, 3864.613538646141, 3919.2161567686576, 3926.4699265599065, 3930.390789427643, 3345.1469875181915, 3349.1459677782254, 3384.560007199073, 3400.60892997306, 3402.4896265560114, 4958.950410495885, 4994.800207991676, 5019.598432125421, 5079.619028572872, 5086.77109530072, 4385.671074669381, 4418.536053714346, 4484.461864576239, 4509.526499717548, 4528.41130653013, 5454.563634909197, 5455.699936503491, 5457.481539253765, 5471.808486702986, 5474.260974768435, 3660.8535658573624, 3719.051641831316, 3725.7578257413184, 3728.1425272187275, 3730.08612889841, 5602.1036634138345, 5675.659460432428, 5687.687177205252, 5696.202531645573, 5713.228714123582, 3505.1762835733584, 3608.1701208721615, 3731.9440208396895, 3733.51464309638, 3784.829682664287, 3727.2545490901384, 3757.0, 3762.698984081267, 3767.7174211934216, 3845.134844659929, 4385.912281754347, 4410.184115938561, 4416.757078360721, 4423.292273236331, 4425.800838962255, 5327.121025030827, 5352.652077614943, 5418.458154184629, 5419.539339156216, 5430.456954304617, 1343.7446885091802, 1359.9592012239648, 1371.8765311122047, 1379.2069560003038, 1387.3132799264429, 849.827882960415, 885.6678745470449, 890.3767362846033, 897.6454300551246, 905.42053086025, 5134.075866344094, 5201.08980928336, 5220.556252718486, 5226.346706661668, 5258.07983602868, 5622.437756224344, 5656.8868622627315, 5723.7996670116345, 5728.455796699307, 5757.481826635623, 5167.612429067835, 5172.146595811724, 5211.895762084813, 5215.53060224574, 5229.790808367698, 3067.585875906724, 3074.5234488654296, 3115.6261248650308, 3121.250899784081, 3163.5254711792954, 5711.286089238845, 5804.506616937608, 5821.243238378984, 5832.037713777264, 5842.386549412336, 5805.622634528742, 5866.882662346729, 5874.03078492044, 5876.294844618673, 5886.676232807151, 5638.23883775685, 5683.488486036276, 5725.341585717612, 5794.768209271666, 5821.010428227211, 5632.352279487747, 5731.283589551306, 5735.512481439125, 5737.5983681141915, 5747.885042299215, 5523.337199536081, 5538.363088244742, 5609.859753506195, 5621.213030175861, 5641.746121424464, 5710.714464276686, 5792.768289268551, 5794.015017447128, 5797.101449275369, 5809.390014048633, 3620.4388319810473, 3635.7091432684792, 3779.6598306152578, 3799.905002374963, 3837.0599203195397, 5532.170174473861, 5542.7782888684005, 5620.578456615852, 5639.2668953035845, 5721.427857214246, 5470.480304371078, 5513.448655134454, 5553.4724201200825, 5577.107662773937, 5591.776328946959, 5454.236406902957, 5469.808556700496, 5558.916616250679, 5569.0, 5572.4148964358155, 5226.189940559219, 5334.146536554133, 5401.270828438268, 5433.755481003285, 5446.074167391632, 5429.375621803543, 5498.835034948958, 5599.608027438203, 5613.522850557748, 5614.747336369955, 5442.863928401822, 5512.007838589093, 5513.944860551504, 5524.171374293888, 5538.335399752055], "yui.html": [579.1891352107046, 645.7029766307498, 649.3344322069875, 659.0641289369096, 661.1108059659757, 11601.941990290057, 11678.240914340562, 11685.0, 11837.408129593528, 11839.348835814028, 11023.393713345762, 11269.211155219138, 11834.467448964795, 12003.159778815487, 12190.69523261919, 608.6439432931718, 762.3443838299058, 765.674588299973, 769.6421164158666, 774.9690012399525, 620.5687047501988, 729.1796728680234, 744.3226663735974, 754.641545265997, 756.3344257053812, 770.8843673448971, 783.9098503672066, 786.2294950948075, 786.4023342259895, 795.5346122518305, 618.3198481670172, 648.3419329380682, 762.6644276518314, 781.3280578702312, 796.4783067091065, 561.0826299001162, 561.7303694226753, 564.3509963541918, 564.7882044233412, 566.6684989281234, 11139.331640101538, 11257.774844503147, 11338.773224535464, 11370.772584548262, 11564.768704625945, 8229.917700822974, 8270.0, 8289.668413263462, 8382.580870956428, 8735.781605459915, 7549.433792465587, 7727.613619319068, 7992.440529162961, 8024.558649274288, 8072.757817265491, 2471.9258422247362, 2501.7873480754156, 2506.7994560435304, 2547.681539807524, 2613.1899111275375, 39804.800975995226, 40804.38793418101, 40818.0, 41269.58730412687, 41570.999999999694, 5470.890582188414, 5502.532284755761, 5523.392426833045, 5528.640638358494, 5716.056850619601, 9450.149486546245, 9462.101100395452, 9497.810043799085, 9506.667266645634, 9510.28672849539, 4990.2764099205415, 5040.017196646619, 5065.468125846733, 5075.923861142086, 5175.948240517622, 3286.983565082159, 3318.20363112856, 3425.72594192464, 3446.3451944130534, 3480.7215422766117, 2208.3485371815354, 2239.1603148819195, 2278.2709532949298, 2281.7490076091617, 2282.463621049052, 321.57230882925654, 340.9676080772323, 341.3156620974979, 341.54233327341484, 342.17706416069393, 439.8108813210286, 463.60593495529207, 465.2509459769768, 480.668338846202, 517.169942242695, 5713.457221563945, 6038.154658347835, 6093.75624974996, 6203.6587987660205, 6236.18929539157, 436.6223216917407, 441.06054104756663, 475.05701183151416, 504.8106959890041, 512.989410860604, 2908.6800451950267, 2949.616549848506, 3432.2963792422493, 3551.396262635358, 3561.857525698943, 52382.0, 52936.735316323175, 53048.73475632675, 54266.0, 54456.18315725267, 44684.0, 44810.0, 44910.55089449064, 45078.0, 45692.77153614277, 42337.364939525934, 42766.0, 42862.999999999374, 43012.78493607512, 43525.564744352785, 6483.578567393104, 6488.480921526361, 6492.285848556749, 6499.610023398422, 6667.599944003376, 30907.0, 31109.68890311068, 31159.0, 31624.051278461684, 31645.841770791918, 38420.231595368496, 39225.0, 39225.607743923334, 42910.356344655476, 42964.0, 6276.8430789228805, 6469.0, 6572.8356791080605, 6602.1747281589805, 6656.201255849329, 8431.662733490592, 8909.643614255358, 9009.324300677345, 9032.187103160748, 9153.038930912158, 8966.193042626195, 9029.187373136449, 9046.683366082156, 9088.272938164799, 9099.49952752605, 9215.400998935047, 9235.815283694423, 9241.075892410705, 9270.44377337362, 9356.111169438893, 7710.67008919214, 8751.168638979287, 8751.956240218758, 8761.211490965843, 8780.692675756318, 7741.142537132289, 8051.677932882853, 8093.838123237385, 8317.95841020791, 8444.071152173134, 7789.649465774167, 7850.214978502333, 7862.72480463181, 7940.642671079931, 8285.171482851667]}, "summary": {"suite": 5622.394418689067, "subtests": {"jquery.html": {"filtered": 5617.3928232801845, "value": 5617.3928232801845}, "dojo.html": {"filtered": 4609.7738345653715, "value": 4609.7738345653715}, "mootools.html": {"filtered": 3645.346509751667, "value": 3645.346509751667}, "ext.html": {"filtered": 16620.90574700013, "value": 16620.90574700013}, "prototype.html": {"filtered": 4091.288539933426, "value": 4091.288539933426}, "yui.html": {"filtered": 4920.532447130711, "value": 4920.532447130711}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0101"}, "testrun": {"date": 1449008977, "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": "20151201121222", "branch": "Mozilla-Aurora", "revision": "c69240d397da029511266b5c5024116472568dc4"}}, {"talos_counters": {}, "results": {"audio-dft": [186.0, 195.0, 197.0, 195.0, 188.0, 218.0, 197.0, 196.0, 189.0, 188.0], "ai-astar": [124.0, 130.0, 125.0, 132.0, 133.0, 136.0, 118.0, 125.0, 127.0, 124.0], "imaging-gaussian-blur": [140.0, 142.0, 150.0, 142.0, 142.0, 142.0, 142.0, 140.0, 136.0, 142.0], "audio-beat-detection": [180.0, 157.0, 192.0, 181.0, 153.0, 177.0, 151.0, 190.0, 187.0, 159.0], "json-stringify-tinderbox": [71.0, 72.0, 76.0, 80.0, 79.0, 80.0, 80.0, 80.0, 77.0, 77.0], "stanford-crypto-pbkdf2": [169.0, 175.0, 182.0, 182.0, 179.0, 171.0, 170.0, 171.0, 178.0, 165.0], "json-parse-financial": [62.0, 71.0, 73.0, 74.0, 73.0, 73.0, 73.0, 86.0, 72.0, 71.0], "stanford-crypto-sha256-iterative": [74.0, 78.0, 79.0, 80.0, 85.0, 85.0, 84.0, 83.0, 86.0, 81.0], "audio-fft": [92.0, 92.0, 93.0, 147.0, 82.0, 85.0, 87.0, 87.0, 145.0, 84.0], "imaging-darkroom": [147.0, 153.0, 153.0, 150.0, 146.0, 154.0, 153.0, 147.0, 153.0, 153.0], "stanford-crypto-ccm": [144.0, 157.0, 156.0, 144.0, 153.0, 149.0, 155.0, 145.0, 149.0, 153.0], "audio-oscillator": [114.0, 114.0, 157.0, 107.0, 110.0, 108.0, 156.0, 108.0, 107.0, 153.0], "stanford-crypto-aes": [88.0, 96.0, 100.0, 100.0, 101.0, 101.0, 100.0, 105.0, 99.0, 101.0], "imaging-desaturate": [122.0, 123.0, 124.0, 124.0, 124.0, 124.0, 123.0, 123.0, 124.0, 123.0]}, "summary": {"suite": 1789.1999999999998, "subtests": {"audio-fft": {"filtered": 99.4, "value": 99.4}, "stanford-crypto-pbkdf2": {"filtered": 174.2, "value": 174.2}, "audio-beat-detection": {"filtered": 172.7, "value": 172.7}, "stanford-crypto-ccm": {"filtered": 150.5, "value": 150.5}, "imaging-darkroom": {"filtered": 150.9, "value": 150.9}, "json-parse-financial": {"filtered": 72.8, "value": 72.8}, "audio-oscillator": {"filtered": 123.4, "value": 123.4}, "ai-astar": {"filtered": 127.4, "value": 127.4}, "audio-dft": {"filtered": 194.9, "value": 194.9}, "stanford-crypto-sha256-iterative": {"filtered": 81.5, "value": 81.5}, "json-stringify-tinderbox": {"filtered": 77.2, "value": 77.2}, "imaging-gaussian-blur": {"filtered": 141.8, "value": 141.8}, "stanford-crypto-aes": {"filtered": 99.1, "value": 99.1}, "imaging-desaturate": {"filtered": 123.4, "value": 123.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0101"}, "testrun": {"date": 1449008977, "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": "20151201121222", "branch": "Mozilla-Aurora", "revision": "c69240d397da029511266b5c5024116472568dc4"}}, {"talos_counters": {}, "results": {"DeltaBlue": [214.86892995272885], "Encrypt": [374.251497005988], "NavierStokes": [6673.333333333333], "Decrypt": [7049.295774647887], "Splay": [690.1311249137336], "Richards": [193.01293186643505], "RegExp": [34542.372881355936], "Earley": [823.7232289950576], "Boyer": [14955.223880597016], "RayTrace": [1210.3990326481257]}, "summary": {"suite": 17324.09978659032, "subtests": {"DeltaBlue": {"filtered": 307.7131719999999, "value": 307.7131719999999}, "Encrypt": {"filtered": 711.235632, "value": 711.235632}, "NavierStokes": {"filtered": 222.37762237762246, "value": 222.37762237762246}, "Decrypt": {"filtered": 37.75994205794205, "value": 37.75994205794205}, "Splay": {"filtered": 118.08045900000002, "value": 118.08045900000002}, "RegExp": {"filtered": 26.372971050049042, "value": 26.372971050049042}, "Richards": {"filtered": 182.899662, "value": 182.899662}, "Earley": {"filtered": 809.0860819999998, "value": 809.0860819999998}, "Boyer": {"filtered": 44.56389321357285, "value": 44.56389321357285}, "RayTrace": {"filtered": 611.3595434565436, "value": 611.3595434565436}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0101"}, "testrun": {"date": 1449008977, "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": "20151201121222", "branch": "Mozilla-Aurora", "revision": "c69240d397da029511266b5c5024116472568dc4"}}] 14:49:54 INFO - RETURN: dromaeo_css: 5622.39 14:49:54 INFO - RETURN: kraken: 1789.20 14:49:54 INFO - RETURN: v8_7: 17324.10 14:49:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17324.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1789.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5622.39"}}} 14:49:54 INFO - Return code: 0 14:49:54 INFO - # TBPL SUCCESS # 14:49:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:49:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:49:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:49:54 INFO - 2015-12-01 14:49:54.583 screenresolution[1656:9755] starting screenresolution argv=screenresolution get 14:49:54 INFO - 2015-12-01 14:49:54.586 screenresolution[1656:9755] Display 0: 1600x1200x32@60 14:49:54 INFO - 2015-12-01 14:49:54.592 screenresolution[1657:9758] starting screenresolution argv=screenresolution list 14:49:54 INFO - Available Modes on Display 0 14:49:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:49:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:49:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:49:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:49:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:49:54 INFO - Intel HD Graphics 3000: 14:49:54 INFO - Chipset Model: Intel HD Graphics 3000 14:49:54 INFO - Type: GPU 14:49:54 INFO - Bus: Built-In 14:49:54 INFO - VRAM (Total): 512 MB 14:49:54 INFO - VRAM (Dynamic, Max): 10 14:49:54 INFO - Vendor: Intel (0x8086) 14:49:54 INFO - Device ID: 0x0116 14:49:54 INFO - Revision ID: 0x0009 14:49:54 INFO - Displays: 14:49:54 INFO - Display: 14:49:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:49:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:49:54 INFO - Display Serial Number: 1600x1200 60 14:49:54 INFO - Main Display: Yes 14:49:54 INFO - Mirror: Off 14:49:54 INFO - Online: Yes 14:49:54 INFO - Rotation: Supported 14:49:54 INFO - Return code: 0 14:49:54 INFO - Running post-action listener: _resource_record_post_action 14:49:54 INFO - Running post-run listener: _resource_record_post_run 14:49:55 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 37356544; Write bytes: 680584192; Read time: 4148; Write time: 50252 14:49:55 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 340845056; Write bytes: 335140864; Read time: 37622; Write time: 6580 14:49:55 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 35288064; Write bytes: 335264768; Read time: 3542; Write time: 42473 14:49:55 INFO - Running post-run listener: _upload_blobber_files 14:49:55 INFO - Blob upload gear active. 14:49:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:49:55 INFO - Copying logs to upload dir... 14:49:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1320.125989 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-12-01 14:49:56.017850) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 14:49:56.021436) ========= 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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010366 build_url: 'https://queue.taskcluster.net/v1/task/eAEoZz4dTYSrPa27ZXGsWA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 14:49:56.042712) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:49:56.043044) ========= 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.7M7cvGpTsu/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.kSaB4IWAqL/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.005435 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:49:56.094647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 14:49:56.094955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 14:49:56.095377) ========= ========= Total master_lag: 0.20 =========