CMK version: 2.2.0.p31
OS version: windows 10 (client)
Problem
Local Check ist not executed.
Description
I have lots of experience with monitoring linux with check-mk but very little experience monitoring windows. I read through the documentation for the local checks and the windows agent at the checkmk documentation.
My Windows Agent configuration file c:\programdata\checkmk\agent\check_mk.user.yml:
global:
logging:
debug: yes
windbg: yes
eventlog: yes
max_file_count: 5 # log rotation files quantity, allowed 1..1024
max_file_size: 8000000 # allowed 200K..200MB
ps:
winperf:
counters:
fileinfo:
path:
logwatch:
logfile:
plugins:
local:
execution:
- pattern : 'c:\\programmdata\\checkmk\\agent\\ck\\check-internet.ps1'
run : yes
mrpe:
config:
modules:
enabled: yes
system:
enabled: yes
It’s basically the default file with comments removed and extended with my own local check definition. What I am wondering is, that the documentation states the file name check_mk.user.yaml and the file existing file is check_mk.user.yml. Before having that clear I have two identical files with both names.
Now I have a simple powershell-check, that checks if the monitored host has a working internet connection:
check-internet.ps1
try {
$response = Invoke-WebRequest -Uri "https://www.google.de" -UseBasicParsing -TimeoutSec 10
if ($response.StatusCode -eq 200) {
echo "1 internet_access - internet access is active (!) $((Get-Date).ToString("HH:mm:ss"))"
} else {
echo "0 internet_access - internet access not active $((Get-Date).ToString("HH:mm:ss"))"
}
}
catch {
echo "0 internet_access - internet access not active - error executing the website $((Get-Date).ToString("HH:mm:ss"))"
}
When I put the script into the file c:\programmdata\checkmk\agent\ck\check-internet.ps1 it is not executed. When I put the script into the file c:\programmdata\checkmk\agent\local\check-internet.ps1 it is executed. I do not see anything useful within the agent log (c:\programdata\checkmk\agent\log\check_mk.log).
Why is my local check not executed at the custom location?
The problem is that I want the local check to be run once per 4 hours and not every minute, so I need the individual configuration.
It seems, that the agent does not use my config. Is my config file wrong? What can be the problem?
Update: Log File
Here’s the last log part of the agent log file: check_mk.log. I’m figuring out that the user config is successfully loaded but no local check is executed.
2024-09-24 17:30:42.726 [srv 5536] Initiating stop routine...
2024-09-24 17:30:42.726 [srv 5536] Stop Service called
2024-09-24 17:30:42.727 [srv 5536] [Trace] Stop request is set
2024-09-24 17:30:42.727 [srv 5536] [Trace] main Wait Loop END
2024-09-24 17:30:42.728 [srv 5536] Shutting down IO...
2024-09-24 17:30:42.728 [srv 5536] [Trace] Stopping execution
2024-09-24 17:30:42.929 [srv 5536] Exiting process queue
2024-09-24 17:30:42.930 [srv 5536] IO ends...
2024-09-24 17:30:42.931 [srv 5536] Thread is stopped
2024-09-24 17:30:42.932 [srv 5536] Processing dir 'C:\ProgramData\checkmk\agent\bin'
2024-09-24 17:30:42.981 [srv 5536] Killing process 'C:\ProgramData\checkmk\agent\bin\cmk-agent-ctl.exe'
2024-09-24 17:30:42.986 [srv 5536] Controller is deleted
2024-09-24 17:30:42.991 [srv 5536] Cleanup called by service
2024-09-24 17:30:42.992 [srv 5536] Processing dir 'C:\ProgramData\checkmk\agent'
2024-09-24 17:30:43.028 [srv 5536] Killed [0] processes from the user folder
2024-09-24 17:30:43.029 [srv 5536] Clean on exit was not requested, not uninstall sequence
2024-09-24 17:30:43.029 [srv 5536] Service is stopped normally
2024-09-24 17:30:43.031 [srv 5536] COM closed
2024-09-24 17:30:45.380 [srv 688] [Trace] Enabled Base
2024-09-24 17:30:45.385 [srv 688] [Trace] Setting root. service: 'CheckMkService', preset: ''
2024-09-24 17:30:45.385 [srv 688] [Trace] Try service: 'CheckMkService'
2024-09-24 17:30:45.386 [srv 688] [Trace] Try registry 'CheckMkService'
2024-09-24 17:30:45.386 [srv 688] [Trace] Service is found 'C:\Program Files (x86)\checkmk\service\check_mk_agent.exe'
2024-09-24 17:30:45.387 [srv 688] Set root 'C:\Program Files (x86)\checkmk\service' from registry 'CheckMkService'
2024-09-24 17:30:45.387 [srv 688] [Trace] Try registry 'CheckMkService'
2024-09-24 17:30:45.387 [srv 688] Protect file from User write 'C:\Program Files (x86)\checkmk\service\check_mk_agent.exe'
2024-09-24 17:30:45.388 [srv 688] Protect path from User access 'C:\Program Files (x86)\checkmk\service'
2024-09-24 17:30:45.388 [srv 688] Protect path from User access 'C:\ProgramData\checkmk'
2024-09-24 17:30:45.388 [srv 688] Protect path from User write 'C:\ProgramData\checkmk\agent'
2024-09-24 17:30:45.389 [srv 688] sid
2024-09-24 17:30:45.389 [srv 688] sid
2024-09-24 17:30:45.409 [srv 688] [Trace] Using root = 'C:\Program Files (x86)\checkmk\service' and data = 'C:\ProgramData\checkmk\agent' folders
2024-09-24 17:30:45.413 [srv 688] COM Initialized
2024-09-24 17:30:45.414 [srv 688] COM initialized
2024-09-24 17:30:45.415 [srv 688] Found root config on path C:\Program Files (x86)\checkmk\service\check_mk.yml
2024-09-24 17:30:45.426 [srv 688] [Trace] Enabled Debug
2024-09-24 17:30:45.426 [srv 688] Loaded start config 'C:\Program Files (x86)\checkmk\service\check_mk.yml','C:\ProgramData\checkmk\agent\bakery','C:\ProgramData\checkmk\agent\check_mk.user.yml'
2024-09-24 17:30:45.427 [srv 688] service to run
2024-09-24 17:30:45.429 [srv 688] Service Main
2024-09-24 17:30:45.429 [srv 688] Service handlers registered
2024-09-24 17:30:45.430 [srv 688] [Trace] Installing cap file 'C:\Program Files (x86)\checkmk\service\install\plugins.cap'
2024-09-24 17:30:45.431 [srv 688] Timestamp OK, checking file content...
2024-09-24 17:30:45.431 [srv 688] [Trace] Installing of CAP file is not required
2024-09-24 17:30:45.432 [srv 688] [Trace] Installing yml file 'C:\Program Files (x86)\checkmk\service\install\check_mk.install.yml'
2024-09-24 17:30:45.432 [srv 688] Target File 'C:\ProgramData\checkmk\agent\install\check_mk.install.yml' is absent, reinstall is mandatory
2024-09-24 17:30:45.433 [srv 688] Reinstalling 'C:\ProgramData\checkmk\agent\install\check_mk.install.yml' with 'C:\Program Files (x86)\checkmk\service\install\check_mk.install.yml'
2024-09-24 17:30:45.433 [srv 688] This Option/YML installation form MSI is ENABLED
2024-09-24 17:30:45.433 [srv 688] Remove 'C:\ProgramData\checkmk\agent\install\check_mk.install.yml' [OK]
2024-09-24 17:30:45.434 [srv 688] Supplied yaml 'C:\Program Files (x86)\checkmk\service\install\check_mk.install.yml' will not be installed
2024-09-24 17:30:45.435 [srv 688] [Trace] Copy file 'C:\Program Files (x86)\checkmk\service\install\checkmk.dat' to 'C:\ProgramData\checkmk\agent\install\checkmk.dat'
2024-09-24 17:30:45.435 [srv 688] Timestamp OK, checking file content...
2024-09-24 17:30:45.436 [srv 688] [Trace] Copy is not required, the file is already exists
2024-09-24 17:30:45.437 [srv 688] Skip installing user yml file
2024-09-24 17:30:45.437 [srv 688] Timestamp OK, checking file content...
2024-09-24 17:30:45.438 [srv 688] Starting upgrade(migration) process...
2024-09-24 17:30:45.439 [srv 688] [Trace] Legacy Agent not found Upgrade is not possible
2024-09-24 17:30:45.439 [srv 688] [Trace] trying path C:\Program Files (x86)\checkmk\service
2024-09-24 17:30:45.440 [srv 688] Found root config on path C:\Program Files (x86)\checkmk\service\check_mk.yml
2024-09-24 17:30:45.440 [srv 688] [Trace] Loading 'C:\Program Files (x86)\checkmk\service\check_mk.yml'
2024-09-24 17:30:45.444 [srv 688] [Trace] Loading 'C:\ProgramData\checkmk\agent\bakery\check_mk.bakery.yml'
2024-09-24 17:30:45.444 [srv 688] [Trace] C:\ProgramData\checkmk\agent\bakery\check_mk.bakery.yml is absent, return
2024-09-24 17:30:45.445 [srv 688] [Trace] Loading 'C:\ProgramData\checkmk\agent\check_mk.user.yml'
2024-09-24 17:30:45.449 [srv 688] [Trace] Target 'folders' is empty, overriding with source
2024-09-24 17:30:45.450 [srv 688] Loaded Config Files by Agent [2.2.0p31,64bit,release,Jul 15 2024,11:42:32] @ 'Win10-64 desktop'
root: 'C:\Program Files (x86)\checkmk\service\check_mk.yml' size=12750 [OK]
bakery: 'C:\ProgramData\checkmk\agent\bakery\check_mk.bakery.yml' size=0 [OK]
user: 'C:\ProgramData\checkmk\agent\check_mk.user.yml' size=1032 [OK]
2024-09-24 17:30:45.452 [srv 688] [Trace] Enabled Debug
2024-09-24 17:30:45.453 [srv 688] Loaded start config 'C:\Program Files (x86)\checkmk\service\check_mk.yml','C:\ProgramData\checkmk\agent\bakery','C:\ProgramData\checkmk\agent\check_mk.user.yml'
2024-09-24 17:30:45.453 [srv 688] [Trace] Successful start of thread
2024-09-24 17:30:45.455 [srv 688] The network is available
2024-09-24 17:30:45.456 [srv 688] starting controller
2024-09-24 17:30:45.457 [srv 688] try to kill
2024-09-24 17:30:45.457 [srv 688] Processing dir 'C:\ProgramData\checkmk\agent\bin'
2024-09-24 17:30:45.510 [srv 688] killed 0 processes in 'C:\ProgramData\checkmk\agent\bin'
2024-09-24 17:30:45.631 [srv 688] Agent controller 'C:\ProgramData\checkmk\agent\bin\cmk-agent-ctl.exe -vv daemon --agent-channel ms/Global\WinAgent_0' started pid [4900]
2024-09-24 17:30:45.668 [ctl:4900] [cmk_agent_ctl][INFO] starting
2024-09-24 17:30:45.699 [ctl:4900] [cmk_agent_ctl][INFO] Loaded config from '"C:\\ProgramData\\checkmk\\agent\\cmk-agent-ctl.toml"', connection registry from '"C:\\ProgramData\\checkmk\\agent\\registered_connections.json"'
2024-09-24 17:30:45.730 [ctl:4900] [cmk_agent_ctl::modes::daemon][INFO] Could not load pre-configured connections from "C:\\ProgramData\\checkmk\\agent\\pre_configured_connections.json": Das System kann die angegebene Datei nicht finden. (os error 2)
2024-09-24 17:30:45.761 [ctl:4900] [cmk_agent_ctl::misc][DEBUG] Sleeping 53s to avoid DDOSing of sites
2024-09-24 17:30:45.793 [ctl:4900] [cmk_agent_ctl::misc][DEBUG] Sleeping 9s to avoid DDOSing of sites
2024-09-24 17:30:45.823 [ctl:4900] [cmk_agent_ctl::modes::pull][INFO] Start listening for incoming pull requests
2024-09-24 17:30:45.854 [ctl:4900] [cmk_agent_ctl::modes::pull][INFO] Listening on [::]:6556 for incoming pull connections (IPv6 & IPv4 if activated)
2024-09-24 17:30:46.644 [srv 688] Controller has started: firewall to controller
2024-09-24 17:30:46.645 [srv 688] Firewall mode is set to configure, adding rule...
2024-09-24 17:30:46.646 [srv 688] Removing all 'Checkmk Agent' app: 'C:\ProgramData\checkmk\agent\bin\cmk-agent-ctl.exe'
2024-09-24 17:30:46.819 [srv 688] Removed 1 old rules.
2024-09-24 17:30:46.825 [srv 688] Firewall rule 'Checkmk Agent' had been added successfully for ports [6556]
2024-09-24 17:30:46.825 [srv 688] Reading module config normal
2024-09-24 17:30:46.826 [srv 688] Processed [1] module(s)
2024-09-24 17:30:46.826 [srv 688] Finding modules
2024-09-24 17:30:46.826 [srv 688] Module 'C:\Program Files (x86)\checkmk\service\install\python-3.cab' is added to the list
2024-09-24 17:30:46.827 [srv 688] Installing modules
2024-09-24 17:30:46.828 [srv 688] Install module python-3
2024-09-24 17:30:46.828 [srv 688] 'C:\ProgramData\checkmk\agent\install\modules\python-3.cab' is absent, no need to uninstall
2024-09-24 17:30:46.829 [srv 688] Installation of the module 'python-3' is not required, module file 'C:\Program Files (x86)\checkmk\service\install\python-3.cab'is absent or too short. Backup will be uninstalled
2024-09-24 17:30:46.829 [srv 688] Module 'python-3' has no package installed, this is normal
2024-09-24 17:30:46.829 [srv 688] [Warn ] Module 'python-3' has no package in backup dir 'C:\ProgramData\checkmk\agent\install\modules'
2024-09-24 17:30:46.830 [srv 688] sid
2024-09-24 17:30:46.830 [srv 688] sid
2024-09-24 17:30:46.831 [srv 688] Temp folder: C:\Windows\TEMP\cmk_service
2024-09-24 17:30:46.832 [srv 688] Pre Start actions
2024-09-24 17:30:46.833 [srv 688] [Warn ] OHM file 'C:\ProgramData\checkmk\agent\bin\OpenHardwareMonitorCLI.exe' is not found
2024-09-24 17:30:46.834 [srv 688] Allowed Extensions: [checkmk.py,py,exe,bat,vbs,cmd,ps1]
2024-09-24 17:30:46.834 [srv 688] [Trace] Left [36] files to execute
2024-09-24 17:30:46.839 [srv 688] [Trace] Left [0] files to execute in 'plugins'
2024-09-24 17:30:46.840 [srv 688] Allowed Extensions: [checkmk.py,py,exe,bat,vbs,cmd,ps1]
2024-09-24 17:30:46.841 [srv 688] [Trace] Left [36] files to execute
2024-09-24 17:30:46.845 [srv 688] [Trace] Left [0] files to execute in 'plugins'
2024-09-24 17:30:46.846 [srv 688] Allowed Extensions: [exe,bat,vbs,cmd,ps1]
2024-09-24 17:30:46.846 [srv 688] [Trace] Left [0] files to execute
2024-09-24 17:30:46.847 [srv 688] [Trace] Left [0] files to execute in 'local'
2024-09-24 17:30:46.847 [srv 688] Pre Start actions ended
2024-09-24 17:30:47.349 [srv 688] Waiting for async threads [0]
2024-09-24 17:30:47.350 [srv 688] Left async threads [0] after waiting 0ms
2024-09-24 17:30:47.351 [srv 688] Starting io with 0 4900
2024-09-24 17:30:47.353 [srv 688] main Wait Loop
2024-09-24 17:30:47.354 [srv 688] cma::world::ExternalPort::mailslotThreadProc: started
2024-09-24 17:30:47.356 [srv 688] Applying config auto restart_on_crash:true error_mode: log
2024-09-24 17:30:54.684 [ctl:4900] [cmk_agent_ctl::modes::renew_certificate][DEBUG] Checking registered connections for certificate expiry.
2024-09-24 17:31:07.579 [app 9108] [Trace] Enabled Base
2024-09-24 17:31:07.586 [app 9108] [Trace] Setting root. service: '', preset: ''
2024-09-24 17:31:07.587 [app 9108] Service '' not found
2024-09-24 17:31:07.587 [app 9108] [Trace] Try registry 'CheckMkService'
2024-09-24 17:31:07.588 [app 9108] Set root 'C:\Program Files (x86)\checkmk\service' from executable
2024-09-24 17:31:07.588 [app 9108] [Trace] Using root = 'C:\Program Files (x86)\checkmk\service' and data = 'C:\ProgramData\checkmk\agent' folders
2024-09-24 17:31:07.591 [app 9108] COM Initialized
2024-09-24 17:31:07.591 [app 9108] COM initialized
2024-09-24 17:31:07.591 [app 9108] Found root config on path C:\Program Files (x86)\checkmk\service\check_mk.yml
2024-09-24 17:31:07.598 [app 9108] [Trace] Enabled Debug
2024-09-24 17:31:07.599 [app 9108] Loaded start config 'C:\Program Files (x86)\checkmk\service\check_mk.yml','C:\ProgramData\checkmk\agent\bakery','C:\ProgramData\checkmk\agent\check_mk.user.yml'
2024-09-24 17:31:07.600 [app 9108] starting controller
2024-09-24 17:31:07.601 [app 9108] not allowed
2024-09-24 17:31:07.601 [app 9108] Controller has NOT started: firewall to agent
2024-09-24 17:31:07.601 [app 9108] Firewall mode is set to configure, adding rule...
2024-09-24 17:31:07.602 [app 9108] Removing all 'Checkmk Agent application' app: 'check_mk_agent.exe'
2024-09-24 17:31:07.728 [app 9108] Removed 1 old rules.
2024-09-24 17:31:07.733 [app 9108] Firewall rule 'Checkmk Agent application' had been added successfully for ports [6556]
2024-09-24 17:31:07.733 [app 9108] Loading module config
2024-09-24 17:31:07.734 [app 9108] Processed [1] module(s)
2024-09-24 17:31:07.734 [app 9108] Module 'python-3' has no package installed, this is normal
2024-09-24 17:31:07.735 [app 9108] [Warn ] Module 'python-3' has no package in backup dir 'C:\ProgramData\checkmk\agent\install\modules'
2024-09-24 17:31:07.735 [app 9108] Pre Start actions
2024-09-24 17:31:07.735 [app 9108] [Warn ] OHM file 'C:\ProgramData\checkmk\agent\bin\OpenHardwareMonitorCLI.exe' is not found
2024-09-24 17:31:07.736 [app 9108] Allowed Extensions: [checkmk.py,py,exe,bat,vbs,cmd,ps1]
2024-09-24 17:31:07.736 [app 9108] [Trace] Left [36] files to execute
2024-09-24 17:31:07.741 [app 9108] [Trace] Left [0] files to execute in 'plugins'
2024-09-24 17:31:07.742 [app 9108] Allowed Extensions: [checkmk.py,py,exe,bat,vbs,cmd,ps1]
2024-09-24 17:31:07.743 [app 9108] [Trace] Left [36] files to execute
2024-09-24 17:31:07.747 [app 9108] [Trace] Left [0] files to execute in 'plugins'
2024-09-24 17:31:07.748 [app 9108] Allowed Extensions: [exe,bat,vbs,cmd,ps1]
2024-09-24 17:31:07.749 [app 9108] [Trace] Left [0] files to execute
2024-09-24 17:31:07.750 [app 9108] [Trace] Left [0] files to execute in 'local'
2024-09-24 17:31:07.750 [app 9108] Pre Start actions ended
2024-09-24 17:31:08.265 [app 9108] Waiting for async threads [0]
2024-09-24 17:31:08.266 [app 9108] Left async threads [0] after waiting 0ms
2024-09-24 17:31:08.268 [app 9108] Started without IO. Debug mode
2024-09-24 17:31:08.269 [app 9108] [Trace] Provider 'wmi_cpuload' is direct called, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.372 [app 9108] [Trace] Found Name at 29
2024-09-24 17:31:08.373 [app 9108] [Trace] Found NumberOfLogicalProcessors at 32
2024-09-24 17:31:08.373 [app 9108] [Trace] Found NumberOfProcessors at 33
2024-09-24 17:31:08.658 [app 9108] [Trace] Sending data 'wmi_cpuload' id is [1054212304847300] length [245]
2024-09-24 17:31:08.658 [app 9108] perf: Section 'wmi_cpuload' took [388] milliseconds
2024-09-24 17:31:08.659 [app 9108] Received [373] bytes from 'wmi_cpuload'
2024-09-24 17:31:08.659 [app 9108] Using file 'C:\Program Files (x86)\checkmk\service\check_mk_agent.exe' for winperf
2024-09-24 17:31:08.660 [app 9108] [Trace] Provider 'uptime' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.660 [app 9108] [Trace] Loaded [3] entries in LogWatch
2024-09-24 17:31:08.660 [app 9108] [Trace] Sending data 'uptime' id is [1054212304847300] length [20]
2024-09-24 17:31:08.661 [app 9108] Exec 'C:\Program Files (x86)\checkmk\service\check_mk_agent.exe' for 'winperf' to be started
2024-09-24 17:31:08.661 [app 9108] [Trace] Provider 'df' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.662 [app 9108] perf: Section 'uptime' took [0] milliseconds
2024-09-24 17:31:08.662 [app 9108] Allowed Extensions: [checkmk.py,py,exe,bat,vbs,cmd,ps1]
2024-09-24 17:31:08.663 [app 9108] [Trace] Left [36] files to execute
2024-09-24 17:31:08.663 [app 9108] [Trace] Provider 'mem' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.664 [app 9108] [Trace] Sending data 'mem' id is [1054212304847300] length [225]
2024-09-24 17:31:08.664 [app 9108] perf: Section 'mem' took [0] milliseconds
2024-09-24 17:31:08.665 [app 9108] [Trace] Provider 'fileinfo' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.665 [app 9108] [Trace] Sending data 'fileinfo' id is [1054212304847300] length [34]
2024-09-24 17:31:08.666 [app 9108] [Trace] Provider 'ps' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.666 [app 9108] async RunStdCmd: "C:\Program Files (x86)\checkmk\service\check_mk_agent.exe" -runonce winperf mail:\\.\mailslot\Global\WinAgentApp_9108 id:1054212304847300 timeout:10 234:phydisk 510:if 238:processor
2024-09-24 17:31:08.668 [app 9108] [Trace] Left [0] files to execute in 'plugins'
2024-09-24 17:31:08.669 [app 9108] Allowed Extensions: [checkmk.py,py,exe,bat,vbs,cmd,ps1]
2024-09-24 17:31:08.669 [app 9108] [Trace] Left [0] files to execute
2024-09-24 17:31:08.670 [app 9108] Processed [1] fixed drives of total [2]
2024-09-24 17:31:08.670 [app 9108] [Trace] Sending data 'df' id is [1054212304847300] length [60]
2024-09-24 17:31:08.670 [app 9108] [Trace] Provider 'services' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.671 [app 9108] [Trace] Provider 'logwatch' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.671 [app 9108] [Trace] Left [0] files to execute in 'local'
2024-09-24 17:31:08.672 [app 9108] [Trace] Absent/Empty node mrpe.config type is Null
2024-09-24 17:31:08.673 [app 9108] perf: Section 'df' took [8] milliseconds
2024-09-24 17:31:08.673 [app 9108] [Trace] To start [0] sync plugins
2024-09-24 17:31:08.674 [app 9108] [Trace] Provider 'plugins' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.674 [app 9108] [Trace] Sending data 'plugins' id is [1054212304847300] length [13]
2024-09-24 17:31:08.675 [app 9108] perf: Section 'fileinfo' took [0] milliseconds
2024-09-24 17:31:08.675 [app 9108] perf: Section 'plugins' took [0] milliseconds
2024-09-24 17:31:08.676 [app 9108] [Trace] To start [0] sync plugins
2024-09-24 17:31:08.676 [app 9108] [Trace] Provider 'dotnet_clrmemory' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.677 [app 9108] [Trace] Provider 'wmi_webservices' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.677 [app 9108] [Trace] Provider 'local' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.678 [app 9108] [Err ] OpenService 'AppHostSvc' failed [1060]
2024-09-24 17:31:08.678 [app 9108] [Warn ] Section 'local' cannot provide data
2024-09-24 17:31:08.679 [app 9108] [Err ] OpenService 'WAS' failed [1060]
2024-09-24 17:31:08.679 [app 9108] [Trace] Sending data 'local' id is [1054212304847300] length [0]
2024-09-24 17:31:08.680 [app 9108] [Err ] OpenService 'W3SVC' failed [1060]
2024-09-24 17:31:08.680 [app 9108] perf: Section 'local' took [1] milliseconds
2024-09-24 17:31:08.681 [app 9108] [Warn ] Section 'wmi_webservices' cannot provide data
2024-09-24 17:31:08.681 [app 9108] [Trace] Sending data 'wmi_webservices' id is [1054212304847300] length [0]
2024-09-24 17:31:08.682 [app 9108] perf: Section 'wmi_webservices' took [4] milliseconds
2024-09-24 17:31:08.682 [app 9108] [Trace] Provider 'msexch' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.683 [app 9108] [Trace] Provider 'mrpe' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.683 [app 9108] [Warn ] Section 'mrpe' cannot provide data
2024-09-24 17:31:08.684 [app 9108] [Trace] Sending data 'mrpe' id is [1054212304847300] length [0]
2024-09-24 17:31:08.684 [app 9108] perf: Section 'mrpe' took [0] milliseconds
2024-09-24 17:31:08.684 [app 9108] [Trace] Provider 'skype' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.694 [app 9108] [Trace] Provider 'spool' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.704 [app 9108] Received [148] bytes from 'uptime'
2024-09-24 17:31:08.706 [app 9108] [Warn ] Section 'spool' cannot provide data
2024-09-24 17:31:08.720 [app 9108] [Trace] Key value cannot be processed 'LS:WEB - Address Book Web Query'
2024-09-24 17:31:08.720 [app 9108] [Trace] Sending data 'spool' id is [1054212304847300] length [0]
2024-09-24 17:31:08.721 [app 9108] perf: Section 'spool' took [15] milliseconds
2024-09-24 17:31:08.721 [app 9108] [Trace] Provider 'openhardwaremonitor' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.728 [app 9108] [Trace] Provider 'agent_plugins' is about to be started, id '1054212304847300' port [mail:\\.\mailslot\Global\WinAgentApp_9108]
2024-09-24 17:31:08.743 [app 9108] [Trace] Sending data 'agent_plugins' id is [1054212304847300] length [130]
2024-09-24 17:31:08.744 [app 9108] perf: Section 'agent_plugins' took [0] milliseconds
2024-09-24 17:31:08.745 [app 9108] Received [353] bytes from 'mem'
2024-09-24 17:31:08.750 [app 9108] [Trace] Key value cannot be processed 'LS:WEB - Address Book File Download'
2024-09-24 17:31:08.759 [app 9108] [Err ] Can't connect to the namespace Root\OpenHardwareMonitor 0X8004100E
2024-09-24 17:31:08.760 [app 9108] [Err ] WMI can't connect '"Root\OpenHardwareMonitor\Sensor"'
2024-09-24 17:31:08.760 [app 9108] [Err ] Error reading WMI [4] in 'openhardwaremonitor'
2024-09-24 17:31:08.761 [app 9108] [Warn ] Resetting time for earliest start of the section 'openhardwaremonitor' at '2024-09-24 18:31:082024-09-24 17:31:08.762 [app 9108] [Trace] No data for OHM, error number [1]
2024-09-24 17:31:08.762 [app 9108] [Warn ] Section 'openhardwaremonitor' cannot provide data
2024-09-24 17:31:08.762 [app 9108] [Trace] Sending data 'openhardwaremonitor' id is [1054212304847300] length [0]
2024-09-24 17:31:08.763 [app 9108] perf: Section 'openhardwaremonitor' took [41] milliseconds
2024-09-24 17:31:08.771 [app 9108] Received [162] bytes from 'fileinfo'
2024-09-24 17:31:08.772 [app 9108] [Trace] Sending data 'services' id is [1054212304847300] length [15854]
2024-09-24 17:31:08.773 [app 9108] perf: Section 'services' took [101] milliseconds
2024-09-24 17:31:08.779 [app 9108] [Trace] Key value cannot be processed 'LS:WEB - Location Information Service'
2024-09-24 17:31:08.797 [app 9108] [Trace] Sending data 'logwatch' id is [1054212304847300] length [159]
2024-09-24 17:31:08.798 [app 9108] perf: Section 'logwatch' took [126] milliseconds
2024-09-24 17:31:08.803 [app 9108] Received [188] bytes from 'df'
2024-09-24 17:31:08.816 [app 9108] [Trace] Sending data 'ps' id is [1054212304847300] length [13950]
2024-09-24 17:31:08.817 [app 9108] perf: Section 'ps' took [150] milliseconds
2024-09-24 17:31:08.818 [app 9108] [Trace] Key value cannot be processed 'LS:WEB - Distribution List Expansion'
2024-09-24 17:31:08.832 [app 9108] Received [141] bytes from 'plugins'
2024-09-24 17:31:08.842 [app 9108] [Trace] Key value cannot be processed 'LS:WEB - UCWA'
2024-09-24 17:31:08.859 [app 9108] [Trace] Key value cannot be processed 'LS:WEB - Mobile Communication Service'
2024-09-24 17:31:08.864 [app 9108] Received [128] bytes from 'local'
2024-09-24 17:31:08.876 [app 9108] [Trace] Key value cannot be processed 'LS:WEB - Throttling and Authentication'
2024-09-24 17:31:08.892 [app 9108] [Trace] Key value cannot be processed 'LS:WEB - Auth Provider related calls'
2024-09-24 17:31:08.896 [app 9108] Received [128] bytes from 'wmi_webservices'
2024-09-24 17:31:08.909 [app 9108] [Trace] Key value cannot be processed 'LS:SIP - Protocol'
2024-09-24 17:31:08.926 [app 9108] [Trace] Key value cannot be processed 'LS:SIP - Responses'
2024-09-24 17:31:08.928 [app 9108] Received [128] bytes from 'mrpe'
2024-09-24 17:31:08.942 [app 9108] [Trace] Key value cannot be processed 'LS:SIP - Peers'
2024-09-24 17:31:08.959 [app 9108] [Trace] Key value cannot be processed 'LS:SIP - Load Management'
2024-09-24 17:31:08.960 [app 9108] Received [128] bytes from 'spool'
2024-09-24 17:31:08.976 [app 9108] [Trace] Key value cannot be processed 'LS:SIP - Authentication'
2024-09-24 17:31:08.992 [app 9108] Received [258] bytes from 'agent_plugins'
2024-09-24 17:31:08.993 [app 9108] [Trace] Key value cannot be processed 'LS:CAA - Operations'
2024-09-24 17:31:09.009 [app 9108] [Trace] Key value cannot be processed 'LS:DATAMCU - MCU Health And Performance'
2024-09-24 17:31:09.024 [app 9108] Received [128] bytes from 'openhardwaremonitor'
2024-09-24 17:31:09.025 [app 9108] [Trace] Key value cannot be processed 'LS:AVMCU - MCU Health And Performance'
2024-09-24 17:31:09.041 [app 9108] [Trace] Key value cannot be processed 'LS:AsMcu - MCU Health And Performance'
2024-09-24 17:31:09.056 [app 9108] Received [15982] bytes from 'services'
2024-09-24 17:31:09.058 [app 9108] [Trace] Key value cannot be processed 'LS:ImMcu - MCU Health And Performance'
2024-09-24 17:31:09.075 [app 9108] [Trace] Key value cannot be processed 'LS:USrv - DBStore'
2024-09-24 17:31:09.088 [app 9108] Received [287] bytes from 'logwatch'
2024-09-24 17:31:09.092 [app 9108] [Trace] Key value cannot be processed 'LS:USrv - Conference Mcu Allocator'
2024-09-24 17:31:09.110 [app 9108] [Trace] Key value cannot be processed 'LS:JoinLauncher - Join Launcher Service Failures'
2024-09-24 17:31:09.120 [app 9108] Received [14078] bytes from 'ps'
2024-09-24 17:31:09.128 [app 9108] [Trace] Key value cannot be processed 'LS:MediationServer - Health Indices'
2024-09-24 17:31:09.145 [app 9108] [Trace] Key value cannot be processed 'LS:MediationServer - Global Counters'
2024-09-24 17:31:09.152 [app 9108] Received [3231] bytes from 'winperf'
2024-09-24 17:31:09.170 [app 9108] [Trace] Key value cannot be processed 'LS:MediationServer - Global Per Gateway Counters'
2024-09-24 17:31:09.189 [app 9108] [Trace] Key value cannot be processed 'LS:MediationServer - Media Relay'
2024-09-24 17:31:09.207 [app 9108] [Trace] Key value cannot be processed 'LS:A/V Auth - Requests'
2024-09-24 17:31:09.229 [app 9108] [Trace] Key value cannot be processed 'LS:DATAPROXY - Server Connections'
2024-09-24 17:31:09.246 [app 9108] [Trace] Key value cannot be processed 'LS:XmppFederationProxy - Streams'
2024-09-24 17:31:09.263 [app 9108] [Trace] Key value cannot be processed 'LS:A/V Edge - TCP Counters'
2024-09-24 17:31:09.280 [app 9108] [Trace] Key value cannot be processed 'LS:A/V Edge - UDP Counters'
2024-09-24 17:31:09.281 [app 9108] [Warn ] Section 'skype' cannot provide data
2024-09-24 17:31:09.281 [app 9108] [Trace] Sending data 'skype' id is [1054212304847300] length [0]
2024-09-24 17:31:09.282 [app 9108] perf: Section 'skype' took [596] milliseconds
2024-09-24 17:31:09.312 [app 9108] Received [128] bytes from 'skype'
2024-09-24 17:31:13.698 [app 9108] [Err ] Timeout [5] seconds broken when query WMI
2024-09-24 17:31:13.699 [app 9108] [Warn ] Object 'Win32_PerfRawData_NETFramework_NETCLRMemory' in 5021ms sends NO DATA
2024-09-24 17:31:13.699 [app 9108] [Warn ] On timeout in section 'dotnet_clrmemory' try reuse cache
2024-09-24 17:31:13.700 [app 9108] [Trace] cma::provider::WmiCachedDataHelper: no data to provide, cache is also empty
2024-09-24 17:31:13.700 [app 9108] [Warn ] Section 'dotnet_clrmemory' cannot provide data
2024-09-24 17:31:13.701 [app 9108] [Trace] Sending data 'dotnet_clrmemory' id is [1054212304847300] length [0]
2024-09-24 17:31:13.701 [app 9108] perf: Section 'dotnet_clrmemory' took [5024] milliseconds
2024-09-24 17:31:13.730 [app 9108] Received [128] bytes from 'dotnet_clrmemory'
2024-09-24 17:31:13.762 [app 9108] [Err ] Timeout [5] seconds broken when query WMI
2024-09-24 17:31:13.763 [app 9108] [Warn ] Object 'Win32_PerfRawData_MSExchangeActiveSync_MSExchangeActiveSync' in 5079ms sends NO DATA
2024-09-24 17:31:13.763 [app 9108] [Warn ] On timeout in sub section 'msexch_activesync' try reuse cache
2024-09-24 17:31:13.764 [app 9108] [Trace] cma::provider::WmiCachedDataHelper: no data to provide, cache is also empty
2024-09-24 17:31:14.321 [app 9108] [Warn ] Object 'Win32_PerfRawData_MSExchangeAvailabilityService_MSExchangeAvailabilityService' in 556ms sends NO DATA
2024-09-24 17:31:14.322 [app 9108] [Warn ] Sub Section 'msexch_availability' has no data to provide, status = [2]
2024-09-24 17:31:14.329 [app 9108] [Warn ] Object 'Win32_PerfRawData_MSExchangeOWA_MSExchangeOWA' in 7ms sends NO DATA
2024-09-24 17:31:14.330 [app 9108] [Warn ] Sub Section 'msexch_owa' has no data to provide, status = [2]
2024-09-24 17:31:14.337 [app 9108] [Warn ] Object 'Win32_PerfRawData_MSExchangeAutodiscover_MSExchangeAutodiscover' in 6ms sends NO DATA
2024-09-24 17:31:14.338 [app 9108] [Warn ] Sub Section 'msexch_autodiscovery' has no data to provide, status = [2]
2024-09-24 17:31:14.345 [app 9108] [Warn ] Object 'Win32_PerfRawData_MSExchangeISClientType_MSExchangeISClientType' in 6ms sends NO DATA
2024-09-24 17:31:14.346 [app 9108] [Warn ] Sub Section 'msexch_isclienttype' has no data to provide, status = [2]
2024-09-24 17:31:14.352 [app 9108] [Warn ] Object 'Win32_PerfRawData_MSExchangeISStore_MSExchangeISStore' in 5ms sends NO DATA
2024-09-24 17:31:14.353 [app 9108] [Warn ] Sub Section 'msexch_isstore' has no data to provide, status = [2]
2024-09-24 17:31:14.359 [app 9108] [Warn ] Object 'Win32_PerfRawData_MSExchangeRpcClientAccess_MSExchangeRpcClientAccess' in 5ms sends NO DATA
2024-09-24 17:31:14.359 [app 9108] [Warn ] Sub Section 'msexch_rpcclientaccess' has no data to provide, status = [2]
2024-09-24 17:31:14.360 [app 9108] [Warn ] Section 'msexch' cannot provide data
2024-09-24 17:31:14.360 [app 9108] [Trace] Sending data 'msexch' id is [1054212304847300] length [0]
2024-09-24 17:31:14.361 [app 9108] perf: Section 'msexch' took [5678] milliseconds
2024-09-24 17:31:14.363 [app 9108] Received [128] bytes from 'msexch'
2024-09-24 17:31:14.364 [app 9108] perf: Answer is ready in [6095] milliseconds