builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0090 starttime: 1447073047.81 results: success (0) buildid: 20151108234235 builduid: 2e9960703c094e9786bcaba2e36cb868 revision: 0789611bc5e98b2fd533e7dabff7041ac06873d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.815133) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.815810) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.816326) ========= 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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.007167 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.844352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.844807) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.862177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.862572) ========= 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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.006333 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.916983) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.917576) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.918272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:07.918583) ========= 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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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-11-09 04:44:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-09 04:44:08 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.216409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:08.155460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:08.156337) ========= 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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.021656 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:08.206921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-09 04:44:08.207376) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0789611bc5e98b2fd533e7dabff7041ac06873d9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0789611bc5e98b2fd533e7dabff7041ac06873d9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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-11-09 04:44:08,294 truncating revision to first 12 chars 2015-11-09 04:44:08,294 Setting DEBUG logging. 2015-11-09 04:44:08,294 attempt 1/10 2015-11-09 04:44:08,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0789611bc5e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-09 04:44:09,073 unpacking tar archive at: mozilla-inbound-0789611bc5e9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-09 04:44:09.281797) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:09.282480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:09.297193) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:09.297634) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 04:44:09.298212) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-11-09 04:44:09.298591) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 04:44:09 INFO - MultiFileLogger online at 20151109 04:44:09 in /builds/slave/test 04:44:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:44:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:09 INFO - {'append_to_log': False, 04:44:09 INFO - 'base_work_dir': '/builds/slave/test', 04:44:09 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:44:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:09 INFO - 'branch': 'Mozilla-Inbound', 04:44:09 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:09 INFO - 'config_files': ('talos/mac_config.py',), 04:44:09 INFO - 'default_actions': ('clobber', 04:44:09 INFO - 'read-buildbot-config', 04:44:09 INFO - 'download-and-extract', 04:44:09 INFO - 'populate-webroot', 04:44:09 INFO - 'create-virtualenv', 04:44:09 INFO - 'install', 04:44:09 INFO - 'run-tests'), 04:44:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:09 INFO - 'download_minidump_stackwalk': True, 04:44:09 INFO - 'download_symbols': 'ondemand', 04:44:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:09 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:09 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:09 INFO - 'installer_path': 'installer.exe', 04:44:09 INFO - 'log_level': 'info', 04:44:09 INFO - 'log_name': 'talos', 04:44:09 INFO - 'log_to_console': True, 04:44:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:44:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:44:09 INFO - 'opt_config_files': (), 04:44:09 INFO - 'pip_index': False, 04:44:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:44:09 INFO - 'cmd': ('bash', 04:44:09 INFO - '-c', 04:44:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:44:09 INFO - 'enabled': True, 04:44:09 INFO - 'halt_on_failure': False, 04:44:09 INFO - 'name': 'check_screen_resolution'},), 04:44:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:44:09 INFO - 'cmd': ('bash', 04:44:09 INFO - '-c', 04:44:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:44:09 INFO - 'enabled': True, 04:44:09 INFO - 'halt_on_failure': False, 04:44:09 INFO - 'name': 'check_screen_resolution'},), 04:44:09 INFO - 'run_cmd_checks_enabled': True, 04:44:09 INFO - 'sps_profile': False, 04:44:09 INFO - 'sps_profile_interval': 0, 04:44:09 INFO - 'suite': 'dromaeojs-e10s', 04:44:09 INFO - 'system_bits': '64', 04:44:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:09 INFO - 'title': 't-yosemite-r5-0090', 04:44:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:09 INFO - 'use_talos_json': True, 04:44:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:09 INFO - 'work_dir': 'build'} 04:44:09 INFO - ##### 04:44:09 INFO - ##### Running clobber step. 04:44:09 INFO - ##### 04:44:09 INFO - Running pre-action listener: _resource_record_pre_action 04:44:09 INFO - Running main action method: clobber 04:44:09 INFO - rmtree: /builds/slave/test/build 04:44:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:11 INFO - Running post-action listener: _resource_record_post_action 04:44:11 INFO - ##### 04:44:11 INFO - ##### Running read-buildbot-config step. 04:44:11 INFO - ##### 04:44:11 INFO - Running pre-action listener: _resource_record_pre_action 04:44:11 INFO - Running main action method: read_buildbot_config 04:44:11 INFO - Using buildbot properties: 04:44:11 INFO - { 04:44:11 INFO - "properties": { 04:44:11 INFO - "buildnumber": 132, 04:44:11 INFO - "product": "firefox", 04:44:11 INFO - "script_repo_revision": "production", 04:44:11 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 04:44:11 INFO - "repository": "", 04:44:11 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 04:44:11 INFO - "buildid": "20151108234235", 04:44:11 INFO - "slavename": "t-yosemite-r5-0090", 04:44:11 INFO - "pgo_build": "False", 04:44:11 INFO - "basedir": "/builds/slave/test", 04:44:11 INFO - "project": "", 04:44:11 INFO - "platform": "yosemite", 04:44:11 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:44:11 INFO - "slavebuilddir": "test", 04:44:11 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 04:44:11 INFO - "branch": "mozilla-inbound", 04:44:11 INFO - "repo_path": "integration/mozilla-inbound", 04:44:11 INFO - "stage_platform": "macosx64", 04:44:11 INFO - "builduid": "2e9960703c094e9786bcaba2e36cb868", 04:44:11 INFO - "revision": "0789611bc5e98b2fd533e7dabff7041ac06873d9" 04:44:11 INFO - }, 04:44:11 INFO - "sourcestamp": { 04:44:11 INFO - "repository": "", 04:44:11 INFO - "hasPatch": false, 04:44:11 INFO - "project": "", 04:44:11 INFO - "branch": "mozilla-inbound-macosx64-talos", 04:44:11 INFO - "changes": [ 04:44:11 INFO - { 04:44:11 INFO - "category": null, 04:44:11 INFO - "files": [ 04:44:11 INFO - { 04:44:11 INFO - "url": null, 04:44:11 INFO - "name": "https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:44:11 INFO - } 04:44:11 INFO - ], 04:44:11 INFO - "repository": "", 04:44:11 INFO - "rev": "0789611bc5e98b2fd533e7dabff7041ac06873d9", 04:44:11 INFO - "who": "cbook@mozilla.com", 04:44:11 INFO - "when": 1447058326, 04:44:11 INFO - "number": 6636295, 04:44:11 INFO - "comments": "Bug 1216030 - Part 18: Remove IsCurrent() check in assertion in CanThrottle. r=bbirtles\n\nThe behavior of unthrottling in case of not current animations there is the\nsame as on current trunk.\nThere are two cases to reach there I can think of:\n\na) 0s duration time and fill-forwards animation\nb) Calling pause() after fill-forwards animation finished.\n\nI can provide these automation tests once bug 1222326 is fixed.", 04:44:11 INFO - "project": "", 04:44:11 INFO - "at": "Mon 09 Nov 2015 00:38:46", 04:44:11 INFO - "branch": "mozilla-inbound-macosx64-talos", 04:44:11 INFO - "revlink": "", 04:44:11 INFO - "properties": [ 04:44:11 INFO - [ 04:44:11 INFO - "buildid", 04:44:11 INFO - "20151108234235", 04:44:11 INFO - "Change" 04:44:11 INFO - ], 04:44:11 INFO - [ 04:44:11 INFO - "builduid", 04:44:11 INFO - "2e9960703c094e9786bcaba2e36cb868", 04:44:11 INFO - "Change" 04:44:11 INFO - ], 04:44:11 INFO - [ 04:44:11 INFO - "pgo_build", 04:44:11 INFO - "False", 04:44:11 INFO - "Change" 04:44:11 INFO - ] 04:44:11 INFO - ], 04:44:11 INFO - "revision": "0789611bc5e98b2fd533e7dabff7041ac06873d9" 04:44:11 INFO - } 04:44:11 INFO - ], 04:44:11 INFO - "revision": "0789611bc5e98b2fd533e7dabff7041ac06873d9" 04:44:11 INFO - } 04:44:11 INFO - } 04:44:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 04:44:11 INFO - Running post-action listener: _resource_record_post_action 04:44:11 INFO - ##### 04:44:11 INFO - ##### Running download-and-extract step. 04:44:11 INFO - ##### 04:44:11 INFO - Running pre-action listener: _resource_record_pre_action 04:44:11 INFO - Running main action method: download_and_extract 04:44:11 INFO - mkdir: /builds/slave/test/build/tests 04:44:11 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')]} 04:44:11 INFO - https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/test_packages.json 04:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/test_packages.json 04:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:44:12 INFO - Downloaded 1149 bytes. 04:44:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:44:12 INFO - Using the following test package requirements: 04:44:12 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:44:12 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:44:12 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 04:44:12 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:44:12 INFO - u'jsshell-mac.zip'], 04:44:12 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:44:12 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 04:44:12 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:44:12 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:44:12 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 04:44:12 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:44:12 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 04:44:12 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:44:12 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 04:44:12 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:44:12 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:44:12 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 04:44:12 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:12 INFO - https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:44:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:44:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:44:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:44:13 INFO - Downloaded 17424605 bytes. 04:44:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 04:44:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:44:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:44:18 INFO - Return code: 0 04:44:18 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:18 INFO - https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:44:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:44:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:44:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:44:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:44:19 INFO - Downloaded 17424605 bytes. 04:44:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 04:44:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:44:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:44:25 INFO - Return code: 0 04:44: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')]} 04:44:25 INFO - https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:44:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:44:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:44:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:44:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:44:26 INFO - Downloaded 11131618 bytes. 04:44:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 04:44:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:44:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:44:26 INFO - Return code: 0 04:44: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')]} 04:44:26 INFO - https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 04:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 04:44:30 INFO - Downloaded 108648488 bytes. 04:44:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:44:30 INFO - mkdir: /builds/slave/test/properties 04:44:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:30 INFO - Contents: 04:44:30 INFO - build_url:https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:44:30 INFO - Running post-action listener: _resource_record_post_action 04:44:30 INFO - Running post-action listener: set_extra_try_arguments 04:44:30 INFO - ##### 04:44:30 INFO - ##### Running populate-webroot step. 04:44:30 INFO - ##### 04:44:30 INFO - Running pre-action listener: _resource_record_pre_action 04:44:30 INFO - Running main action method: populate_webroot 04:44:30 INFO - Guessing talos json url... 04:44:30 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')]} 04:44:30 INFO - https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 04:44:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 04:44:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 04:44:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 04:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 04:44:30 INFO - Downloaded 111 bytes. 04:44:30 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 04:44:30 INFO - Contents: 04:44:30 INFO - 20151108234235 04:44:30 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/0789611bc5e98b2fd533e7dabff7041ac06873d9 04:44:30 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')]} 04:44:30 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/0789611bc5/testing/talos/talos.json 04:44:30 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/0789611bc5/testing/talos/talos.json to /builds/slave/test/build/talos.json 04:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/0789611bc5/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 04:44:31 INFO - Downloaded 4206 bytes. 04:44:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:31 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:44:31 INFO - '../fennec_ids.txt'], 04:44:31 INFO - 'tests': ['tcheck2']}, 04:44:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:31 INFO - '--tppagecycles', 04:44:31 INFO - '7'], 04:44:31 INFO - 'tests': ['tsvgm']}}, 04:44:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:44:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:44:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:44:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:44:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:44:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:31 INFO - 'talos_options': ['--e10s'], 04:44:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:31 INFO - 'tests': ['damp', 'tps']}, 04:44:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:31 INFO - 'talos_options': ['--e10s'], 04:44:31 INFO - 'tests': ['damp', 'tps']}, 04:44:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:44:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:31 INFO - 'other': {'tests': ['a11yr', 04:44:31 INFO - 'ts_paint', 04:44:31 INFO - 'tpaint', 04:44:31 INFO - 'sessionrestore', 04:44:31 INFO - 'sessionrestore_no_auto_restore']}, 04:44:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:44:31 INFO - 'tests': ['a11yr', 04:44:31 INFO - 'ts_paint', 04:44:31 INFO - 'tpaint', 04:44:31 INFO - 'sessionrestore', 04:44:31 INFO - 'sessionrestore_no_auto_restore']}, 04:44:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:44:31 INFO - 'tests': ['a11yr', 04:44:31 INFO - 'ts_paint', 04:44:31 INFO - 'tpaint', 04:44:31 INFO - 'sessionrestore', 04:44:31 INFO - 'sessionrestore_no_auto_restore']}, 04:44:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:44:31 INFO - 'tests': ['a11yr', 04:44:31 INFO - 'ts_paint', 04:44:31 INFO - 'tpaint', 04:44:31 INFO - 'sessionrestore', 04:44:31 INFO - 'sessionrestore_no_auto_restore']}, 04:44:31 INFO - 'other_l64': {'tests': ['a11yr', 04:44:31 INFO - 'ts_paint', 04:44:31 INFO - 'tpaint', 04:44:31 INFO - 'sessionrestore', 04:44:31 INFO - 'sessionrestore_no_auto_restore']}, 04:44:31 INFO - 'other_nol64': {'tests': ['a11yr', 04:44:31 INFO - 'ts_paint', 04:44:31 INFO - 'tpaint', 04:44:31 INFO - 'sessionrestore', 04:44:31 INFO - 'sessionrestore_no_auto_restore']}, 04:44:31 INFO - 'svgr': {'tests': ['tsvgx', 04:44:31 INFO - 'tsvgr_opacity', 04:44:31 INFO - 'tart', 04:44:31 INFO - 'tscrollx', 04:44:31 INFO - 'cart']}, 04:44:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:44:31 INFO - 'tests': ['tsvgx', 04:44:31 INFO - 'tsvgr_opacity', 04:44:31 INFO - 'tart', 04:44:31 INFO - 'tscrollx', 04:44:31 INFO - 'cart']}, 04:44:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:31 INFO - 'tests': ['tp5o']}, 04:44:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:31 INFO - 'talos_options': ['--e10s'], 04:44:31 INFO - 'tests': ['tp5o']}, 04:44:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:31 INFO - 'talos_options': ['--xperf_path', 04:44:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:31 INFO - 'tests': ['tp5n']}, 04:44:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:31 INFO - 'talos_options': ['--e10s', 04:44:31 INFO - '--xperf_path', 04:44:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:31 INFO - 'tests': ['tp5n']}}, 04:44:31 INFO - 'talos.zip': {'path': '', 04:44:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:31 INFO - Running post-action listener: _resource_record_post_action 04:44:31 INFO - ##### 04:44:31 INFO - ##### Running create-virtualenv step. 04:44:31 INFO - ##### 04:44:31 INFO - Running pre-action listener: _resource_record_pre_action 04:44:31 INFO - Running main action method: create_virtualenv 04:44:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:44:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:31 INFO - Using real prefix '/tools/python27' 04:44:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:37 INFO - Installing pip.................done. 04:44:37 INFO - Return code: 0 04:44:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10fde4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8932ce4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd999f0>, '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 0x10faf8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd63990>, '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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 04:44:37 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 04:44:37 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 04:44:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kdC7DzSpIJ/Render', 04:44:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:37 INFO - 'HOME': '/Users/cltbld', 04:44:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:37 INFO - 'LOGNAME': 'cltbld', 04:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:37 INFO - 'MOZ_NO_REMOTE': '1', 04:44:37 INFO - 'NO_EM_RESTART': '1', 04:44:37 INFO - 'PAGER': '/bin/cat', 04:44:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:37 INFO - 'PWD': '/builds/slave/test', 04:44:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:37 INFO - 'SHELL': '/bin/bash', 04:44:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FjmUh6gHYN/Listeners', 04:44:37 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 04:44:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:37 INFO - 'USER': 'cltbld', 04:44:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:37 INFO - 'XPC_FLAGS': '0x0', 04:44:37 INFO - 'XPC_SERVICE_NAME': '0', 04:44:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:37 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 04:44:37 INFO - Cleaning up... 04:44:37 INFO - Return code: 0 04:44:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10fde4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8932ce4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd999f0>, '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 0x10faf8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd63990>, '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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 04:44:37 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 04:44:37 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 04:44:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kdC7DzSpIJ/Render', 04:44:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:37 INFO - 'HOME': '/Users/cltbld', 04:44:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:37 INFO - 'LOGNAME': 'cltbld', 04:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:37 INFO - 'MOZ_NO_REMOTE': '1', 04:44:37 INFO - 'NO_EM_RESTART': '1', 04:44:37 INFO - 'PAGER': '/bin/cat', 04:44:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:37 INFO - 'PWD': '/builds/slave/test', 04:44:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:37 INFO - 'SHELL': '/bin/bash', 04:44:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FjmUh6gHYN/Listeners', 04:44:37 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 04:44:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:37 INFO - 'USER': 'cltbld', 04:44:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:37 INFO - 'XPC_FLAGS': '0x0', 04:44:37 INFO - 'XPC_SERVICE_NAME': '0', 04:44:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:37 INFO - Downloading/unpacking psutil>=0.7.1 04:44:37 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 04:44:37 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 04:44:37 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 04:44:37 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 04:44:37 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 04:44:37 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 04:44:40 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:44:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:40 INFO - Installing collected packages: psutil 04:44:40 INFO - Running setup.py install for psutil 04:44:41 INFO - building 'psutil._psutil_osx' extension 04:44:41 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 04:44:41 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 04:44:41 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 04:44:41 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 04:44:41 INFO - building 'psutil._psutil_posix' extension 04:44:41 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 04:44:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:44:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:44:41 INFO - ^ 04:44:41 INFO - 1 warning generated. 04:44:41 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 04:44:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:41 INFO - Successfully installed psutil 04:44:41 INFO - Cleaning up... 04:44:42 INFO - Return code: 0 04:44:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:42 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 0x10fde4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8932ce4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd999f0>, '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 0x10faf8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd63990>, '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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 04:44:42 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 04:44:42 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 04:44:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kdC7DzSpIJ/Render', 04:44:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:42 INFO - 'HOME': '/Users/cltbld', 04:44:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:42 INFO - 'LOGNAME': 'cltbld', 04:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:42 INFO - 'MOZ_NO_REMOTE': '1', 04:44:42 INFO - 'NO_EM_RESTART': '1', 04:44:42 INFO - 'PAGER': '/bin/cat', 04:44:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:42 INFO - 'PWD': '/builds/slave/test', 04:44:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:42 INFO - 'SHELL': '/bin/bash', 04:44:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FjmUh6gHYN/Listeners', 04:44:42 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 04:44:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:42 INFO - 'USER': 'cltbld', 04:44:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:42 INFO - 'XPC_FLAGS': '0x0', 04:44:42 INFO - 'XPC_SERVICE_NAME': '0', 04:44:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:44:42 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 04:44:42 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 04:44:42 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 04:44:42 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 04:44:42 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 04:44:42 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 04:44:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:44:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:44:45 INFO - Installing collected packages: mozsystemmonitor 04:44:45 INFO - Running setup.py install for mozsystemmonitor 04:44:45 INFO - Successfully installed mozsystemmonitor 04:44:45 INFO - Cleaning up... 04:44:45 INFO - Return code: 0 04:44:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:45 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')]} 04:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:45 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')]} 04:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:45 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 0x10fde4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8932ce4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd999f0>, '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 0x10faf8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd63990>, '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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 04:44:45 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 04:44:45 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 04:44:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kdC7DzSpIJ/Render', 04:44:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:45 INFO - 'HOME': '/Users/cltbld', 04:44:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:45 INFO - 'LOGNAME': 'cltbld', 04:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:45 INFO - 'MOZ_NO_REMOTE': '1', 04:44:45 INFO - 'NO_EM_RESTART': '1', 04:44:45 INFO - 'PAGER': '/bin/cat', 04:44:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:45 INFO - 'PWD': '/builds/slave/test', 04:44:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:45 INFO - 'SHELL': '/bin/bash', 04:44:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FjmUh6gHYN/Listeners', 04:44:45 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 04:44:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:45 INFO - 'USER': 'cltbld', 04:44:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:45 INFO - 'XPC_FLAGS': '0x0', 04:44:45 INFO - 'XPC_SERVICE_NAME': '0', 04:44:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:48 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 04:44:48 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 04:44:48 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 04:44:48 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 04:44:48 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 04:44:48 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 04:44:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44:49 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 04:44:49 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 04:44:49 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 04:44:49 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 04:44:49 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 04:44:49 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 04:44:49 INFO - Downloading docopt-0.6.1.tar.gz 04:44:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:50 INFO - Running setup.py install for blobuploader 04:44:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:50 INFO - Running setup.py install for requests 04:44:50 INFO - Running setup.py install for docopt 04:44:51 INFO - Successfully installed blobuploader requests docopt 04:44:51 INFO - Cleaning up... 04:44:51 INFO - Return code: 0 04:44:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:51 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')]} 04:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:51 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')]} 04:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:51 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 0x10fde4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8932ce4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd999f0>, '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 0x10faf8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd63990>, '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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 04:44:51 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 04:44:51 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 04:44:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kdC7DzSpIJ/Render', 04:44:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:51 INFO - 'HOME': '/Users/cltbld', 04:44:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:51 INFO - 'LOGNAME': 'cltbld', 04:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:51 INFO - 'MOZ_NO_REMOTE': '1', 04:44:51 INFO - 'NO_EM_RESTART': '1', 04:44:51 INFO - 'PAGER': '/bin/cat', 04:44:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:51 INFO - 'PWD': '/builds/slave/test', 04:44:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:51 INFO - 'SHELL': '/bin/bash', 04:44:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FjmUh6gHYN/Listeners', 04:44:51 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 04:44:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:51 INFO - 'USER': 'cltbld', 04:44:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:51 INFO - 'XPC_FLAGS': '0x0', 04:44:51 INFO - 'XPC_SERVICE_NAME': '0', 04:44:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:51 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-bMd0pC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:51 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-AzH0s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:51 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-RmFuAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:52 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-FkuCSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:52 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-FoFV9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:52 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-OWbh_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:52 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Dh66_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:52 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-CfLr9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:52 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-QWP4yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:52 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-zqzSZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:53 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-emp8So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:53 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-0zfrPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:53 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-txuzgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:53 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-ozG97S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:53 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-BvEACf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:53 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Pw3kXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:53 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-KyBLal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:53 INFO - Running setup.py install for manifestparser 04:44:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Running setup.py install for mozcrash 04:44:54 INFO - Running setup.py install for mozdebug 04:44:54 INFO - Running setup.py install for mozdevice 04:44:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Running setup.py install for mozfile 04:44:54 INFO - Running setup.py install for mozhttpd 04:44:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Running setup.py install for mozinfo 04:44:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Running setup.py install for mozInstall 04:44:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Running setup.py install for mozleak 04:44:55 INFO - Running setup.py install for mozlog 04:44:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Running setup.py install for moznetwork 04:44:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:44:56 INFO - Running setup.py install for mozprocess 04:44:56 INFO - Running setup.py install for mozprofile 04:44:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:56 INFO - Running setup.py install for mozrunner 04:44:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:56 INFO - Running setup.py install for mozscreenshot 04:44:56 INFO - Running setup.py install for moztest 04:44:57 INFO - Running setup.py install for mozversion 04:44:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:57 INFO - Cleaning up... 04:44:57 INFO - Return code: 0 04:44:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:57 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 0x10fde4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8932ce4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd999f0>, '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 0x10faf8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd63990>, '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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 04:44:57 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 04:44:57 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 04:44:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kdC7DzSpIJ/Render', 04:44:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:57 INFO - 'HOME': '/Users/cltbld', 04:44:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:57 INFO - 'LOGNAME': 'cltbld', 04:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:57 INFO - 'MOZ_NO_REMOTE': '1', 04:44:57 INFO - 'NO_EM_RESTART': '1', 04:44:57 INFO - 'PAGER': '/bin/cat', 04:44:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:57 INFO - 'PWD': '/builds/slave/test', 04:44:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:57 INFO - 'SHELL': '/bin/bash', 04:44:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FjmUh6gHYN/Listeners', 04:44:57 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 04:44:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:57 INFO - 'USER': 'cltbld', 04:44:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:57 INFO - 'XPC_FLAGS': '0x0', 04:44:57 INFO - 'XPC_SERVICE_NAME': '0', 04:44:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:57 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-yxGHa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:57 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)) 04:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:57 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-GDD9Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:58 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)) 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:58 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-DQACFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:58 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)) 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:58 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-rVYgfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:58 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-TKUoYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:58 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)) 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:58 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-3rhpZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:58 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)) 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:58 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Xz6x1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:58 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-42fcaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:58 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)) 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:58 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-MorAcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:59 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)) 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:59 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-oZciUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:59 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)) 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:59 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-G9j0vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:59 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)) 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:59 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-aOgpXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:59 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)) 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:59 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-YCRJ_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:59 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)) 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:59 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-76RC43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:59 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)) 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:59 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-vClCjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:59 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)) 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:59 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-fLw7Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:00 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)) 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:00 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-H_LGr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:00 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)) 04:45:00 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)) 04:45:00 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)) 04:45:00 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)) 04:45:00 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:00 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:02 INFO - Downloading blessings-1.5.1.tar.gz 04:45:02 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 04:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:03 INFO - Installing collected packages: blessings 04:45:03 INFO - Running setup.py install for blessings 04:45:03 INFO - Successfully installed blessings 04:45:03 INFO - Cleaning up... 04:45:03 INFO - Return code: 0 04:45:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:03 INFO - Reading from file tmpfile_stdout 04:45:03 INFO - Current package versions: 04:45:03 INFO - blessings == 1.5.1 04:45:03 INFO - blobuploader == 1.2.4 04:45:03 INFO - docopt == 0.6.1 04:45:03 INFO - manifestparser == 1.1 04:45:03 INFO - mozInstall == 1.12 04:45:03 INFO - mozcrash == 0.16 04:45:03 INFO - mozdebug == 0.1 04:45:03 INFO - mozdevice == 0.47 04:45:03 INFO - mozfile == 1.2 04:45:03 INFO - mozhttpd == 0.7 04:45:03 INFO - mozinfo == 0.9 04:45:03 INFO - mozleak == 0.1 04:45:03 INFO - mozlog == 3.0 04:45:03 INFO - moznetwork == 0.27 04:45:03 INFO - mozprocess == 0.22 04:45:03 INFO - mozprofile == 0.27 04:45:03 INFO - mozrunner == 6.11 04:45:03 INFO - mozscreenshot == 0.1 04:45:03 INFO - mozsystemmonitor == 0.0 04:45:03 INFO - moztest == 0.7 04:45:03 INFO - mozversion == 1.4 04:45:03 INFO - psutil == 3.1.1 04:45:03 INFO - requests == 1.2.3 04:45:03 INFO - wsgiref == 0.1.2 04:45:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:03 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')]} 04:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:03 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')]} 04:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:03 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 0x10fde4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8932ce4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd999f0>, '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 0x10faf8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd63990>, '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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 04:45:03 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 04:45:03 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 04:45:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kdC7DzSpIJ/Render', 04:45:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:03 INFO - 'HOME': '/Users/cltbld', 04:45:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:03 INFO - 'LOGNAME': 'cltbld', 04:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:03 INFO - 'MOZ_NO_REMOTE': '1', 04:45:03 INFO - 'NO_EM_RESTART': '1', 04:45:03 INFO - 'PAGER': '/bin/cat', 04:45:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:03 INFO - 'PWD': '/builds/slave/test', 04:45:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:03 INFO - 'SHELL': '/bin/bash', 04:45:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FjmUh6gHYN/Listeners', 04:45:03 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 04:45:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:03 INFO - 'USER': 'cltbld', 04:45:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:03 INFO - 'XPC_FLAGS': '0x0', 04:45:03 INFO - 'XPC_SERVICE_NAME': '0', 04:45:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:04 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)) 04:45:04 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)) 04:45:04 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)) 04:45:04 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)) 04:45:04 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)) 04:45:04 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)) 04:45:04 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)) 04:45:04 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)) 04:45:04 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)) 04:45:04 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)) 04:45:04 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)) 04:45:04 INFO - Cleaning up... 04:45:04 INFO - Return code: 0 04:45:04 INFO - Running post-action listener: _resource_record_post_action 04:45:04 INFO - Running post-action listener: _start_resource_monitoring 04:45:04 INFO - Starting resource monitoring. 04:45:04 INFO - ##### 04:45:04 INFO - ##### Running install step. 04:45:04 INFO - ##### 04:45:04 INFO - Running pre-action listener: _resource_record_pre_action 04:45:04 INFO - Running main action method: install 04:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:04 INFO - Reading from file tmpfile_stdout 04:45:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:04 INFO - Reading from file tmpfile_stdout 04:45:04 INFO - Output received: 04:45:04 INFO - Usage: mozinstall [options] installer 04:45:04 INFO - Options: 04:45:04 INFO - -h, --help show this help message and exit 04:45:04 INFO - -d DEST, --destination=DEST 04:45:04 INFO - Directory to install application into. [default: 04:45:04 INFO - "/builds/slave/test"] 04:45:04 INFO - --app=APP Application being installed. [default: firefox] 04:45:04 INFO - mkdir: /builds/slave/test/build/application 04:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:45:46 INFO - Reading from file tmpfile_stdout 04:45:46 INFO - Output received: 04:45:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:45:46 INFO - Running post-action listener: _resource_record_post_action 04:45:46 INFO - ##### 04:45:46 INFO - ##### Running run-tests step. 04:45:46 INFO - ##### 04:45:46 INFO - Running pre-action listener: _resource_record_pre_action 04:45:46 INFO - Running main action method: run_tests 04:45:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:45:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:45:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:45:46 INFO - 2015-11-09 04:45:46.823 screenresolution[2494:69128] starting screenresolution argv=screenresolution get 04:45:46 INFO - 2015-11-09 04:45:46.827 screenresolution[2494:69128] Display 0: 1600x1200x32@60 04:45:46 INFO - 2015-11-09 04:45:46.835 screenresolution[2495:69130] starting screenresolution argv=screenresolution list 04:45:46 INFO - Available Modes on Display 0 04:45:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:45:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:45:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:45:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:45:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:45:47 INFO - Intel HD Graphics 3000: 04:45:47 INFO - Chipset Model: Intel HD Graphics 3000 04:45:47 INFO - Type: GPU 04:45:47 INFO - Bus: Built-In 04:45:47 INFO - VRAM (Total): 512 MB 04:45:47 INFO - VRAM (Dynamic, Max): 10 04:45:47 INFO - Vendor: Intel (0x8086) 04:45:47 INFO - Device ID: 0x0116 04:45:47 INFO - Revision ID: 0x0009 04:45:47 INFO - Displays: 04:45:47 INFO - Display: 04:45:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:45:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:45:47 INFO - Display Serial Number: 1600x1200 60 04:45:47 INFO - Main Display: Yes 04:45:47 INFO - Mirror: Off 04:45:47 INFO - Online: Yes 04:45:47 INFO - Rotation: Supported 04:45:47 INFO - Return code: 0 04:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:47 INFO - Python 2.7.3 04:45:47 INFO - Return code: 0 04:45:47 INFO - grabbing minidump binary from tooltool 04:45: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')]} 04:45:47 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 0x10fd999f0>, '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 0x10faf8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd63990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:47 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 04:45:47 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 04:45:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:47 INFO - Return code: 0 04:45:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:45:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:45:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0090', '--webServer', 'localhost'] in /builds/slave/test/build 04:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0090 --webServer localhost 04:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kdC7DzSpIJ/Render', 04:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:47 INFO - 'HOME': '/Users/cltbld', 04:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:47 INFO - 'LOGNAME': 'cltbld', 04:45:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:47 INFO - 'MOZ_NO_REMOTE': '1', 04:45:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:47 INFO - 'NO_EM_RESTART': '1', 04:45:47 INFO - 'PAGER': '/bin/cat', 04:45:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:47 INFO - 'PWD': '/builds/slave/test', 04:45:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:47 INFO - 'SHELL': '/bin/bash', 04:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FjmUh6gHYN/Listeners', 04:45:47 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 04:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:47 INFO - 'USER': 'cltbld', 04:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:47 INFO - 'XPC_FLAGS': '0x0', 04:45:47 INFO - 'XPC_SERVICE_NAME': '0', 04:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:45:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0090', '--webServer', 'localhost'] with output_timeout 3600 04:45:47 INFO - mozversion INFO | application_buildid: 20151108234235 04:45:47 INFO - mozversion INFO | application_changeset: 0789611bc5e98b2fd533e7dabff7041ac06873d9 04:45:47 INFO - mozversion INFO | application_display_name: Nightly 04:45:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:47 INFO - mozversion INFO | application_name: Firefox 04:45:47 INFO - mozversion INFO | application_remotingname: firefox 04:45:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:45:47 INFO - mozversion INFO | application_vendor: Mozilla 04:45:47 INFO - mozversion INFO | application_version: 45.0a1 04:45:47 INFO - mozversion INFO | platform_buildid: 20151108234235 04:45:47 INFO - mozversion INFO | platform_changeset: 0789611bc5e98b2fd533e7dabff7041ac06873d9 04:45:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:45:47 INFO - mozversion INFO | platform_version: 45.0a1 04:45:47 INFO - 2015-11-09 04:45:47,516 DEBUG : using testdate: 1447073147 04:45:47 INFO - 2015-11-09 04:45:47,516 DEBUG : actual date: 1447073147 04:45:47 INFO - 2015-11-09 04:45:47,600 INFO : starting webserver on 'localhost:53739' 04:45:47 INFO - 2015-11-09 04:45:47,601 INFO : Starting test suite t-yosemite-r5-0090.e 04:45:47 INFO - 2015-11-09 04:45:47,602 INFO : Starting test dromaeo_css 04:45:47 INFO - 2015-11-09 04:45:47,602 DEBUG : operating with platform_type : mac_ 04:45:47 INFO - 2015-11-09 04:45:47,603 INFO : Initialising browser for dromaeo_css test... 04:45:47 INFO - 2015-11-09 04:45:47,618 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpmAggwg/profile http://localhost:53739/getInfo.html 04:45:51 INFO - 2015-11-09 04:45:51,313 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:45:51 INFO - 2015-11-09 04:45:51,313 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:45:51 INFO - 2015-11-09 04:45:51,313 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:45:51 INFO - 2015-11-09 04:45:51,313 DEBUG : BROWSER_OUTPUT: __metrics 04:45:52 INFO - 2015-11-09 04:45:52,071 INFO : Browser initialized. 04:45:52 INFO - 2015-11-09 04:45:52,071 INFO : Running cycle 1/1 for dromaeo_css test... 04:45:52 INFO - 2015-11-09 04:45:52,072 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpmAggwg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:46:04 INFO - 2015-11-09 04:46:04,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 239648768 04:46:04 INFO - 2015-11-09 04:46:04,457 DEBUG : BROWSER_OUTPUT: 04:46:54 INFO - 2015-11-09 04:46:54,208 DEBUG : BROWSER_OUTPUT: 1447073214207 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] 04:49:03 INFO - 2015-11-09 04:49:03,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53739/tests/dromaeo/cssquery-ext.html) 04:49:04 INFO - 2015-11-09 04:49:04,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 266846208 04:49:04 INFO - 2015-11-09 04:49:04,989 DEBUG : BROWSER_OUTPUT: 04:52:07 INFO - 2015-11-09 04:52:07,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/dromaeo/cssquery-ext.html (next: http://localhost:53739/tests/dromaeo/cssquery-jquery.html) 04:52:07 INFO - 2015-11-09 04:52:07,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 273027072 04:52:07 INFO - 2015-11-09 04:52:07,625 DEBUG : BROWSER_OUTPUT: 04:55:09 INFO - 2015-11-09 04:55:09,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53739/tests/dromaeo/cssquery-mootools.html) 04:55:10 INFO - 2015-11-09 04:55:10,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 273063936 04:55:10 INFO - 2015-11-09 04:55:10,064 DEBUG : BROWSER_OUTPUT: 04:58:11 INFO - 2015-11-09 04:58:11,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53739/tests/dromaeo/cssquery-prototype.html) 04:58:12 INFO - 2015-11-09 04:58:12,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 278315008 04:58:12 INFO - 2015-11-09 04:58:12,441 DEBUG : BROWSER_OUTPUT: 05:01:15 INFO - 2015-11-09 05:01:15,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53739/tests/dromaeo/cssquery-yui.html) 05:01:15 INFO - 2015-11-09 05:01:15,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 283467776 05:01:15 INFO - 2015-11-09 05:01:15,792 DEBUG : BROWSER_OUTPUT: 05:04:18 INFO - 2015-11-09 05:04:18,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/dromaeo/cssquery-yui.html (next: http://localhost:53739/tests/dromaeo/cssquery-dojo.html) 05:04:18 INFO - 2015-11-09 05:04:18,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 287535104 05:04:18 INFO - 2015-11-09 05:04:18,391 DEBUG : BROWSER_OUTPUT: 05:04:18 INFO - 2015-11-09 05:04:18,391 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:04:18 INFO - 2015-11-09 05:04:18,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:04:18 INFO - 2015-11-09 05:04:18,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:04:18 INFO - 2015-11-09 05:04:18,391 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:04:18 INFO - 2015-11-09 05:04:18,392 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2562.7052888917774;2622.4886147201305;2648.602709593562;2663.613776002479;2694.8517831519257;4481.932771008429;4503.166914120886;4580.038191979684;4620.97689511552;4639.280911458721;4434.667399945001;4444.355568442582;4514;4541.341505481703;4597.931031034537;4194.349875769245;4195.790210489478;4319.028218650794;4333.566643335673;4339.522652508237;126.87275770021982;4248.490181178247;4264.9147017059795;4340.392345071693;4346.717463364871;4131.462909821704;4156.771377574232;4174.165166966589;4207.663386929038;4228.640565551932;4260.062786187065;4275.294576394891;4303.849365272201;4334.956650433487;4350.369196466526;3996.8800935971967;4195.160967806451;4279.465066866642;4342.934855977162;4375.993521490075;4346.47842258931;4418.9337159942625;4469.061497085616;4518.751468669222;4606.355110284563;4726.196546587088;4767.356406885096;4793.952060479385;4805.303231031481;4813.590844778198;4729.266963620645;4734.218853889104;4774.212254977924;4830.1064303103685;4851;4518.751468669222;4560.429946256718;4591.104734576759;4593.28804035375;4616.330632058366;4906.1414252505665;4974.975125124423;4983.50164983506;5015.874603134951;5065.6200784941275;4498.460184777848;4588.908221835544;4608.792604332813;4756.524347565285;4758.738269395217;4866.732329721828;4880.731559764247;4978.925316120261;4981.402231732215;4995.775190116454;4797.328374027639;4855.101806165871;4860.586850117779;4889;4914.336564563738;4677.766111694402;4753.572178503951;4794.017226468565;4850.587700045536;4929.531694489017;3715.256948610289;3761.5674197467642;3778.5654649715084;3784.243151369737;3815.103450689086;3227.370662720794;3418.8803391881165;3456.879009234665;3466.3240668069484;3492.965070349264;4456.821727130943;4519.231730605805;4526.298423744325;4552.408186935743;4553.2942393929;4878.292647566083;4924.8768780780765;4982.402111746614;4985.326980857611;4993.251012348104;4411.911761764747;4479.731216126977;4590.997829186252;4619.930701039487;4688.0858232644305;4263;4329.718568293051;4348.543402942709;4360.193364227564;4381.21138195128;4948.455669876311;4989.151844186497;5034.848954531297;5045.949540504622;5086.7710953007945;4711.764411779466;4793.736344501086;4863.610911127031;4895.877603059952;4948.1835497142565;4971.975140124277;5013.222950442687;5032.899342013213;5034.647574669884;5056.0140772549;4812.326274321527;4856.320115183807;4880.341153944172;4889.364382630235;4892.168331383602;4735.621150308036;4879.243717223836;4927;4927.5565199130815;4966.453690094159;4591.540845915381;4707.24684050564;4728.527147285244;4728.905421891612;4841.854744357534;4710.222813235778;4734.834280800155;4751.667383283137;4760.690555113906;4768.3085952537385;4597.563231493003;4632.5830675239395;4659.534046595313;4675.719456832601;4713.986492904042;4534.501204867528;4648.511906249795;4667.649926255476;4737;4801.927971080507;4735.550122738335;4740;4749.857504274877;4778.04439112172;4815.374001379798 05:04:18 INFO - 2015-11-09 05:04:18,396 DEBUG : BROWSER_OUTPUT: |1;ext.html;459.74943655707636;472.4566748239524;473.3704173449313;486.5110563883298;499.59283184204895;32889;33310.33379332415;33426.33147337052;33470.99587012391;33732.32535349292;35182.29635407297;36088.09779755508;36172.45741313882;36280.81859590698;36320.45519317212;7604.467687261894;7751.263629955173;7853.607319633996;7877.094134174557;7939.96030019852;7648.541087534766;7796.259355361231;7819;7865.134835168127;7867.0952840423515;7693.653785579662;7758.418118641096;7781.182975787546;7868.606569671522;7902.367810575169;7811.648475818602;7839.608019599054;7847.9215207847765;7848.803779905491;7975.561344126071;7544.094708634999;7665.655045522909;7702.152763196044;7762;7774.611269436506;32559.348813023607;33176.33647327064;33325;33398.16504587381;33526.3294734104;2600.466904284636;2625.5799072148557;2641;2650.8144429889917;3044.2845931206148;22397.21609743651;22519.21182758612;22664.54670906589;23209;23740.69426181559;1943.5141214696325;2009.2867032203649;2011.8189362957405;2018.7678416982087;2124.6281900667477;230492;232502;235027;235355;237620.81189594115;42625.360619590734;44846.77576612096;52166.21750673743;55007.72496137494;56648.43351566514;52323;52568.474315257125;52949.47050529523;53150.734246328524;53300.73349633227;11429.771404571862;11517.712057198469;11526.654200373834;11612.88387116135;11632.476538555786;8560.743177704679;8627.913720862836;8664.740057798275;8706.564671766386;8706.825863482694;17334.30662773475;17646;17746.645067098587;17851.46445606634;17993.10034498296;7113.386117472202;7388.493019258248;7422.406207503387;7478.962605186939;7494.1381741099385;770.6146926536732;790.9802254943558;848.804774901776;906.4787747045475;913.48388160689;23375;23723;23795;23812.715006924886;23888.64167037461;857.6183598298697;877.2061284537376;901.9819603607891;940.3182692547985;1006.8389057750725;12228.510859565518;12399.194052386567;13526.526571569948;14089.647758806112;14268.286585670676;599702;600439;615577;615800;616685;48667.75666121647;48692;48709.26936095962;48925.51074489281;49397.50602493929;1116.240956149826;1130.3387518301722;1141.2467771270922;1145.0782120393164;1154.8671902731126;24659.753402466464;25319.620205697298;25351.492970140123;25465.363365916;25677.743222568282;41201.79399102985;41219.1756164869;41277.174456511304;41290;41430.585694142675;239002;239948;241930;242149;243162;24688.50622987566;36635.81682091572;38839;38889.22221555497;39167.60832391639;35747.46378804268;36064.63935360613;36340.81829590835;37289.25421491501;37632.623673762915;28811.85594072016;30366.696333036387;30450.69549304567;30854.382912341178;30917.381652367276;29487;29508.262293442836;29558.113256602337;29657.110286691433;29704.702952970194;29415.26461838471;29896.701032990262;30278.243043924078;30594.388112238077;31304.373912521165;25522.872385637955;29010.419791604472;29030.7096929028;29319.12042638639;29471.11586652404;20428.489287767923;20464.181432742524;20494.590108197455;20655.896720516303;20767.273145440442 05:04:18 INFO - 2015-11-09 05:04:18,396 DEBUG : BROWSER_OUTPUT: |2;jquery.html;282.3491851282794;285.0848775430867;285.1005078975831;288.34401736050484;293.545482136016;13249.933750331234;14456.710865782678;14821.851781482195;15069.47256846012;15976.600584985381;15315.77026344603;15385;15494.84505154948;15505.302261398236;15574.84425155748;4347.891302717426;4550.476695180064;4561.361409402686;4561.429821272341;4568.725876447407;4529.750863702495;4545.636349092065;4547.8635640930825;4586.266197408415;4596.402467679214;3307.3881331953544;4473.396091527651;4542.364069030338;4926.605871530269;4937;4842.806287748486;4912.091263116335;4942.629302802305;4988.451270360258;5009.699418034911;4217.746935183899;4328.6753493487795;4328.675349348811;4343.956560434387;4380.277254253045;17702.822971770376;17913.641727165515;17989.550261243443;18124.184411701506;18460.16929238174;1721.122227663888;1730.3684155283356;1742.4337090445656;1817.972730409045;1824.8540116790625;11056.170787190913;11113;11372.545098196062;11394.71513212168;11519.654410367702;1339.5110784563662;1428.9428422863073;1442.5383877159313;1443.4154167562153;1462.5977856089555;43795.343069853974;45047.32429013567;45148.097038059386;46338.53661463376;48853.511464885254;5250.7637156328055;5333.973330133324;5350.438203988525;5376.542993845489;5378.1663842104535;6183.505319574513;6189.50483961282;6196.225471816023;6199.535034872402;6257.030160325156;4212.410262563244;4230.259704551691;4296.119295544406;4307.203167414038;4352.39066530686;4381.298992161239;4450.532694067077;4454.309582014793;4457.2199865023495;4469.351943968107;2425.5997760369696;2430.526047420736;2465.654808326836;2475.740047295008;2479.1075212923333;846.7205822078822;852.1691350932791;860.2257967828879;867.7179916527153;936.9880529028633;346.210639741385;347.24820763047717;349.67480243373905;384.13186199190034;385.72227995842945;8270.131636178116;8273.958630206811;8500.914990850013;8591.097934716765;8709.259712924346;344.37839699342925;345.34557014457465;355.5999500561868;362.2718336144369;375.2569911575097;4528.818847246073;4782.593479554277;5112.565431938327;5172.7641772698;5357.330333708286;467819;471254;478911;482567;494550;54152.45847541553;55875.720621396635;56334.718326408925;57139;58045.709771451715;431.82079437033906;437.536211615682;437.63676148796424;441.1750027448692;443.6982851660837;9032.36773425854;9062.320325975446;9131.680391186277;9217.723468295962;9233.861492077489;27284.863575681993;28399.432011359244;28942.13173604795;29601.25996850096;29787.404251915275;38880.6111938877;38933.8053309743;39298.80350598229;39318.213635726555;39471.605283946796;4989.950100498949;5145.948540514547;5153.768080436314;5171.379434467888;5230.921536176884;9203.76990575241;9705.417674939245;9749.658761943581;9798.80402391934;9810.068043535854;7093.787186384417;8314.085450600309;8314.750557483285;8363.916360836314;8427.578621069044;7536.171021187774;8080.71717489885;8222.259996600334;8344.499330040217;8429.409941304295;7290.270972902667;7596.278353556403;7712.8457430852195;7731.536107833548;8244.752657420288;11538.538458461568;12068.715605959758;12491;12614.432350544064;12759.234445933274;12185.329806860707;12382.752344953231;12770.106092573431;13016.47934082664;13044.54344097952 05:04:18 INFO - 2015-11-09 05:04:18,400 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1461.6638173220158;1465.7654775235965;1511.1084460168506;1511.807878576065;1517.8937474376794;5786.71066446677;5868.911966320498;6388.872222555552;6464.838379040526;6468.159139311889;6255.186825712651;6337.651429171394;6436.742530298794;6482.5786323888915;6526.118973938517;1897.2505860185217;1901.5341241395877;1912.6844070728314;1915.2530513099903;1930.256851112318;1897.1936926806122;1899.3352326685688;1919.51052481617;1921.2795201799324;1935.5644979879555;1837.9632407351844;1848.510144811626;1861.3020117455953;1874.9250029998784;1876.3151449720822;1778.2442461953683;1806.7922188948176;1810.3030333321701;1825.3520000399933;1834.8623853210995;1870;1905.7617797775279;1906.5138389710673;1910.3122875764714;1928.5757133430623;6476.514261430364;6520.978496666049;6585.736570537173;6592.901106483407;6606.108175396356;3798.962010379916;3880.72834901557;3881.514810648669;3907.2380885727293;3960.722749407543;2449.5223431430877;2465.4452748131707;2471.456279618481;2491.5141547398266;2491.8878650460592;740.9147947985997;759.9164091949881;769.9384049276044;772.1005029141044;773.7253275087319;8528.104549022326;8551.315894728406;8649.524276164808;8662.13378662135;8679.652813887436;3508.614052454228;3531.9823400883347;3566.0906468850276;3634.9818250908575;3703.185299234164;7437.665305061285;7438.5536867788105;7446;7469.551826890404;7527.247275272429;3974.463447434617;3994.5206575210577;4016.7991600419864;4019.8593049243136;4029.7985100744845;3321.4353559894876;3437.6906078453057;3646.052026473083;3674.81625918703;3715.0898029982827;2988.925276868096;3067.708567686066;3094.210976201054;3127.343257915863;3133.2480204750696;1008.0423597582326;1014.7666036811574;1017.5421060522795;1029.264076185531;1034.829253173218;883.8143989762222;889.4752096263236;893.5800173918248;940.7036783413203;1088.711491454765;6223.0354295084335;6223.37766223374;6252.437280644764;6296.65368404733;6314.55798094129;965.546193289167;967.1682353176262;980.5832521178471;981.764376549623;1009.2682804966487;4839.2983017462275;4921.926171107436;4926.531979461945;4939.456659767423;4970.776315065831;7566.621668916532;7628.122765881994;7758.650860711282;7763;7778.455508114378;7697.846043079107;7714.421418393531;7747.651355689008;7763.650635721406;7815.765527034198;5841.912371314434;6067.575269731165;6160.199174107337;6164.445199931938;6178.443940045418;6109.480694141048;6151.415615516519;6168.321484636776;6196.132541444112;6210.689465526796;6905.585664860125;6983.9650801745665;7059.223485416703;7069.363757261871;7088.539244949062;6829.965850170717;6925.445964322943;7155.534890232118;7179.353858152791;7199.71201151948;5325.387580428301;5441.809536666197;5763.596548241583;5911.054231322968;5912.526997840077;5976.910346344721;6156.876862462636;6165.784197553064;6176.4441200292185;6188.226471691039;5681.488666020078;5782.277215348082;5856;5870.0607902735355;5910.704464776658;5682.801101961411;5711.200431939615;5716.342620598684;5748.913766293425;5857.297124345106;5791.681457519877;5861.7655293787775;5862.794802181903;5869.266341707286;5923.4076592340425;5272.78908843642;5279.498447647467;5284.837335786121;5319.734013299397;5337.066013447554;5407.891842163213;5467.58993075513;5490.423505531861;5497.257870187474;5531.640443371168 05:04:18 INFO - 2015-11-09 05:04:18,401 DEBUG : BROWSER_OUTPUT: |4;prototype.html;267.0825713673532;269.8407939315803;270.714396311891;273.9986300068499;274.59634337523835;5074.822381216649;5186.11835987882;5220.504052115052;5253.133233016557;5318.441563635821;5002.949970500294;5066.898662026766;5107.821226257081;5128.666636668614;5200.2459643351785;3868.9940615440046;3993.700472464562;4002.539707933581;4003;4020.7386519876113;3959.0696186396317;3970.126572154136;3972.2055588882195;4002.239574480839;4040.8585699500522;3914.3149948758996;3915.847815692674;3923.941140882889;3973.46358241638;3987.8803635890827;3960.8613698520558;3991.2416640838437;3993.1614360984227;4006.3990401439873;4022.3966405039187;3435.6736110069755;3437.7077948374417;3457.7406694498013;3478.1478537758157;3497.667721566447;4821.108095002401;4924.556789888928;4994.525520075587;5022.42242142151;5095.566876815476;4359.869203923888;4410.75740834254;4420.778961051967;4461.397711308997;4468.620167285784;5388.326459192601;5400.432954539756;5413.918791218135;5418.241446197536;5443.891122177574;3667.5782285037294;3668.944965825515;3671.7980511071883;3689.94465083024;3741.2330472253125;5453.345598528163;5597.580181486404;5604.355499117612;5624.91562626561;5679.716014199274;3619.8009109498703;3630.2557975615464;3640.0899775056237;3642.307961487309;3661.1579336752698;3712.387456069718;3724.1992971511254;3733.178700685845;3759.9060023499633;3761.981190094032;4334.674899382559;4349.934750978738;4353.0423306872435;4358;4377.993061595851;5105.744712764347;5219.19102539107;5451.155070964007;5475.014497390508;5491.835244942658;1315.9473621055051;1337.1776357540043;1343.8454577723687;1355.728854229158;1359.184489306428;830.7923019245188;851.3019324154134;866.2896424931622;866.657670220272;870.5429649433971;5037.596992240612;5043.470435604208;5071.264666623319;5085.618578606619;5101.846944591668;5505.504504594605;5511.972440137773;5555.194496797942;5590.077637189818;5723.141528770718;5112.207607820794;5126.307948426989;5127.769250383742;5134.2298655201275;5157.174852023658;3020.4865172920654;3067.831269280211;3079.630444346693;3112.25305926576;3126.765492588065;5746.511546518509;5761.48146666802;5774.855628609234;5805.332386775491;5815.156802263648;5782.797602083907;5785.1611516329895;5791.160281759206;5828.271466066742;5847.853803654858;5731.914021289684;5760.884782304247;5788.27646544182;5844.678542680108;5898.085796701518;5517.69652669107;5660.85847853807;5662.85842853932;5705.515031222392;5710.200571919851;5544.168374743821;5549.417311182267;5554.2779438672715;5565.248691426767;5593.888122237614;5764.048931926185;5780.335261444988;5798.913016304675;5808.041673123887;5859;3724.8137593119695;3774.698024158116;3820.331441997695;3830.3488406970323;3860.652541271299;5526.392096869422;5574.749136288958;5586.469285417878;5662.037453632975;5675.631083979528;5461.918071228855;5466.972665136808;5507.284053073075;5541.861453463695;5576.191452239484;5475.972620136874;5493.615446918678;5508.724563771875;5547.722613869371;5550.611457197957;5190.247414125006;5358.410574836843;5362.70505122222;5380.569554435714;5465.180222966586;5560.054790685674;5564.527015203753;5590.217369568345;5604.467575580314;5614.606977511535;5455.918161227505;5458.8908221834545;5460.781568737206;5511.22842802;5563.721813909207 05:04:18 INFO - 2015-11-09 05:04:18,404 DEBUG : BROWSER_OUTPUT: |5;yui.html;552.3427121725147;555.5694336888911;560.1150182711317;627.7426255235355;644.8907878449066;11064.834027489584;11357.943210283936;11472.827907581393;11498.712532186699;11599.014083802876;10565.577376904934;10761.78476430471;10831.458427078634;11914.404279785998;11949.864762847516;745.3962290544649;748.6144635512716;769.4844454215661;771.3713323641242;772.9652165652531;769.8113962079299;770.5222761887637;771.6296177834643;772.0542335638854;776.8679324514846;798.2217338095369;799.4044436894521;801.6032064128235;803.2008151888849;807.261355859388;790.3637571754736;797.3182928596083;799.2726618776943;805.6817557064956;806.2824086562964;586.0184191479298;590.5157770628086;592.8162269696408;593.5459373579215;597.7160848596882;11337.206395552315;11425.542978280859;11447.08423326132;11512.884871151266;11541.884581154249;9612.567434465465;9677.661281855171;9717.076877696607;9879.950600247024;9947.651832185838;7873.724419645342;7896.60516974149;7944;8216;8503.362247831437;2470.2275967944624;2616.3851494898686;2802.187365663955;2826.802123851331;2866.0685277284965;36081.09797255063;36839.99999999973;36904.261914761555;38397;39412.21175576472;5708.20085188074;5813.651180929158;5814.186013957965;5820.185174075633;6030.125631783367;9708.951455242819;9790.118889299998;9806.75483112928;9812.411255324703;9821.214302855755;5221.869453263699;5236.790528378822;5290.074237008585;5487.780488780484;5492.148716948879;2968.0912705548685;3203.967960320367;3256.495243237302;3288.901332960015;3316.121227874615;2248.2805502239453;2276.840621156503;2279.3845661671257;2279.8746068966366;2318.652202169654;341.89743077076776;342.75835535947095;353.00804738684377;353.3180960745734;357.303258645642;395.37530701491573;425.7892343290091;491.9877003074952;497.4329264638315;535.2559941681067;6115.755369785159;6345.730853829253;6372.7132279047555;6545;6668.499862510331;391.44610376317763;427.938711994256;482.17788670317026;496.2457065260783;503.8261799679178;3047.817130972149;3062.969370306313;3087.2590578261056;3140.654528001918;3170.144061103489;48173;49115;49183.60613120343;49245;49955;41079.58920410758;42038;42044.36933446001;42164;44650.33024504635;35944.281114378085;39493.60506394899;40110.79944600317;40349.59650403458;41125.1774964505;6594.10979517759;6675.7997260082275;6789.864202716017;6831.897521537082;6918.5502942308585;30581.694183057883;31214.843925781133;31248;31503.684963150074;31528.684713152576;36345.81827090848;37336.81331593324;38485.42271865868;40865.79567102146;41365.172696546506;6246.406591373812;6253.187085678833;6317.652529110943;6377.107204991212;6379.2344918608205;9207.309451791009;9492.477913714813;9494.287928405536;9719.46542940145;9813.607455701693;8464.44981076228;8903.821923561363;9047.547622618975;9061.093890610886;9217.400868943765;8570.228679418882;8920.018797932353;9130.452172869649;9146.49694266795;9286.767830804014;9004.50475223869;9004.819903602021;9134.58894349769;9221.631134754534;9521.761955951157;7517.962410187914;7726.3818894487185;7749.65126569317;8035.477693949874;8124.675012999413;6746.8650626988165;7050.647467626701;7113;7371.299726525972;7564.281393267631 05:04:18 INFO - 2015-11-09 05:04:18,405 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:04:18 INFO - 2015-11-09 05:04:18,405 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:04:18 INFO - 2015-11-09 05:04:18,405 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,302 05:04:18 INFO - 2015-11-09 05:04:18,405 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:04:18 INFO - 2015-11-09 05:04:18,405 DEBUG : BROWSER_OUTPUT: __startTimestamp1447074258388__endTimestamp 05:04:18 INFO - 2015-11-09 05:04:18,405 DEBUG : BROWSER_OUTPUT: 05:04:18 INFO - 2015-11-09 05:04:18,406 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:04:18 INFO - 2015-11-09 05:04:18,406 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:04:18 INFO - 2015-11-09 05:04:18,406 DEBUG : BROWSER_OUTPUT: 05:04:18 INFO - 2015-11-09 05:04:18,406 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4508.42 Median:4659.53 stddev:596.94 (12.8%) stddev-sans-first:578.92 05:04:18 INFO - 2015-11-09 05:04:18,406 DEBUG : BROWSER_OUTPUT: Values: 2562.7 2622.5 2648.6 2663.6 2694.9 4481.9 4503.2 4580.0 4621.0 4639.3 4434.7 4444.4 4514.0 4541.3 4597.9 4194.3 4195.8 4319.0 4333.6 4339.5 126.9 4248.5 4264.9 4340.4 4346.7 4131.5 4156.8 4174.2 4207.7 4228.6 4260.1 4275.3 4303.8 4335.0 4350.4 3996.9 4195.2 4279.5 4342.9 4376.0 4346.5 4418.9 4469.1 4518.8 4606.4 4726.2 4767.4 4794.0 4805.3 4813.6 4729.3 4734.2 4774.2 4830.1 4851.0 4518.8 4560.4 4591.1 4593.3 4616.3 4906.1 4975.0 4983.5 5015.9 5065.6 4498.5 4588.9 4608.8 4756.5 4758.7 4866.7 4880.7 4978.9 4981.4 4995.8 4797.3 4855.1 4860.6 4889.0 4914.3 4677.8 4753.6 4794.0 4850.6 4929.5 3715.3 3761.6 3778.6 3784.2 3815.1 3227.4 3418.9 3456.9 3466.3 3493.0 4456.8 4519.2 4526.3 4552.4 4553.3 4878.3 4924.9 4982.4 4985.3 4993.3 4411.9 4479.7 4591.0 4619.9 4688.1 4263.0 4329.7 4348.5 4360.2 4381.2 4948.5 4989.2 5034.8 5045.9 5086.8 4711.8 4793.7 4863.6 4895.9 4948.2 4972.0 5013.2 5032.9 5034.6 5056.0 4812.3 4856.3 4880.3 4889.4 4892.2 4735.6 4879.2 4927.0 4927.6 4966.5 4591.5 4707.2 4728.5 4728.9 4841.9 4710.2 4734.8 4751.7 4760.7 4768.3 4597.6 4632.6 4659.5 4675.7 4714.0 4534.5 4648.5 4667.6 4737.0 4801.9 4735.6 4740.0 4749.9 4778.0 4815.4 05:04:18 INFO - 2015-11-09 05:04:18,406 DEBUG : BROWSER_OUTPUT: 05:04:18 INFO - 2015-11-09 05:04:18,406 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49165.78 Median:33629.33 stddev:108326.59 (322.1%) stddev-sans-first:108568.75 05:04:18 INFO - 2015-11-09 05:04:18,408 DEBUG : BROWSER_OUTPUT: Values: 459.7 472.5 473.4 486.5 499.6 32889.0 33310.3 33426.3 33471.0 33732.3 35182.3 36088.1 36172.5 36280.8 36320.5 7604.5 7751.3 7853.6 7877.1 7940.0 7648.5 7796.3 7819.0 7865.1 7867.1 7693.7 7758.4 7781.2 7868.6 7902.4 7811.6 7839.6 7847.9 7848.8 7975.6 7544.1 7665.7 7702.2 7762.0 7774.6 32559.3 33176.3 33325.0 33398.2 33526.3 2600.5 2625.6 2641.0 2650.8 3044.3 22397.2 22519.2 22664.5 23209.0 23740.7 1943.5 2009.3 2011.8 2018.8 2124.6 230492.0 232502.0 235027.0 235355.0 237620.8 42625.4 44846.8 52166.2 55007.7 56648.4 52323.0 52568.5 52949.5 53150.7 53300.7 11429.8 11517.7 11526.7 11612.9 11632.5 8560.7 8627.9 8664.7 8706.6 8706.8 17334.3 17646.0 17746.6 17851.5 17993.1 7113.4 7388.5 7422.4 7479.0 7494.1 770.6 791.0 848.8 906.5 913.5 23375.0 23723.0 23795.0 23812.7 23888.6 857.6 877.2 902.0 940.3 1006.8 12228.5 12399.2 13526.5 14089.6 14268.3 599702.0 600439.0 615577.0 615800.0 616685.0 48667.8 48692.0 48709.3 48925.5 49397.5 1116.2 1130.3 1141.2 1145.1 1154.9 24659.8 25319.6 25351.5 25465.4 25677.7 41201.8 41219.2 41277.2 41290.0 41430.6 239002.0 239948.0 241930.0 242149.0 243162.0 24688.5 36635.8 38839.0 38889.2 39167.6 35747.5 36064.6 36340.8 37289.3 37632.6 28811.9 30366.7 30450.7 30854.4 30917.4 29487.0 29508.3 29558.1 29657.1 29704.7 29415.3 29896.7 30278.2 30594.4 31304.4 25522.9 29010.4 29030.7 29319.1 29471.1 20428.5 20464.2 20494.6 20655.9 20767.3 05:04:18 INFO - 2015-11-09 05:04:18,408 DEBUG : BROWSER_OUTPUT: 05:04:18 INFO - 2015-11-09 05:04:18,408 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23498.77 Median:4455.76 stddev:78257.22 (1756.3%) stddev-sans-first:78457.33 05:04:18 INFO - 2015-11-09 05:04:18,410 DEBUG : BROWSER_OUTPUT: Values: 282.3 285.1 285.1 288.3 293.5 13249.9 14456.7 14821.9 15069.5 15976.6 15315.8 15385.0 15494.8 15505.3 15574.8 4347.9 4550.5 4561.4 4561.4 4568.7 4529.8 4545.6 4547.9 4586.3 4596.4 3307.4 4473.4 4542.4 4926.6 4937.0 4842.8 4912.1 4942.6 4988.5 5009.7 4217.7 4328.7 4328.7 4344.0 4380.3 17702.8 17913.6 17989.6 18124.2 18460.2 1721.1 1730.4 1742.4 1818.0 1824.9 11056.2 11113.0 11372.5 11394.7 11519.7 1339.5 1428.9 1442.5 1443.4 1462.6 43795.3 45047.3 45148.1 46338.5 48853.5 5250.8 5334.0 5350.4 5376.5 5378.2 6183.5 6189.5 6196.2 6199.5 6257.0 4212.4 4230.3 4296.1 4307.2 4352.4 4381.3 4450.5 4454.3 4457.2 4469.4 2425.6 2430.5 2465.7 2475.7 2479.1 846.7 852.2 860.2 867.7 937.0 346.2 347.2 349.7 384.1 385.7 8270.1 8274.0 8500.9 8591.1 8709.3 344.4 345.3 355.6 362.3 375.3 4528.8 4782.6 5112.6 5172.8 5357.3 467819.0 471254.0 478911.0 482567.0 494550.0 54152.5 55875.7 56334.7 57139.0 58045.7 431.8 437.5 437.6 441.2 443.7 9032.4 9062.3 9131.7 9217.7 9233.9 27284.9 28399.4 28942.1 29601.3 29787.4 38880.6 38933.8 39298.8 39318.2 39471.6 4990.0 5145.9 5153.8 5171.4 5230.9 9203.8 9705.4 9749.7 9798.8 9810.1 7093.8 8314.1 8314.8 8363.9 8427.6 7536.2 8080.7 8222.3 8344.5 8429.4 7290.3 7596.3 7712.8 7731.5 8244.8 11538.5 12068.7 12491.0 12614.4 12759.2 12185.3 12382.8 12770.1 13016.5 13044.5 05:04:18 INFO - 2015-11-09 05:04:18,410 DEBUG : BROWSER_OUTPUT: 05:04:18 INFO - 2015-11-09 05:04:18,410 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4538.83 Median:5784.49 stddev:2319.78 (40.1%) stddev-sans-first:2314.76 05:04:18 INFO - 2015-11-09 05:04:18,411 DEBUG : BROWSER_OUTPUT: Values: 1461.7 1465.8 1511.1 1511.8 1517.9 5786.7 5868.9 6388.9 6464.8 6468.2 6255.2 6337.7 6436.7 6482.6 6526.1 1897.3 1901.5 1912.7 1915.3 1930.3 1897.2 1899.3 1919.5 1921.3 1935.6 1838.0 1848.5 1861.3 1874.9 1876.3 1778.2 1806.8 1810.3 1825.4 1834.9 1870.0 1905.8 1906.5 1910.3 1928.6 6476.5 6521.0 6585.7 6592.9 6606.1 3799.0 3880.7 3881.5 3907.2 3960.7 2449.5 2465.4 2471.5 2491.5 2491.9 740.9 759.9 769.9 772.1 773.7 8528.1 8551.3 8649.5 8662.1 8679.7 3508.6 3532.0 3566.1 3635.0 3703.2 7437.7 7438.6 7446.0 7469.6 7527.2 3974.5 3994.5 4016.8 4019.9 4029.8 3321.4 3437.7 3646.1 3674.8 3715.1 2988.9 3067.7 3094.2 3127.3 3133.2 1008.0 1014.8 1017.5 1029.3 1034.8 883.8 889.5 893.6 940.7 1088.7 6223.0 6223.4 6252.4 6296.7 6314.6 965.5 967.2 980.6 981.8 1009.3 4839.3 4921.9 4926.5 4939.5 4970.8 7566.6 7628.1 7758.7 7763.0 7778.5 7697.8 7714.4 7747.7 7763.7 7815.8 5841.9 6067.6 6160.2 6164.4 6178.4 6109.5 6151.4 6168.3 6196.1 6210.7 6905.6 6984.0 7059.2 7069.4 7088.5 6830.0 6925.4 7155.5 7179.4 7199.7 5325.4 5441.8 5763.6 5911.1 5912.5 5976.9 6156.9 6165.8 6176.4 6188.2 5681.5 5782.3 5856.0 5870.1 5910.7 5682.8 5711.2 5716.3 5748.9 5857.3 5791.7 5861.8 5862.8 5869.3 5923.4 5272.8 5279.5 5284.8 5319.7 5337.1 5407.9 5467.6 5490.4 5497.3 5531.6 05:04:18 INFO - 2015-11-09 05:04:18,412 DEBUG : BROWSER_OUTPUT: 05:04:18 INFO - 2015-11-09 05:04:18,412 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4540.14 Median:5171.65 stddev:1387.54 (26.8%) stddev-sans-first:1353.85 05:04:18 INFO - 2015-11-09 05:04:18,413 DEBUG : BROWSER_OUTPUT: Values: 267.1 269.8 270.7 274.0 274.6 5074.8 5186.1 5220.5 5253.1 5318.4 5002.9 5066.9 5107.8 5128.7 5200.2 3869.0 3993.7 4002.5 4003.0 4020.7 3959.1 3970.1 3972.2 4002.2 4040.9 3914.3 3915.8 3923.9 3973.5 3987.9 3960.9 3991.2 3993.2 4006.4 4022.4 3435.7 3437.7 3457.7 3478.1 3497.7 4821.1 4924.6 4994.5 5022.4 5095.6 4359.9 4410.8 4420.8 4461.4 4468.6 5388.3 5400.4 5413.9 5418.2 5443.9 3667.6 3668.9 3671.8 3689.9 3741.2 5453.3 5597.6 5604.4 5624.9 5679.7 3619.8 3630.3 3640.1 3642.3 3661.2 3712.4 3724.2 3733.2 3759.9 3762.0 4334.7 4349.9 4353.0 4358.0 4378.0 5105.7 5219.2 5451.2 5475.0 5491.8 1315.9 1337.2 1343.8 1355.7 1359.2 830.8 851.3 866.3 866.7 870.5 5037.6 5043.5 5071.3 5085.6 5101.8 5505.5 5512.0 5555.2 5590.1 5723.1 5112.2 5126.3 5127.8 5134.2 5157.2 3020.5 3067.8 3079.6 3112.3 3126.8 5746.5 5761.5 5774.9 5805.3 5815.2 5782.8 5785.2 5791.2 5828.3 5847.9 5731.9 5760.9 5788.3 5844.7 5898.1 5517.7 5660.9 5662.9 5705.5 5710.2 5544.2 5549.4 5554.3 5565.2 5593.9 5764.0 5780.3 5798.9 5808.0 5859.0 3724.8 3774.7 3820.3 3830.3 3860.7 5526.4 5574.7 5586.5 5662.0 5675.6 5461.9 5467.0 5507.3 5541.9 5576.2 5476.0 5493.6 5508.7 5547.7 5550.6 5190.2 5358.4 5362.7 5380.6 5465.2 5560.1 5564.5 5590.2 5604.5 5614.6 5455.9 5458.9 5460.8 5511.2 5563.7 05:04:18 INFO - 2015-11-09 05:04:18,413 DEBUG : BROWSER_OUTPUT: 05:04:18 INFO - 2015-11-09 05:04:18,413 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11097.12 Median:5817.19 stddev:13531.02 (232.6%) stddev-sans-first:13545.81 05:04:18 INFO - 2015-11-09 05:04:18,414 DEBUG : BROWSER_OUTPUT: Values: 552.3 555.6 560.1 627.7 644.9 11064.8 11357.9 11472.8 11498.7 11599.0 10565.6 10761.8 10831.5 11914.4 11949.9 745.4 748.6 769.5 771.4 773.0 769.8 770.5 771.6 772.1 776.9 798.2 799.4 801.6 803.2 807.3 790.4 797.3 799.3 805.7 806.3 586.0 590.5 592.8 593.5 597.7 11337.2 11425.5 11447.1 11512.9 11541.9 9612.6 9677.7 9717.1 9880.0 9947.7 7873.7 7896.6 7944.0 8216.0 8503.4 2470.2 2616.4 2802.2 2826.8 2866.1 36081.1 36840.0 36904.3 38397.0 39412.2 5708.2 5813.7 5814.2 5820.2 6030.1 9709.0 9790.1 9806.8 9812.4 9821.2 5221.9 5236.8 5290.1 5487.8 5492.1 2968.1 3204.0 3256.5 3288.9 3316.1 2248.3 2276.8 2279.4 2279.9 2318.7 341.9 342.8 353.0 353.3 357.3 395.4 425.8 492.0 497.4 535.3 6115.8 6345.7 6372.7 6545.0 6668.5 391.4 427.9 482.2 496.2 503.8 3047.8 3063.0 3087.3 3140.7 3170.1 48173.0 49115.0 49183.6 49245.0 49955.0 41079.6 42038.0 42044.4 42164.0 44650.3 35944.3 39493.6 40110.8 40349.6 41125.2 6594.1 6675.8 6789.9 6831.9 6918.6 30581.7 31214.8 31248.0 31503.7 31528.7 36345.8 37336.8 38485.4 40865.8 41365.2 6246.4 6253.2 6317.7 6377.1 6379.2 9207.3 9492.5 9494.3 9719.5 9813.6 8464.4 8903.8 9047.5 9061.1 9217.4 8570.2 8920.0 9130.5 9146.5 9286.8 9004.5 9004.8 9134.6 9221.6 9521.8 7518.0 7726.4 7749.7 8035.5 8124.7 6746.9 7050.6 7113.0 7371.3 7564.3 05:04:18 INFO - 2015-11-09 05:04:18,415 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:04:18 INFO - 2015-11-09 05:04:18,415 DEBUG : BROWSER_OUTPUT: 05:04:19 INFO - 2015-11-09 05:04:19,103 INFO : Browser exited with error code: 0 05:04:19 INFO - 2015-11-09 05:04:19,136 INFO : Completed test dromaeo_css (00:18:31) 05:04:19 INFO - 2015-11-09 05:04:19,136 INFO : Starting test kraken 05:04:19 INFO - 2015-11-09 05:04:19,136 DEBUG : operating with platform_type : mac_ 05:04:19 INFO - 2015-11-09 05:04:19,137 INFO : Initialising browser for kraken test... 05:04:19 INFO - 2015-11-09 05:04:19,152 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpCuO6Yl/profile http://localhost:53739/getInfo.html 05:04:22 INFO - 2015-11-09 05:04:22,585 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:04:22 INFO - 2015-11-09 05:04:22,586 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:04:22 INFO - 2015-11-09 05:04:22,586 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:04:22 INFO - 2015-11-09 05:04:22,586 DEBUG : BROWSER_OUTPUT: __metrics 05:04:23 INFO - 2015-11-09 05:04:23,284 INFO : Browser initialized. 05:04:23 INFO - 2015-11-09 05:04:23,284 INFO : Running cycle 1/1 for kraken test... 05:04:23 INFO - 2015-11-09 05:04:23,285 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpCuO6Yl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:04:35 INFO - 2015-11-09 05:04:35,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 239849472 05:04:35 INFO - 2015-11-09 05:04:35,661 DEBUG : BROWSER_OUTPUT: 05:04:38 INFO - 2015-11-09 05:04:38,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53739/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:39 INFO - 2015-11-09 05:04:39,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 259334144 05:04:39 INFO - 2015-11-09 05:04:39,163 DEBUG : BROWSER_OUTPUT: 05:04:42 INFO - 2015-11-09 05:04:42,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53739/tests/kraken/driver.html?testName=audio-dft) 05:04:42 INFO - 2015-11-09 05:04:42,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 268251136 05:04:42 INFO - 2015-11-09 05:04:42,865 DEBUG : BROWSER_OUTPUT: 05:04:46 INFO - 2015-11-09 05:04:46,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53739/tests/kraken/driver.html?testName=audio-fft) 05:04:46 INFO - 2015-11-09 05:04:46,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 268738560 05:04:46 INFO - 2015-11-09 05:04:46,802 DEBUG : BROWSER_OUTPUT: 05:04:49 INFO - 2015-11-09 05:04:49,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53739/tests/kraken/driver.html?testName=audio-oscillator) 05:04:49 INFO - 2015-11-09 05:04:49,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 268292096 05:04:49 INFO - 2015-11-09 05:04:49,597 DEBUG : BROWSER_OUTPUT: 05:04:52 INFO - 2015-11-09 05:04:52,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53739/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:52 INFO - 2015-11-09 05:04:52,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 269004800 05:04:52 INFO - 2015-11-09 05:04:52,600 DEBUG : BROWSER_OUTPUT: 05:04:56 INFO - 2015-11-09 05:04:56,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53739/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:56 INFO - 2015-11-09 05:04:56,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 267751424 05:04:56 INFO - 2015-11-09 05:04:56,682 DEBUG : BROWSER_OUTPUT: 05:05:00 INFO - 2015-11-09 05:05:00,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53739/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:00 INFO - 2015-11-09 05:05:00,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 267296768 05:05:00 INFO - 2015-11-09 05:05:00,937 DEBUG : BROWSER_OUTPUT: 05:05:04 INFO - 2015-11-09 05:05:04,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53739/tests/kraken/driver.html?testName=json-parse-financial) 05:05:04 INFO - 2015-11-09 05:05:04,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 268480512 05:05:04 INFO - 2015-11-09 05:05:04,908 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-11-09 05:05:06,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53739/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:07 INFO - 2015-11-09 05:05:07,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 266563584 05:05:07 INFO - 2015-11-09 05:05:07,260 DEBUG : BROWSER_OUTPUT: 05:05:09 INFO - 2015-11-09 05:05:09,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53739/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:09 INFO - 2015-11-09 05:05:09,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 268144640 05:05:09 INFO - 2015-11-09 05:05:09,940 DEBUG : BROWSER_OUTPUT: 05:05:12 INFO - 2015-11-09 05:05:12,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53739/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:12 INFO - 2015-11-09 05:05:12,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 268500992 05:05:12 INFO - 2015-11-09 05:05:12,955 DEBUG : BROWSER_OUTPUT: 05:05:15 INFO - 2015-11-09 05:05:15,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:16 INFO - 2015-11-09 05:05:16,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 268288000 05:05:16 INFO - 2015-11-09 05:05:16,533 DEBUG : BROWSER_OUTPUT: 05:05:19 INFO - 2015-11-09 05:05:19,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:20 INFO - 2015-11-09 05:05:20,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 268677120 05:05:20 INFO - 2015-11-09 05:05:20,187 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53739/tests/kraken/driver.html?testName=ai-astar) 05:05:22 INFO - 2015-11-09 05:05:22,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 269172736 05:05:22 INFO - 2015-11-09 05:05:22,390 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,391 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:05:22 INFO - 2015-11-09 05:05:22,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:05:22 INFO - 2015-11-09 05:05:22,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:05:22 INFO - 2015-11-09 05:05:22,391 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:05:22 INFO - 2015-11-09 05:05:22,391 DEBUG : BROWSER_OUTPUT: |0;ai-astar;133;124;134;144;140;146;135;135;135;134 05:05:22 INFO - 2015-11-09 05:05:22,392 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;188;166;197;209;162;180;180;165;208;165 05:05:22 INFO - 2015-11-09 05:05:22,392 DEBUG : BROWSER_OUTPUT: |2;audio-dft;209;210;209;204;203;204;203;202;205;206 05:05:22 INFO - 2015-11-09 05:05:22,392 DEBUG : BROWSER_OUTPUT: |3;audio-fft;88;95;100;155;84;86;89;88;127;80 05:05:22 INFO - 2015-11-09 05:05:22,392 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;105;110;154;117;115;113;152;109;108;157 05:05:22 INFO - 2015-11-09 05:05:22,392 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;144;143;157;146;143;143;149;157;146;143 05:05:22 INFO - 2015-11-09 05:05:22,392 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;156;165;161;155;157;157;165;163;157;155 05:05:22 INFO - 2015-11-09 05:05:22,392 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;130;133;133;136;134;139;138;130;128;134 05:05:22 INFO - 2015-11-09 05:05:22,393 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;73;79;77;79;77;78;87;81;80 05:05:22 INFO - 2015-11-09 05:05:22,393 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;82;84;83;88;87;91;88;83;87 05:05:22 INFO - 2015-11-09 05:05:22,393 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;105;106;121;112;113;111;109;106;109;113 05:05:22 INFO - 2015-11-09 05:05:22,393 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;159;159;161;160;171;161;151;157;162;158 05:05:22 INFO - 2015-11-09 05:05:22,393 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;189;203;192;192;201;188;192;190;192;192 05:05:22 INFO - 2015-11-09 05:05:22,393 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;85;87;89;90;93;91;91;93;97;90 05:05:22 INFO - 2015-11-09 05:05:22,393 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:05:22 INFO - 2015-11-09 05:05:22,393 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:05:22 INFO - 2015-11-09 05:05:22,393 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,759 05:05:22 INFO - 2015-11-09 05:05:22,394 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:05:22 INFO - 2015-11-09 05:05:22,394 DEBUG : BROWSER_OUTPUT: __startTimestamp1447074322390__endTimestamp 05:05:22 INFO - 2015-11-09 05:05:22,394 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,395 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:05:22 INFO - 2015-11-09 05:05:22,395 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:05:22 INFO - 2015-11-09 05:05:22,395 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,396 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:136.00 Median:135.00 stddev:6.18 (4.6%) stddev-sans-first:6.46 05:05:22 INFO - 2015-11-09 05:05:22,397 DEBUG : BROWSER_OUTPUT: Values: 133.0 124.0 134.0 144.0 140.0 146.0 135.0 135.0 135.0 134.0 05:05:22 INFO - 2015-11-09 05:05:22,397 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,397 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:182.00 Median:184.00 stddev:17.98 (9.8%) stddev-sans-first:18.93 05:05:22 INFO - 2015-11-09 05:05:22,398 DEBUG : BROWSER_OUTPUT: Values: 188.0 166.0 197.0 209.0 162.0 180.0 180.0 165.0 208.0 165.0 05:05:22 INFO - 2015-11-09 05:05:22,398 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,398 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:205.50 Median:205.50 stddev:2.88 (1.4%) stddev-sans-first:2.76 05:05:22 INFO - 2015-11-09 05:05:22,398 DEBUG : BROWSER_OUTPUT: Values: 209.0 210.0 209.0 204.0 203.0 204.0 203.0 202.0 205.0 206.0 05:05:22 INFO - 2015-11-09 05:05:22,398 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,398 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:99.20 Median:87.00 stddev:23.65 (27.2%) stddev-sans-first:24.73 05:05:22 INFO - 2015-11-09 05:05:22,398 DEBUG : BROWSER_OUTPUT: Values: 88.0 95.0 100.0 155.0 84.0 86.0 89.0 88.0 127.0 80.0 05:05:22 INFO - 2015-11-09 05:05:22,399 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,399 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:124.00 Median:116.00 stddev:21.24 (18.3%) stddev-sans-first:21.39 05:05:22 INFO - 2015-11-09 05:05:22,399 DEBUG : BROWSER_OUTPUT: Values: 105.0 110.0 154.0 117.0 115.0 113.0 152.0 109.0 108.0 157.0 05:05:22 INFO - 2015-11-09 05:05:22,399 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,399 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:147.10 Median:146.00 stddev:5.57 (3.8%) stddev-sans-first:5.79 05:05:22 INFO - 2015-11-09 05:05:22,399 DEBUG : BROWSER_OUTPUT: Values: 144.0 143.0 157.0 146.0 143.0 143.0 149.0 157.0 146.0 143.0 05:05:22 INFO - 2015-11-09 05:05:22,400 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,400 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:159.10 Median:159.00 stddev:4.01 (2.5%) stddev-sans-first:4.10 05:05:22 INFO - 2015-11-09 05:05:22,400 DEBUG : BROWSER_OUTPUT: Values: 156.0 165.0 161.0 155.0 157.0 157.0 165.0 163.0 157.0 155.0 05:05:22 INFO - 2015-11-09 05:05:22,400 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,401 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:133.50 Median:134.00 stddev:3.54 (2.6%) stddev-sans-first:3.52 05:05:22 INFO - 2015-11-09 05:05:22,401 DEBUG : BROWSER_OUTPUT: Values: 130.0 133.0 133.0 136.0 134.0 139.0 138.0 130.0 128.0 134.0 05:05:22 INFO - 2015-11-09 05:05:22,401 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,403 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:78.00 Median:79.00 stddev:4.76 (6.0%) stddev-sans-first:3.77 05:05:22 INFO - 2015-11-09 05:05:22,403 DEBUG : BROWSER_OUTPUT: Values: 69.0 73.0 79.0 77.0 79.0 77.0 78.0 87.0 81.0 80.0 05:05:22 INFO - 2015-11-09 05:05:22,403 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,403 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:85.30 Median:87.00 stddev:3.40 (3.9%) stddev-sans-first:3.02 05:05:22 INFO - 2015-11-09 05:05:22,403 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 84.0 83.0 88.0 87.0 91.0 88.0 83.0 87.0 05:05:22 INFO - 2015-11-09 05:05:22,403 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,403 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:110.50 Median:111.50 stddev:4.72 (4.2%) stddev-sans-first:4.57 05:05:22 INFO - 2015-11-09 05:05:22,404 DEBUG : BROWSER_OUTPUT: Values: 105.0 106.0 121.0 112.0 113.0 111.0 109.0 106.0 109.0 113.0 05:05:22 INFO - 2015-11-09 05:05:22,404 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,404 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:159.90 Median:160.50 stddev:4.98 (3.1%) stddev-sans-first:5.27 05:05:22 INFO - 2015-11-09 05:05:22,404 DEBUG : BROWSER_OUTPUT: Values: 159.0 159.0 161.0 160.0 171.0 161.0 151.0 157.0 162.0 158.0 05:05:22 INFO - 2015-11-09 05:05:22,404 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,404 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.10 Median:192.00 stddev:4.93 (2.6%) stddev-sans-first:5.00 05:05:22 INFO - 2015-11-09 05:05:22,404 DEBUG : BROWSER_OUTPUT: Values: 189.0 203.0 192.0 192.0 201.0 188.0 192.0 190.0 192.0 192.0 05:05:22 INFO - 2015-11-09 05:05:22,405 DEBUG : BROWSER_OUTPUT: 05:05:22 INFO - 2015-11-09 05:05:22,405 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:90.60 Median:91.00 stddev:3.34 (3.7%) stddev-sans-first:2.86 05:05:22 INFO - 2015-11-09 05:05:22,405 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 89.0 90.0 93.0 91.0 91.0 93.0 97.0 90.0 05:05:22 INFO - 2015-11-09 05:05:22,405 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:05:22 INFO - 2015-11-09 05:05:22,405 DEBUG : BROWSER_OUTPUT: 05:05:23 INFO - 2015-11-09 05:05:23,118 INFO : Browser exited with error code: 0 05:05:23 INFO - 2015-11-09 05:05:23,175 INFO : Completed test kraken (00:01:04) 05:05:23 INFO - 2015-11-09 05:05:23,175 INFO : Starting test v8_7 05:05:23 INFO - 2015-11-09 05:05:23,175 DEBUG : operating with platform_type : mac_ 05:05:23 INFO - 2015-11-09 05:05:23,175 INFO : Initialising browser for v8_7 test... 05:05:23 INFO - 2015-11-09 05:05:23,190 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpjZla0d/profile http://localhost:53739/getInfo.html 05:05:26 INFO - 2015-11-09 05:05:26,610 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:05:26 INFO - 2015-11-09 05:05:26,610 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:05:26 INFO - 2015-11-09 05:05:26,611 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:05:26 INFO - 2015-11-09 05:05:26,611 DEBUG : BROWSER_OUTPUT: __metrics 05:05:27 INFO - 2015-11-09 05:05:27,328 INFO : Browser initialized. 05:05:27 INFO - 2015-11-09 05:05:27,328 INFO : Running cycle 1/1 for v8_7 test... 05:05:27 INFO - 2015-11-09 05:05:27,328 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpjZla0d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:05:39 INFO - 2015-11-09 05:05:39,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 241008640 05:05:39 INFO - 2015-11-09 05:05:39,712 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53739/tests/v8_7/run.html (next: http://localhost:53739/tests/v8_7/run.html) 05:06:02 INFO - 2015-11-09 05:06:02,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 261132288 05:06:02 INFO - 2015-11-09 05:06:02,585 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,585 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:06:02 INFO - 2015-11-09 05:06:02,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:06:02 INFO - 2015-11-09 05:06:02,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:06:02 INFO - 2015-11-09 05:06:02,586 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:06:02 INFO - 2015-11-09 05:06:02,586 DEBUG : BROWSER_OUTPUT: |0;Richards;872.6003490401396 05:06:02 INFO - 2015-11-09 05:06:02,586 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;234.52157598499062 05:06:02 INFO - 2015-11-09 05:06:02,586 DEBUG : BROWSER_OUTPUT: |2;Encrypt;385.35645472061657 05:06:02 INFO - 2015-11-09 05:06:02,586 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6843.5374149659865 05:06:02 INFO - 2015-11-09 05:06:02,586 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1367.9890560875513 05:06:02 INFO - 2015-11-09 05:06:02,586 DEBUG : BROWSER_OUTPUT: |5;Earley;929.368029739777 05:06:02 INFO - 2015-11-09 05:06:02,587 DEBUG : BROWSER_OUTPUT: |6;Boyer;15400 05:06:02 INFO - 2015-11-09 05:06:02,587 DEBUG : BROWSER_OUTPUT: |7;RegExp;38018.8679245283 05:06:02 INFO - 2015-11-09 05:06:02,587 DEBUG : BROWSER_OUTPUT: |8;Splay;811.0300081103001 05:06:02 INFO - 2015-11-09 05:06:02,587 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6849.315068493151 05:06:02 INFO - 2015-11-09 05:06:02,587 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:06:02 INFO - 2015-11-09 05:06:02,587 DEBUG : BROWSER_OUTPUT: __startTimestamp1447074362582__endTimestamp 05:06:02 INFO - 2015-11-09 05:06:02,587 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,587 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:06:02 INFO - 2015-11-09 05:06:02,587 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:06:02 INFO - 2015-11-09 05:06:02,588 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,588 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:872.60 Median:872.60 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,588 DEBUG : BROWSER_OUTPUT: Values: 872.6 05:06:02 INFO - 2015-11-09 05:06:02,588 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,588 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:234.52 Median:234.52 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,588 DEBUG : BROWSER_OUTPUT: Values: 234.5 05:06:02 INFO - 2015-11-09 05:06:02,588 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,588 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:385.36 Median:385.36 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,589 DEBUG : BROWSER_OUTPUT: Values: 385.4 05:06:02 INFO - 2015-11-09 05:06:02,589 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,589 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6843.54 Median:6843.54 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,589 DEBUG : BROWSER_OUTPUT: Values: 6843.5 05:06:02 INFO - 2015-11-09 05:06:02,589 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,589 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1367.99 Median:1367.99 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,589 DEBUG : BROWSER_OUTPUT: Values: 1368.0 05:06:02 INFO - 2015-11-09 05:06:02,589 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,590 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:929.37 Median:929.37 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,590 DEBUG : BROWSER_OUTPUT: Values: 929.4 05:06:02 INFO - 2015-11-09 05:06:02,590 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,590 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15400.00 Median:15400.00 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,590 DEBUG : BROWSER_OUTPUT: Values: 15400.0 05:06:02 INFO - 2015-11-09 05:06:02,590 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,590 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:38018.87 Median:38018.87 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,590 DEBUG : BROWSER_OUTPUT: Values: 38018.9 05:06:02 INFO - 2015-11-09 05:06:02,591 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,591 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:811.03 Median:811.03 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,591 DEBUG : BROWSER_OUTPUT: Values: 811.0 05:06:02 INFO - 2015-11-09 05:06:02,591 DEBUG : BROWSER_OUTPUT: 05:06:02 INFO - 2015-11-09 05:06:02,591 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6849.32 Median:6849.32 stddev:0.00 (0.0%) 05:06:02 INFO - 2015-11-09 05:06:02,591 DEBUG : BROWSER_OUTPUT: Values: 6849.3 05:06:02 INFO - 2015-11-09 05:06:02,591 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:06:02 INFO - 2015-11-09 05:06:02,591 DEBUG : BROWSER_OUTPUT: 05:06:03 INFO - 2015-11-09 05:06:03,347 INFO : Browser exited with error code: 0 05:06:03 INFO - 2015-11-09 05:06:03,371 INFO : Completed test v8_7 (00:00:40) 05:06:03 INFO - 2015-11-09 05:06:03,562 INFO : Completed test suite (00:20:15) 05:06:03 INFO - 2015-11-09 05:06:03,562 DEBUG : Working with test: dromaeo_css 05:06:03 INFO - 2015-11-09 05:06:03,562 DEBUG : Generating results file: dromaeo_css 05:06:03 INFO - 2015-11-09 05:06:03,563 DEBUG : Working with test: kraken 05:06:03 INFO - 2015-11-09 05:06:03,563 DEBUG : Generating results file: kraken 05:06:03 INFO - 2015-11-09 05:06:03,564 INFO : javascript benchmark 05:06:03 INFO - 2015-11-09 05:06:03,564 DEBUG : Working with test: v8_7 05:06:03 INFO - 2015-11-09 05:06:03,564 DEBUG : Generating results file: v8_7 05:06:03 INFO - 2015-11-09 05:06:03,564 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:03 INFO - 2015-11-09 05:06:03,626 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 05:06:03 INFO - 2015-11-09 05:06:03,626 DEBUG : process_Request line: dromaeo_css 5647.30 graph.html#tests=[[72,63,57]] 05:06:03 INFO - 2015-11-09 05:06:03,626 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:03 INFO - 2015-11-09 05:06:03,664 DEBUG : process_Request line: kraken 1903.80 graph.html#tests=[[232,63,57]] 05:06:03 INFO - 2015-11-09 05:06:03,664 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:03 INFO - 2015-11-09 05:06:03,697 DEBUG : process_Request line: v8_7 13985.98 graph.html#tests=[[230,63,57]] 05:06:03 INFO - 2015-11-09 05:06:03,698 INFO : javascript benchmark 05:06:03 INFO - 2015-11-09 05:06:03,701 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [282.3491851282794, 285.0848775430867, 285.1005078975831, 288.34401736050484, 293.545482136016, 13249.933750331234, 14456.710865782678, 14821.851781482195, 15069.47256846012, 15976.600584985381, 15315.77026344603, 15385.0, 15494.84505154948, 15505.302261398236, 15574.84425155748, 4347.891302717426, 4550.476695180064, 4561.361409402686, 4561.429821272341, 4568.725876447407, 4529.750863702495, 4545.636349092065, 4547.8635640930825, 4586.266197408415, 4596.402467679214, 3307.3881331953544, 4473.396091527651, 4542.364069030338, 4926.605871530269, 4937.0, 4842.806287748486, 4912.091263116335, 4942.629302802305, 4988.451270360258, 5009.699418034911, 4217.746935183899, 4328.6753493487795, 4328.675349348811, 4343.956560434387, 4380.277254253045, 17702.822971770376, 17913.641727165515, 17989.550261243443, 18124.184411701506, 18460.16929238174, 1721.122227663888, 1730.3684155283356, 1742.4337090445656, 1817.972730409045, 1824.8540116790625, 11056.170787190913, 11113.0, 11372.545098196062, 11394.71513212168, 11519.654410367702, 1339.5110784563662, 1428.9428422863073, 1442.5383877159313, 1443.4154167562153, 1462.5977856089555, 43795.343069853974, 45047.32429013567, 45148.097038059386, 46338.53661463376, 48853.511464885254, 5250.7637156328055, 5333.973330133324, 5350.438203988525, 5376.542993845489, 5378.1663842104535, 6183.505319574513, 6189.50483961282, 6196.225471816023, 6199.535034872402, 6257.030160325156, 4212.410262563244, 4230.259704551691, 4296.119295544406, 4307.203167414038, 4352.39066530686, 4381.298992161239, 4450.532694067077, 4454.309582014793, 4457.2199865023495, 4469.351943968107, 2425.5997760369696, 2430.526047420736, 2465.654808326836, 2475.740047295008, 2479.1075212923333, 846.7205822078822, 852.1691350932791, 860.2257967828879, 867.7179916527153, 936.9880529028633, 346.210639741385, 347.24820763047717, 349.67480243373905, 384.13186199190034, 385.72227995842945, 8270.131636178116, 8273.958630206811, 8500.914990850013, 8591.097934716765, 8709.259712924346, 344.37839699342925, 345.34557014457465, 355.5999500561868, 362.2718336144369, 375.2569911575097, 4528.818847246073, 4782.593479554277, 5112.565431938327, 5172.7641772698, 5357.330333708286, 467819.0, 471254.0, 478911.0, 482567.0, 494550.0, 54152.45847541553, 55875.720621396635, 56334.718326408925, 57139.0, 58045.709771451715, 431.82079437033906, 437.536211615682, 437.63676148796424, 441.1750027448692, 443.6982851660837, 9032.36773425854, 9062.320325975446, 9131.680391186277, 9217.723468295962, 9233.861492077489, 27284.863575681993, 28399.432011359244, 28942.13173604795, 29601.25996850096, 29787.404251915275, 38880.6111938877, 38933.8053309743, 39298.80350598229, 39318.213635726555, 39471.605283946796, 4989.950100498949, 5145.948540514547, 5153.768080436314, 5171.379434467888, 5230.921536176884, 9203.76990575241, 9705.417674939245, 9749.658761943581, 9798.80402391934, 9810.068043535854, 7093.787186384417, 8314.085450600309, 8314.750557483285, 8363.916360836314, 8427.578621069044, 7536.171021187774, 8080.71717489885, 8222.259996600334, 8344.499330040217, 8429.409941304295, 7290.270972902667, 7596.278353556403, 7712.8457430852195, 7731.536107833548, 8244.752657420288, 11538.538458461568, 12068.715605959758, 12491.0, 12614.432350544064, 12759.234445933274, 12185.329806860707, 12382.752344953231, 12770.106092573431, 13016.47934082664, 13044.54344097952], "dojo.html": [2562.7052888917774, 2622.4886147201305, 2648.602709593562, 2663.613776002479, 2694.8517831519257, 4481.932771008429, 4503.166914120886, 4580.038191979684, 4620.97689511552, 4639.280911458721, 4434.667399945001, 4444.355568442582, 4514.0, 4541.341505481703, 4597.931031034537, 4194.349875769245, 4195.790210489478, 4319.028218650794, 4333.566643335673, 4339.522652508237, 126.87275770021982, 4248.490181178247, 4264.9147017059795, 4340.392345071693, 4346.717463364871, 4131.462909821704, 4156.771377574232, 4174.165166966589, 4207.663386929038, 4228.640565551932, 4260.062786187065, 4275.294576394891, 4303.849365272201, 4334.956650433487, 4350.369196466526, 3996.8800935971967, 4195.160967806451, 4279.465066866642, 4342.934855977162, 4375.993521490075, 4346.47842258931, 4418.9337159942625, 4469.061497085616, 4518.751468669222, 4606.355110284563, 4726.196546587088, 4767.356406885096, 4793.952060479385, 4805.303231031481, 4813.590844778198, 4729.266963620645, 4734.218853889104, 4774.212254977924, 4830.1064303103685, 4851.0, 4518.751468669222, 4560.429946256718, 4591.104734576759, 4593.28804035375, 4616.330632058366, 4906.1414252505665, 4974.975125124423, 4983.50164983506, 5015.874603134951, 5065.6200784941275, 4498.460184777848, 4588.908221835544, 4608.792604332813, 4756.524347565285, 4758.738269395217, 4866.732329721828, 4880.731559764247, 4978.925316120261, 4981.402231732215, 4995.775190116454, 4797.328374027639, 4855.101806165871, 4860.586850117779, 4889.0, 4914.336564563738, 4677.766111694402, 4753.572178503951, 4794.017226468565, 4850.587700045536, 4929.531694489017, 3715.256948610289, 3761.5674197467642, 3778.5654649715084, 3784.243151369737, 3815.103450689086, 3227.370662720794, 3418.8803391881165, 3456.879009234665, 3466.3240668069484, 3492.965070349264, 4456.821727130943, 4519.231730605805, 4526.298423744325, 4552.408186935743, 4553.2942393929, 4878.292647566083, 4924.8768780780765, 4982.402111746614, 4985.326980857611, 4993.251012348104, 4411.911761764747, 4479.731216126977, 4590.997829186252, 4619.930701039487, 4688.0858232644305, 4263.0, 4329.718568293051, 4348.543402942709, 4360.193364227564, 4381.21138195128, 4948.455669876311, 4989.151844186497, 5034.848954531297, 5045.949540504622, 5086.7710953007945, 4711.764411779466, 4793.736344501086, 4863.610911127031, 4895.877603059952, 4948.1835497142565, 4971.975140124277, 5013.222950442687, 5032.899342013213, 5034.647574669884, 5056.0140772549, 4812.326274321527, 4856.320115183807, 4880.341153944172, 4889.364382630235, 4892.168331383602, 4735.621150308036, 4879.243717223836, 4927.0, 4927.5565199130815, 4966.453690094159, 4591.540845915381, 4707.24684050564, 4728.527147285244, 4728.905421891612, 4841.854744357534, 4710.222813235778, 4734.834280800155, 4751.667383283137, 4760.690555113906, 4768.3085952537385, 4597.563231493003, 4632.5830675239395, 4659.534046595313, 4675.719456832601, 4713.986492904042, 4534.501204867528, 4648.511906249795, 4667.649926255476, 4737.0, 4801.927971080507, 4735.550122738335, 4740.0, 4749.857504274877, 4778.04439112172, 4815.374001379798], "mootools.html": [1461.6638173220158, 1465.7654775235965, 1511.1084460168506, 1511.807878576065, 1517.8937474376794, 5786.71066446677, 5868.911966320498, 6388.872222555552, 6464.838379040526, 6468.159139311889, 6255.186825712651, 6337.651429171394, 6436.742530298794, 6482.5786323888915, 6526.118973938517, 1897.2505860185217, 1901.5341241395877, 1912.6844070728314, 1915.2530513099903, 1930.256851112318, 1897.1936926806122, 1899.3352326685688, 1919.51052481617, 1921.2795201799324, 1935.5644979879555, 1837.9632407351844, 1848.510144811626, 1861.3020117455953, 1874.9250029998784, 1876.3151449720822, 1778.2442461953683, 1806.7922188948176, 1810.3030333321701, 1825.3520000399933, 1834.8623853210995, 1870.0, 1905.7617797775279, 1906.5138389710673, 1910.3122875764714, 1928.5757133430623, 6476.514261430364, 6520.978496666049, 6585.736570537173, 6592.901106483407, 6606.108175396356, 3798.962010379916, 3880.72834901557, 3881.514810648669, 3907.2380885727293, 3960.722749407543, 2449.5223431430877, 2465.4452748131707, 2471.456279618481, 2491.5141547398266, 2491.8878650460592, 740.9147947985997, 759.9164091949881, 769.9384049276044, 772.1005029141044, 773.7253275087319, 8528.104549022326, 8551.315894728406, 8649.524276164808, 8662.13378662135, 8679.652813887436, 3508.614052454228, 3531.9823400883347, 3566.0906468850276, 3634.9818250908575, 3703.185299234164, 7437.665305061285, 7438.5536867788105, 7446.0, 7469.551826890404, 7527.247275272429, 3974.463447434617, 3994.5206575210577, 4016.7991600419864, 4019.8593049243136, 4029.7985100744845, 3321.4353559894876, 3437.6906078453057, 3646.052026473083, 3674.81625918703, 3715.0898029982827, 2988.925276868096, 3067.708567686066, 3094.210976201054, 3127.343257915863, 3133.2480204750696, 1008.0423597582326, 1014.7666036811574, 1017.5421060522795, 1029.264076185531, 1034.829253173218, 883.8143989762222, 889.4752096263236, 893.5800173918248, 940.7036783413203, 1088.711491454765, 6223.0354295084335, 6223.37766223374, 6252.437280644764, 6296.65368404733, 6314.55798094129, 965.546193289167, 967.1682353176262, 980.5832521178471, 981.764376549623, 1009.2682804966487, 4839.2983017462275, 4921.926171107436, 4926.531979461945, 4939.456659767423, 4970.776315065831, 7566.621668916532, 7628.122765881994, 7758.650860711282, 7763.0, 7778.455508114378, 7697.846043079107, 7714.421418393531, 7747.651355689008, 7763.650635721406, 7815.765527034198, 5841.912371314434, 6067.575269731165, 6160.199174107337, 6164.445199931938, 6178.443940045418, 6109.480694141048, 6151.415615516519, 6168.321484636776, 6196.132541444112, 6210.689465526796, 6905.585664860125, 6983.9650801745665, 7059.223485416703, 7069.363757261871, 7088.539244949062, 6829.965850170717, 6925.445964322943, 7155.534890232118, 7179.353858152791, 7199.71201151948, 5325.387580428301, 5441.809536666197, 5763.596548241583, 5911.054231322968, 5912.526997840077, 5976.910346344721, 6156.876862462636, 6165.784197553064, 6176.4441200292185, 6188.226471691039, 5681.488666020078, 5782.277215348082, 5856.0, 5870.0607902735355, 5910.704464776658, 5682.801101961411, 5711.200431939615, 5716.342620598684, 5748.913766293425, 5857.297124345106, 5791.681457519877, 5861.7655293787775, 5862.794802181903, 5869.266341707286, 5923.4076592340425, 5272.78908843642, 5279.498447647467, 5284.837335786121, 5319.734013299397, 5337.066013447554, 5407.891842163213, 5467.58993075513, 5490.423505531861, 5497.257870187474, 5531.640443371168], "ext.html": [459.74943655707636, 472.4566748239524, 473.3704173449313, 486.5110563883298, 499.59283184204895, 32889.0, 33310.33379332415, 33426.33147337052, 33470.99587012391, 33732.32535349292, 35182.29635407297, 36088.09779755508, 36172.45741313882, 36280.81859590698, 36320.45519317212, 7604.467687261894, 7751.263629955173, 7853.607319633996, 7877.094134174557, 7939.96030019852, 7648.541087534766, 7796.259355361231, 7819.0, 7865.134835168127, 7867.0952840423515, 7693.653785579662, 7758.418118641096, 7781.182975787546, 7868.606569671522, 7902.367810575169, 7811.648475818602, 7839.608019599054, 7847.9215207847765, 7848.803779905491, 7975.561344126071, 7544.094708634999, 7665.655045522909, 7702.152763196044, 7762.0, 7774.611269436506, 32559.348813023607, 33176.33647327064, 33325.0, 33398.16504587381, 33526.3294734104, 2600.466904284636, 2625.5799072148557, 2641.0, 2650.8144429889917, 3044.2845931206148, 22397.21609743651, 22519.21182758612, 22664.54670906589, 23209.0, 23740.69426181559, 1943.5141214696325, 2009.2867032203649, 2011.8189362957405, 2018.7678416982087, 2124.6281900667477, 230492.0, 232502.0, 235027.0, 235355.0, 237620.81189594115, 42625.360619590734, 44846.77576612096, 52166.21750673743, 55007.72496137494, 56648.43351566514, 52323.0, 52568.474315257125, 52949.47050529523, 53150.734246328524, 53300.73349633227, 11429.771404571862, 11517.712057198469, 11526.654200373834, 11612.88387116135, 11632.476538555786, 8560.743177704679, 8627.913720862836, 8664.740057798275, 8706.564671766386, 8706.825863482694, 17334.30662773475, 17646.0, 17746.645067098587, 17851.46445606634, 17993.10034498296, 7113.386117472202, 7388.493019258248, 7422.406207503387, 7478.962605186939, 7494.1381741099385, 770.6146926536732, 790.9802254943558, 848.804774901776, 906.4787747045475, 913.48388160689, 23375.0, 23723.0, 23795.0, 23812.715006924886, 23888.64167037461, 857.6183598298697, 877.2061284537376, 901.9819603607891, 940.3182692547985, 1006.8389057750725, 12228.510859565518, 12399.194052386567, 13526.526571569948, 14089.647758806112, 14268.286585670676, 599702.0, 600439.0, 615577.0, 615800.0, 616685.0, 48667.75666121647, 48692.0, 48709.26936095962, 48925.51074489281, 49397.50602493929, 1116.240956149826, 1130.3387518301722, 1141.2467771270922, 1145.0782120393164, 1154.8671902731126, 24659.753402466464, 25319.620205697298, 25351.492970140123, 25465.363365916, 25677.743222568282, 41201.79399102985, 41219.1756164869, 41277.174456511304, 41290.0, 41430.585694142675, 239002.0, 239948.0, 241930.0, 242149.0, 243162.0, 24688.50622987566, 36635.81682091572, 38839.0, 38889.22221555497, 39167.60832391639, 35747.46378804268, 36064.63935360613, 36340.81829590835, 37289.25421491501, 37632.623673762915, 28811.85594072016, 30366.696333036387, 30450.69549304567, 30854.382912341178, 30917.381652367276, 29487.0, 29508.262293442836, 29558.113256602337, 29657.110286691433, 29704.702952970194, 29415.26461838471, 29896.701032990262, 30278.243043924078, 30594.388112238077, 31304.373912521165, 25522.872385637955, 29010.419791604472, 29030.7096929028, 29319.12042638639, 29471.11586652404, 20428.489287767923, 20464.181432742524, 20494.590108197455, 20655.896720516303, 20767.273145440442], "prototype.html": [267.0825713673532, 269.8407939315803, 270.714396311891, 273.9986300068499, 274.59634337523835, 5074.822381216649, 5186.11835987882, 5220.504052115052, 5253.133233016557, 5318.441563635821, 5002.949970500294, 5066.898662026766, 5107.821226257081, 5128.666636668614, 5200.2459643351785, 3868.9940615440046, 3993.700472464562, 4002.539707933581, 4003.0, 4020.7386519876113, 3959.0696186396317, 3970.126572154136, 3972.2055588882195, 4002.239574480839, 4040.8585699500522, 3914.3149948758996, 3915.847815692674, 3923.941140882889, 3973.46358241638, 3987.8803635890827, 3960.8613698520558, 3991.2416640838437, 3993.1614360984227, 4006.3990401439873, 4022.3966405039187, 3435.6736110069755, 3437.7077948374417, 3457.7406694498013, 3478.1478537758157, 3497.667721566447, 4821.108095002401, 4924.556789888928, 4994.525520075587, 5022.42242142151, 5095.566876815476, 4359.869203923888, 4410.75740834254, 4420.778961051967, 4461.397711308997, 4468.620167285784, 5388.326459192601, 5400.432954539756, 5413.918791218135, 5418.241446197536, 5443.891122177574, 3667.5782285037294, 3668.944965825515, 3671.7980511071883, 3689.94465083024, 3741.2330472253125, 5453.345598528163, 5597.580181486404, 5604.355499117612, 5624.91562626561, 5679.716014199274, 3619.8009109498703, 3630.2557975615464, 3640.0899775056237, 3642.307961487309, 3661.1579336752698, 3712.387456069718, 3724.1992971511254, 3733.178700685845, 3759.9060023499633, 3761.981190094032, 4334.674899382559, 4349.934750978738, 4353.0423306872435, 4358.0, 4377.993061595851, 5105.744712764347, 5219.19102539107, 5451.155070964007, 5475.014497390508, 5491.835244942658, 1315.9473621055051, 1337.1776357540043, 1343.8454577723687, 1355.728854229158, 1359.184489306428, 830.7923019245188, 851.3019324154134, 866.2896424931622, 866.657670220272, 870.5429649433971, 5037.596992240612, 5043.470435604208, 5071.264666623319, 5085.618578606619, 5101.846944591668, 5505.504504594605, 5511.972440137773, 5555.194496797942, 5590.077637189818, 5723.141528770718, 5112.207607820794, 5126.307948426989, 5127.769250383742, 5134.2298655201275, 5157.174852023658, 3020.4865172920654, 3067.831269280211, 3079.630444346693, 3112.25305926576, 3126.765492588065, 5746.511546518509, 5761.48146666802, 5774.855628609234, 5805.332386775491, 5815.156802263648, 5782.797602083907, 5785.1611516329895, 5791.160281759206, 5828.271466066742, 5847.853803654858, 5731.914021289684, 5760.884782304247, 5788.27646544182, 5844.678542680108, 5898.085796701518, 5517.69652669107, 5660.85847853807, 5662.85842853932, 5705.515031222392, 5710.200571919851, 5544.168374743821, 5549.417311182267, 5554.2779438672715, 5565.248691426767, 5593.888122237614, 5764.048931926185, 5780.335261444988, 5798.913016304675, 5808.041673123887, 5859.0, 3724.8137593119695, 3774.698024158116, 3820.331441997695, 3830.3488406970323, 3860.652541271299, 5526.392096869422, 5574.749136288958, 5586.469285417878, 5662.037453632975, 5675.631083979528, 5461.918071228855, 5466.972665136808, 5507.284053073075, 5541.861453463695, 5576.191452239484, 5475.972620136874, 5493.615446918678, 5508.724563771875, 5547.722613869371, 5550.611457197957, 5190.247414125006, 5358.410574836843, 5362.70505122222, 5380.569554435714, 5465.180222966586, 5560.054790685674, 5564.527015203753, 5590.217369568345, 5604.467575580314, 5614.606977511535, 5455.918161227505, 5458.8908221834545, 5460.781568737206, 5511.22842802, 5563.721813909207], "yui.html": [552.3427121725147, 555.5694336888911, 560.1150182711317, 627.7426255235355, 644.8907878449066, 11064.834027489584, 11357.943210283936, 11472.827907581393, 11498.712532186699, 11599.014083802876, 10565.577376904934, 10761.78476430471, 10831.458427078634, 11914.404279785998, 11949.864762847516, 745.3962290544649, 748.6144635512716, 769.4844454215661, 771.3713323641242, 772.9652165652531, 769.8113962079299, 770.5222761887637, 771.6296177834643, 772.0542335638854, 776.8679324514846, 798.2217338095369, 799.4044436894521, 801.6032064128235, 803.2008151888849, 807.261355859388, 790.3637571754736, 797.3182928596083, 799.2726618776943, 805.6817557064956, 806.2824086562964, 586.0184191479298, 590.5157770628086, 592.8162269696408, 593.5459373579215, 597.7160848596882, 11337.206395552315, 11425.542978280859, 11447.08423326132, 11512.884871151266, 11541.884581154249, 9612.567434465465, 9677.661281855171, 9717.076877696607, 9879.950600247024, 9947.651832185838, 7873.724419645342, 7896.60516974149, 7944.0, 8216.0, 8503.362247831437, 2470.2275967944624, 2616.3851494898686, 2802.187365663955, 2826.802123851331, 2866.0685277284965, 36081.09797255063, 36839.99999999973, 36904.261914761555, 38397.0, 39412.21175576472, 5708.20085188074, 5813.651180929158, 5814.186013957965, 5820.185174075633, 6030.125631783367, 9708.951455242819, 9790.118889299998, 9806.75483112928, 9812.411255324703, 9821.214302855755, 5221.869453263699, 5236.790528378822, 5290.074237008585, 5487.780488780484, 5492.148716948879, 2968.0912705548685, 3203.967960320367, 3256.495243237302, 3288.901332960015, 3316.121227874615, 2248.2805502239453, 2276.840621156503, 2279.3845661671257, 2279.8746068966366, 2318.652202169654, 341.89743077076776, 342.75835535947095, 353.00804738684377, 353.3180960745734, 357.303258645642, 395.37530701491573, 425.7892343290091, 491.9877003074952, 497.4329264638315, 535.2559941681067, 6115.755369785159, 6345.730853829253, 6372.7132279047555, 6545.0, 6668.499862510331, 391.44610376317763, 427.938711994256, 482.17788670317026, 496.2457065260783, 503.8261799679178, 3047.817130972149, 3062.969370306313, 3087.2590578261056, 3140.654528001918, 3170.144061103489, 48173.0, 49115.0, 49183.60613120343, 49245.0, 49955.0, 41079.58920410758, 42038.0, 42044.36933446001, 42164.0, 44650.33024504635, 35944.281114378085, 39493.60506394899, 40110.79944600317, 40349.59650403458, 41125.1774964505, 6594.10979517759, 6675.7997260082275, 6789.864202716017, 6831.897521537082, 6918.5502942308585, 30581.694183057883, 31214.843925781133, 31248.0, 31503.684963150074, 31528.684713152576, 36345.81827090848, 37336.81331593324, 38485.42271865868, 40865.79567102146, 41365.172696546506, 6246.406591373812, 6253.187085678833, 6317.652529110943, 6377.107204991212, 6379.2344918608205, 9207.309451791009, 9492.477913714813, 9494.287928405536, 9719.46542940145, 9813.607455701693, 8464.44981076228, 8903.821923561363, 9047.547622618975, 9061.093890610886, 9217.400868943765, 8570.228679418882, 8920.018797932353, 9130.452172869649, 9146.49694266795, 9286.767830804014, 9004.50475223869, 9004.819903602021, 9134.58894349769, 9221.631134754534, 9521.761955951157, 7517.962410187914, 7726.3818894487185, 7749.65126569317, 8035.477693949874, 8124.675012999413, 6746.8650626988165, 7050.647467626701, 7113.0, 7371.299726525972, 7564.281393267631]}, "summary": {"lowerIsBetter": false, "suite": 5647.301299213745, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6005.7672301795055, "unit": "ms", "value": 6005.7672301795055}, "dojo.html": {"lowerIsBetter": false, "filtered": 4472.960032736556, "unit": "ms", "value": 4472.960032736556}, "mootools.html": {"lowerIsBetter": false, "filtered": 3743.1519069652986, "unit": "ms", "value": 3743.1519069652986}, "ext.html": {"lowerIsBetter": false, "filtered": 16039.392966359826, "unit": "ms", "value": 16039.392966359826}, "prototype.html": {"lowerIsBetter": false, "filtered": 4077.9761526080033, "unit": "ms", "value": 4077.9761526080033}, "yui.html": {"lowerIsBetter": false, "filtered": 4931.358089820077, "unit": "ms", "value": 4931.358089820077}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0090.e"}, "testrun": {"date": 1447073147, "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": "45.0a1", "id": "20151108234235", "branch": "Mozilla-Inbound", "revision": "0789611bc5e98b2fd533e7dabff7041ac06873d9"}}, {"talos_counters": {}, "results": {"audio-dft": [209.0, 210.0, 209.0, 204.0, 203.0, 204.0, 203.0, 202.0, 205.0, 206.0], "ai-astar": [133.0, 124.0, 134.0, 144.0, 140.0, 146.0, 135.0, 135.0, 135.0, 134.0], "imaging-gaussian-blur": [144.0, 143.0, 157.0, 146.0, 143.0, 143.0, 149.0, 157.0, 146.0, 143.0], "audio-beat-detection": [188.0, 166.0, 197.0, 209.0, 162.0, 180.0, 180.0, 165.0, 208.0, 165.0], "json-stringify-tinderbox": [80.0, 82.0, 84.0, 83.0, 88.0, 87.0, 91.0, 88.0, 83.0, 87.0], "stanford-crypto-pbkdf2": [189.0, 203.0, 192.0, 192.0, 201.0, 188.0, 192.0, 190.0, 192.0, 192.0], "json-parse-financial": [69.0, 73.0, 79.0, 77.0, 79.0, 77.0, 78.0, 87.0, 81.0, 80.0], "stanford-crypto-sha256-iterative": [85.0, 87.0, 89.0, 90.0, 93.0, 91.0, 91.0, 93.0, 97.0, 90.0], "audio-fft": [88.0, 95.0, 100.0, 155.0, 84.0, 86.0, 89.0, 88.0, 127.0, 80.0], "imaging-darkroom": [156.0, 165.0, 161.0, 155.0, 157.0, 157.0, 165.0, 163.0, 157.0, 155.0], "stanford-crypto-ccm": [159.0, 159.0, 161.0, 160.0, 171.0, 161.0, 151.0, 157.0, 162.0, 158.0], "audio-oscillator": [105.0, 110.0, 154.0, 117.0, 115.0, 113.0, 152.0, 109.0, 108.0, 157.0], "stanford-crypto-aes": [105.0, 106.0, 121.0, 112.0, 113.0, 111.0, 109.0, 106.0, 109.0, 113.0], "imaging-desaturate": [130.0, 133.0, 133.0, 136.0, 134.0, 139.0, 138.0, 130.0, 128.0, 134.0]}, "summary": {"lowerIsBetter": true, "suite": 1903.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 99.2, "unit": "ms", "value": 99.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 193.1, "unit": "ms", "value": 193.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 182.0, "unit": "ms", "value": 182.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 159.9, "unit": "ms", "value": 159.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 159.1, "unit": "ms", "value": 159.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 78.0, "unit": "ms", "value": 78.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 124.0, "unit": "ms", "value": 124.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 136.0, "unit": "ms", "value": 136.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 205.5, "unit": "ms", "value": 205.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 90.6, "unit": "ms", "value": 90.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 85.3, "unit": "ms", "value": 85.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 110.5, "unit": "ms", "value": 110.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 133.5, "unit": "ms", "value": 133.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0090.e"}, "testrun": {"date": 1447073147, "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": "45.0a1", "id": "20151108234235", "branch": "Mozilla-Inbound", "revision": "0789611bc5e98b2fd533e7dabff7041ac06873d9"}}, {"talos_counters": {}, "results": {"DeltaBlue": [234.52157598499062], "Encrypt": [385.35645472061657], "NavierStokes": [6849.315068493151], "Decrypt": [6843.5374149659865], "Splay": [811.0300081103001], "Richards": [872.6003490401396], "RegExp": [38018.8679245283], "Earley": [929.368029739777], "Boyer": [15400.0], "RayTrace": [1367.9890560875513]}, "summary": {"lowerIsBetter": false, "suite": 13985.979193053427, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 281.9271519999999, "unit": "score", "value": 281.9271519999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 690.7396950000002, "unit": "score", "value": 690.7396950000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 216.66400000000004, "unit": "score", "value": 216.66400000000004}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.89523558648112, "unit": "score", "value": 38.89523558648112}, "Splay": {"lowerIsBetter": false, "filtered": 100.47840299999996, "unit": "score", "value": 100.47840299999996}, "RegExp": {"lowerIsBetter": false, "filtered": 23.961392059553358, "unit": "score", "value": 23.961392059553358}, "Richards": {"lowerIsBetter": false, "filtered": 40.456091999999984, "unit": "score", "value": 40.456091999999984}, "Earley": {"lowerIsBetter": false, "filtered": 717.1141880000002, "unit": "score", "value": 717.1141880000002}, "Boyer": {"lowerIsBetter": false, "filtered": 43.27681818181816, "unit": "score", "value": 43.27681818181816}, "RayTrace": {"lowerIsBetter": false, "filtered": 540.9319589999998, "unit": "score", "value": 540.9319589999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0090.e"}, "testrun": {"date": 1447073147, "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": "45.0a1", "id": "20151108234235", "branch": "Mozilla-Inbound", "revision": "0789611bc5e98b2fd533e7dabff7041ac06873d9"}}] 05:06:03 INFO - RETURN: dromaeo_css: 5647.30 05:06:03 INFO - RETURN: kraken: 1903.80 05:06:03 INFO - RETURN: v8_7: 13985.98 05:06:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "13985.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1903.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5647.30"}}} 05:06:03 INFO - Return code: 0 05:06:03 INFO - # TBPL SUCCESS # 05:06:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:06:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:06:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:06:03 INFO - 2015-11-09 05:06:03.804 screenresolution[2526:71985] starting screenresolution argv=screenresolution get 05:06:03 INFO - 2015-11-09 05:06:03.808 screenresolution[2526:71985] Display 0: 1600x1200x32@60 05:06:03 INFO - 2015-11-09 05:06:03.815 screenresolution[2527:71988] starting screenresolution argv=screenresolution list 05:06:03 INFO - Available Modes on Display 0 05:06:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:06:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:06:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:06:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:06:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:06:04 INFO - Intel HD Graphics 3000: 05:06:04 INFO - Chipset Model: Intel HD Graphics 3000 05:06:04 INFO - Type: GPU 05:06:04 INFO - Bus: Built-In 05:06:04 INFO - VRAM (Total): 512 MB 05:06:04 INFO - VRAM (Dynamic, Max): 10 05:06:04 INFO - Vendor: Intel (0x8086) 05:06:04 INFO - Device ID: 0x0116 05:06:04 INFO - Revision ID: 0x0009 05:06:04 INFO - Displays: 05:06:04 INFO - Display: 05:06:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:06:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:06:04 INFO - Display Serial Number: 1600x1200 60 05:06:04 INFO - Main Display: Yes 05:06:04 INFO - Mirror: Off 05:06:04 INFO - Online: Yes 05:06:04 INFO - Rotation: Supported 05:06:04 INFO - Return code: 0 05:06:04 INFO - Running post-action listener: _resource_record_post_action 05:06:04 INFO - Running post-run listener: _resource_record_post_run 05:06:05 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 110592; Write bytes: 690336768; Read time: 37; Write time: 59492 05:06:05 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 336333312; Write bytes: 334592000; Read time: 36939; Write time: 4336 05:06:05 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 110592; Write bytes: 344550400; Read time: 37; Write time: 54357 05:06:05 INFO - Running post-run listener: _upload_blobber_files 05:06:05 INFO - Blob upload gear active. 05:06:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:06:05 INFO - Copying logs to upload dir... 05:06:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1315.923735 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-11-09 05:06:05.258322) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-09 05:06:05.262033) ========= 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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/uH1MGVo7RTSPRF8OQCcrPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-09 05:06:05.291396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 05:06:05.292028) ========= 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.kdC7DzSpIJ/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.FjmUh6gHYN/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.005763 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 05:06:05.341316) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-09 05:06:05.341634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-09 05:06:05.342023) ========= ========= Total master_lag: 0.24 =========