nutdotnet / WinNUT-Client

WinForms-based client for monitoring your Uninterruptible Power Supply (UPS) connected to a Network UPS Tools (NUT) server.
GNU General Public License v3.0
182 stars 18 forks source link

WinNUT cannot reconnect automatically after Windows wakes up from sleep. #162

Open timmyhbk opened 1 week ago

timmyhbk commented 1 week ago

WinNUT Version:
2.3.8892.21649 Windows OS Version: Windows 11 23H2 22631.3737

Describe the bug When Windows resumes from sleep, WinNUT cannot connect. Log stay on Try Reconnect 1 / 30. Need to manually reconnect to resume the connection.

To Reproduce Steps to reproduce the behavior:

  1. Connect WinNUT to the NUT server.
  2. Put Windows to sleep.
  3. Wake up Windows.
  4. See error.

Expected behavior WinNUT can automatically reconnect when Windows wakes up from sleep.

Screenshots If applicable, add screenshots to help explain your problem.

Additional context

  1. If it's a reboot. WinNUT can reconnect normally.
  2. WinNUT runs as administrator.

Log (I don't know how to get it to generate an English Log, so I've put an English translation below the text.)

2024/6/27 Thursday 下午 01:59:59 [2820, WinNUT]: PowerModeChangedEvent: Suspend
2024/6/27 Thursday 下午 02:00:00 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:38 [2820, UPS_Device]: Something went wrong in Retrieve_UPS_Datas:
2024/6/27 Thursday 下午 02:06:38 [2820, UPS_Device]: System.IO.IOException thrown in System
Message: 無法從傳輸連接讀取資料: 連線已被您主機上的軟體中止。。
(editor's notes: Unable to read data from the transport connection: The connection has been aborted by the software on your host.)
   At System.Net.Sockets.NetworkStream.Read(Byte[] buffer, Int32 offset, Int32 size)
   At System.IO.StreamReader.ReadBuffer()
   At System.IO.StreamReader.ReadLine()
   At WinNUT_Client_Common.Nut_Socket.Query_Data(String Query_Msg) At C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\Nut_Socket.vb: Line 237
   At WinNUT_Client_Common.UPS_Device.GetUPSVar(String varName, Object Fallback_value, Boolean recursing) At C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\UPS_Device.vb: Line 442
   At WinNUT_Client_Common.UPS_Device.Retrieve_UPS_Datas(Object sender, EventArgs e) At C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\UPS_Device.vb: Line 325

2024/6/27 Thursday 下午 02:06:38 [2820, UPS_Device]: Inner exception present:
2024/6/27 Thursday 下午 02:06:38 [2820, IOException]: System.Net.Sockets.SocketException thrown in System
Message: 連線已被您主機上的軟體中止。
(editor's notes: The connection has been aborted by the software on your host.)
   At System.Net.Sockets.Socket.Receive(Byte[] buffer, Int32 offset, Int32 size, SocketFlags socketFlags)
   At System.Net.Sockets.NetworkStream.Read(Byte[] buffer, Int32 offset, Int32 size)

2024/6/27 Thursday 下午 02:06:38 [2820, Logger]: Exception report complete.
2024/6/27 Thursday 下午 02:06:38 [2820, Logger]: Exception report complete.
2024/6/27 Thursday 下午 02:06:38 [2820, UPS_Device]: Processing request to disconnect...
2024/6/27 Thursday 下午 02:06:38 [2820, WinNUT]: Initializing all display values and configurations.
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: Update Icon
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: Status Icon Changed
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: New Icon Value For Systray : 1216
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: New Icon Value For Gui : 1216
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
Not Connected
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: Battery Status => Unknown
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: Disconnected from Nut Host
2024/6/27 Thursday 下午 02:06:39 [2820, String]: New Log to CB_Current Log : Disconnected from Nut Host
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: PowerModeChangedEvent: Resume
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: Restarting WinNUT after waking up from Windows
2024/6/27 Thursday 下午 02:06:39 [2820, String]: New Log to CB_Current Log : Restarting WinNUT after waking up from Windows.
2024/6/27 Thursday 下午 02:06:39 [2820, WinNUT]: Client UPS_Connect subroutine beginning.
2024/6/27 Thursday 下午 02:06:39 [2820, UPS_Device]: Beginning connection: upsmon@192.168.1.101:3493, Name: UPS [AutoReconnect]
2024/6/27 Thursday 下午 02:06:39 [2820, Nut_Socket]: Attempting TCP socket connection to 192.168.1.101:3493...
2024/6/27 Thursday 下午 02:06:39 [2820, Nut_Socket]: Connection established and streams ready for 192.168.1.101:3493
2024/6/27 Thursday 下午 02:06:39 [2820, Nut_Socket]: Attempting authentication...
2024/6/27 Thursday 下午 02:06:39 [2820, Nut_Socket]: Error while attempting to log in: ACCESSDENIED (ERR ACCESS-DENIED)
Query: USERNAME upsmon
2024/6/27 Thursday 下午 02:06:39 [2820, UPS_Device]: NUT protocol error encoutnered:
WinNUT_Client_Common.NutException: ACCESSDENIED (ERR ACCESS-DENIED)
Query: VER
   At WinNUT_Client_Common.Nut_Socket.Query_Data(String Query_Msg) At C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\Nut_Socket.vb: Line 247
   At WinNUT_Client_Common.Nut_Socket.Connect() At C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\Nut_Socket.vb: Line 120
   At WinNUT_Client_Common.UPS_Device.Connect_UPS(Object retryOnConnFailure) At C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\UPS_Device.vb: Line 152
2024/6/27 Thursday 下午 02:06:39 [2820, UPS_Device]: Socket has reported a Broken event.
2024/6/27 Thursday 下午 02:06:39 [2820, UPS_Device]: Reconnection Process Started
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Try Reconnect 1 / 30
2024/6/27 Thursday 下午 02:06:44 [2820, String]: New Log to CB_Current Log : Try Reconnect 1 / 30
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Beginning connection: upsmon@192.168.1.101:3493, Name: UPS [AutoReconnect]
2024/6/27 Thursday 下午 02:06:44 [2820, Nut_Socket]: Attempting TCP socket connection to 192.168.1.101:3493...
2024/6/27 Thursday 下午 02:06:44 [2820, Nut_Socket]: Connection established and streams ready for 192.168.1.101:3493
2024/6/27 Thursday 下午 02:06:44 [2820, Nut_Socket]: Attempting authentication...
2024/6/27 Thursday 下午 02:06:44 [2820, Nut_Socket]: Error while attempting to log in: INVALIDARGUMENT (ERR INVALID-ARGUMENT)
Query: LOGIN
2024/6/27 Thursday 下午 02:06:44 [2820, Nut_Socket]: NUT server reports VER: DSM7-2-1-NewModel-repack-64570-230831 NETVER: 1.2
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Retrieving basic UPS product information...
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: ups.serial is not supported by server.
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Apply Fallback Value when retrieving ups.serial
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: ups.firmware is not supported by server.
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Apply Fallback Value when retrieving ups.firmware
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Initializing other well-known UPS variables...
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: output.current is not supported by server.
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: output.voltage: 110
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: output.realpower is not supported by server.
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Determining best method to calculate power usage...
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: ups.realpower is not supported by server.
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Using RPNomLoadPct method.
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: battery.capacity is not supported by server.
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Apply Fallback Value when retrieving battery.capacity
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: output.frequency.nominal is not supported by server.
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Apply Fallback Value when retrieving output.frequency.nominal
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Completed retrieval of basic UPS product information.
2024/6/27 Thursday 下午 02:06:44 [2820, UPS_Device]: Nut Host Reconnected
2024/6/27 Thursday 下午 02:06:45 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:45 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:45 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:45 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:46 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:46 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:46 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:46 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:47 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:47 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:47 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:47 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:47 [2820, WinNUT]: Main GUI activated.
2024/6/27 Thursday 下午 02:06:47 [2820, WinNUT]: Update Icon
2024/6/27 Thursday 下午 02:06:48 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:48 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:48 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:48 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:49 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:49 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:49 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:49 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:50 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:50 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:50 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:50 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:51 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:51 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:51 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:51 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:52 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:52 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:52 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:52 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:53 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:53 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:53 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:53 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:54 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:54 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:54 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:54 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:55 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:55 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:55 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:55 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:56 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:56 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:56 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:56 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:57 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:57 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:57 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:57 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:58 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:58 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:58 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:58 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:06:59 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:06:59 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:06:59 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:06:59 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:00 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:00 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:00 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:00 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:01 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:01 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:01 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:01 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:02 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:02 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:02 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:02 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:03 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:03 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:03 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:03 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:04 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:04 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:04 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:04 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:05 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:05 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:05 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:05 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:06 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:06 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:06 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:06 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:07 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:07 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:07 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:07 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:08 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:08 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:08 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:08 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:09 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:09 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:09 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:09 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:10 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:10 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:10 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:10 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:11 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:11 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:11 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:11 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:12 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:12 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:12 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:12 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:13 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:13 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:13 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:13 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:14 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:14 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:14 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:14 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:15 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:15 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:15 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:15 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:16 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:16 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:16 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:16 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:17 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:17 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:17 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:17 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:18 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:18 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:18 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:18 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:19 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:19 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:19 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:19 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:20 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:20 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:20 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:20 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:21 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:21 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:21 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:21 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:22 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:22 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:22 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:22 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:23 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:23 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:23 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:23 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:24 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:24 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:24 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:24 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:25 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:25 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:25 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:25 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:26 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:26 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:26 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:26 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:27 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:27 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:27 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:27 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:28 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:28 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:28 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:28 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:29 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:29 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:29 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:29 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:30 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:30 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:30 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:30 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:31 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:31 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:31 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:31 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:32 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:32 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:32 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:32 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:33 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:33 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:33 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:33 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:34 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:34 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:34 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:34 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:35 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:35 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:35 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:35 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:36 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:36 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:36 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:36 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:37 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:37 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:37 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:37 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:38 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:38 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:38 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:38 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:39 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:39 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:39 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:39 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:40 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:40 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:40 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:40 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:41 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:41 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:41 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:41 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:42 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:42 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:42 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:42 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:43 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:43 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:43 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:43 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:44 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:44 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:44 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:44 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:45 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:45 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:45 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:45 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:46 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:46 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:46 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:46 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:47 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:47 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:47 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:47 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:48 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:48 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:48 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:48 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:49 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:49 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:49 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:49 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:50 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:50 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:50 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:50 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:51 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:51 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:51 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:51 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:52 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:52 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:52 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:52 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:53 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:53 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:53 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:53 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:54 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:54 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:54 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:54 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:55 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:55 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:55 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:55 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:56 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:56 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:56 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:56 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:57 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:57 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:57 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:57 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:58 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:58 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:58 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:58 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:07:59 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:07:59 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:07:59 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:07:59 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:00 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:00 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:00 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:00 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:01 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:01 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:01 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:01 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:02 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:02 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:02 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:02 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:03 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:03 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:03 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:03 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:04 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:04 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:04 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:04 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:05 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:05 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:05 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:05 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:06 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:06 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:06 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:06 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:07 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:07 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:07 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:07 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:08 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:08 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:08 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:08 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:09 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:09 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:09 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:09 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:10 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:10 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:10 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:10 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:10 [2820, WinNUT]: Open Pref Gui From Menu
2024/6/27 Thursday 下午 02:08:10 [2820, Pref_Gui]: Load Pref Gui
2024/6/27 Thursday 下午 02:08:10 [2820, WinNUT]: Main Gui Lose Focus
2024/6/27 Thursday 下午 02:08:10 [2820, WinNUT]: Update Icon
2024/6/27 Thursday 下午 02:08:10 [2820, Pref_Gui]: Pref Gui Opened.
2024/6/27 Thursday 下午 02:08:11 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:11 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:11 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:11 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:12 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:12 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:12 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:12 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:13 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:13 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:13 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:13 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/27 Thursday 下午 02:08:13 [2820, Pref_Gui]: User clicked ViewLog button.
2024/6/27 Thursday 下午 02:08:13 [2820, Pref_Gui]: Opened UI window to log location.
2024/6/27 Thursday 下午 02:08:14 [2820, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/27 Thursday 下午 02:08:14 [2820, UPS_Device]: input.frequency is not supported by server.
2024/6/27 Thursday 下午 02:08:14 [2820, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/27 Thursday 下午 02:08:14 [2820, UPS_Device]: UPS statuses have not changed since last update, skipping.

UPS Variable

UPS (CPS/CP650HGaTW/Unknown)
battery.charge (Description unavailable) : 100
battery.charge.low (Description unavailable) : 10
battery.charge.warning (Description unavailable) : 20
battery.mfr.date (Description unavailable) : CPS
battery.runtime (Description unavailable) : 1744
battery.runtime.low (Description unavailable) : 300
battery.type (Description unavailable) : PbAcid
battery.voltage (Description unavailable) : 13.8
battery.voltage.nominal (Description unavailable) : 12
device.mfr (Description unavailable) : CPS
device.model (Description unavailable) : CP650HGaTW
device.type (Description unavailable) : ups
driver.name (Description unavailable) : usbhid-ups
driver.parameter.pollfreq (Description unavailable) : 30
driver.parameter.pollinterval (Description unavailable) : 5
driver.parameter.port (Description unavailable) : auto
driver.parameter.synchronous (Description unavailable) : no
driver.version (Description unavailable) : DSM7-2-1-NewModel-repack-64570-230831
driver.version.data (Description unavailable) : CyberPower HID 0.4
driver.version.internal (Description unavailable) : 0.41
input.transfer.high (Description unavailable) : 135
input.transfer.low (Description unavailable) : 100
input.voltage (Description unavailable) : 110.0
input.voltage.nominal (Description unavailable) : 0
output.voltage (Description unavailable) : 110.0
ups.beeper.status (Description unavailable) : enabled
ups.delay.shutdown (Description unavailable) : 20
ups.delay.start (Description unavailable) : 30
ups.load (Description unavailable) : 21
ups.mfr (Description unavailable) : CPS
ups.model (Description unavailable) : CP650HGaTW
ups.productid (Description unavailable) : 0501
ups.realpower.nominal (Description unavailable) : 375
ups.status (Description unavailable) : OL
ups.test.result (Description unavailable) : Done and passed
ups.timer.shutdown (Description unavailable) : -60
ups.timer.start (Description unavailable) : -60
ups.vendorid (Description unavailable) : 0764

Thanks for your help.

gbakeman commented 1 week ago

Hi @timmyhbk ,

I have to wonder if this is related to #145. WinNUT currently does not correctly handle the OS going from active -> suspend -> active states, so the next time system operation is resumed, it will continue to try exchanging data over a broken socket connection. This will almost immediately result in an error, which it reports, then tries reconnecting again. From what I can see in the log you posted, that seems to be the case here. You suspended your system at 01:59:59, then resumed around 02:06. WinNUT discovers the broken socket and goes through a reconnect procedure. After dealing with a strange response from the Synology DSM (fairly typical), it then seems to resume reading data from the NUT server normally.

It looks like WinNUT was actually reconnected successfully after resuming from sleep. Please let me know if you think issue #145 is more closer to what you're experiencing, otherwise we'll need to troubleshoot this a little more.

timmyhbk commented 1 week ago

Hi @gbakeman ,

After testing for a while I did notice that occasionally the connection would be restored. But not always.

When it doesn't reconnect, the GUI doesn't change, even if the UPS is disconnected. Clicking on the UPS Variable brings up Error Encountered.

螢幕擷取畫面 2024-06-29 003933

I tried logging different logs. hope this helps.

2024/6/29 星期六 下午 05:27:42 [19320, WinNUT]: Update Icon
2024/6/29 星期六 下午 05:33:04 [19320, WinNUT]: PowerModeChangedEvent: Suspend
2024/6/29 星期六 下午 05:33:04 [19320, WinNUT]: PowerModeChangedEvent: Resume
2024/6/29 星期六 下午 05:33:04 [19320, WinNUT]: Restarting WinNUT after waking up from Windows
2024/6/29 星期六 下午 05:33:04 [19320, String]: New Log to CB_Current Log : 從睡眠喚醒 Windows 後重新啟動 WinNUT。 (edit: Restarting WinNUT after waking Windows from sleep)
2024/6/29 星期六 下午 05:33:06 [19320, WinNUT]: Client UPS_Connect subroutine beginning.
2024/6/29 星期六 下午 05:33:06 [19320, UPS_Device]: Beginning connection: upsmon@192.168.1.101:3493, Name: ups [AutoReconnect]
2024/6/29 星期六 下午 05:33:06 [19320, Nut_Socket]: Attempting TCP socket connection to 192.168.1.101:3493...
2024/6/29 星期六 下午 05:33:06 [19320, Nut_Socket]: Connection established and streams ready for 192.168.1.101:3493
2024/6/29 星期六 下午 05:33:06 [19320, Nut_Socket]: Attempting authentication...
2024/6/29 星期六 下午 05:33:06 [19320, Nut_Socket]: Error while attempting to log in: ACCESSDENIED (ERR ACCESS-DENIED)
Query: USERNAME upsmon
2024/6/29 星期六 下午 05:33:06 [19320, UPS_Device]: NUT protocol error encoutnered:
WinNUT_Client_Common.NutException: ACCESSDENIED (ERR ACCESS-DENIED)
Query: VER
   At WinNUT_Client_Common.Nut_Socket.Query_Data(String Query_Msg)
   At WinNUT_Client_Common.Nut_Socket.Connect()
   At WinNUT_Client_Common.UPS_Device.Connect_UPS(Object retryOnConnFailure)
2024/6/29 星期六 下午 05:33:07 [19320, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/29 星期六 下午 05:33:07 [19320, UPS_Device]: Something went wrong in Retrieve_UPS_Datas: System.IO.IOException: 無法寫入資料至傳輸連接: 遠端主機已強制關閉一個現存的連線。。 ---> System.Net.Sockets.SocketException: 遠端主機已強制關閉一個現存的連線。
(Edit: Unable to write data to the transport connection: The remote host has forcibly closed an existing connection. // The remote host has forced an existing connection to close.)
   At System.Net.Sockets.Socket.Send(Byte[] buffer, Int32 offset, Int32 size, SocketFlags socketFlags)
   At System.Net.Sockets.NetworkStream.Write(Byte[] buffer, Int32 offset, Int32 size)
   --- 內部例外狀況堆疊追蹤的結尾 ---
   (Edit: End of Internal Exception Stack Tracking)
   At System.Net.Sockets.NetworkStream.Write(Byte[] buffer, Int32 offset, Int32 size)
   At System.IO.StreamWriter.Flush(Boolean flushStream, Boolean flushEncoder)
   At System.IO.StreamWriter.Flush()
   At WinNUT_Client_Common.Nut_Socket.Query_Data(String Query_Msg)
   At WinNUT_Client_Common.UPS_Device.GetUPSVar(String varName, Object Fallback_value, Boolean recursing)
   At WinNUT_Client_Common.UPS_Device.Retrieve_UPS_Datas()
2024/6/29 星期六 下午 05:33:07 [19320, UPS_Device]: Processing request to disconnect...
2024/6/29 星期六 下午 05:33:07 [19320, UPS_Device]: Socket has reported a Broken event.
2024/6/29 星期六 下午 05:33:07 [19320, UPS_Device]: Reconnection Process Started
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: Try Reconnect 1 / 30
2024/6/29 星期六 下午 05:33:12 [19320, String]: New Log to CB_Current Log : Try Reconnect 1 / 30
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: Beginning connection: upsmon@192.168.1.101:3493, Name: ups [AutoReconnect]
2024/6/29 星期六 下午 05:33:12 [19320, Nut_Socket]: Attempting TCP socket connection to 192.168.1.101:3493...
2024/6/29 星期六 下午 05:33:12 [19320, Nut_Socket]: Connection established and streams ready for 192.168.1.101:3493
2024/6/29 星期六 下午 05:33:12 [19320, Nut_Socket]: Attempting authentication...
2024/6/29 星期六 下午 05:33:12 [19320, Nut_Socket]: Error while attempting to log in: INVALIDARGUMENT (ERR INVALID-ARGUMENT)
Query: LOGIN
2024/6/29 星期六 下午 05:33:12 [19320, Nut_Socket]: NUT server reports VER: DSM7-2-1-NewModel-repack-64570-230831 NETVER: 1.2
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: ups.serial is not supported by server.
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: Apply Fallback Value when retrieving ups.serial
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: ups.firmware is not supported by server.
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: Apply Fallback Value when retrieving ups.firmware
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: ups.realpower is not supported by server.
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: Unhandled error while getting ups.realpower
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: Using NominalPowerCalc method to calculate power usage.
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: battery.capacity is not supported by server.
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: Apply Fallback Value when retrieving battery.capacity
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: output.frequency.nominal is not supported by server.
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: Apply Fallback Value when retrieving output.frequency.nominal
2024/6/29 星期六 下午 05:33:12 [19320, UPS_Device]: Nut Host Reconnected
2024/6/29 星期六 下午 05:33:15 [19320, WinNUT]: Restore Main Gui On Mouse Click Notify Icon
2024/6/29 星期六 下午 05:33:15 [19320, WinNUT]: Main Gui Has Focus
2024/6/29 星期六 下午 05:33:15 [19320, WinNUT]: Update Icon
2024/6/29 星期六 下午 05:33:15 [19320, WinNUT]: Main Gui Lose Focus
2024/6/29 星期六 下午 05:33:15 [19320, WinNUT]: Update Icon
2024/6/29 星期六 下午 05:33:17 [19320, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/29 星期六 下午 05:33:17 [19320, UPS_Device]: output.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:17 [19320, UPS_Device]: Apply Fallback Value when retrieving output.frequency
2024/6/29 星期六 下午 05:33:17 [19320, UPS_Device]: input.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:17 [19320, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/29 星期六 下午 05:33:17 [19320, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/29 星期六 下午 05:33:17 [19320, WinNUT]: Main Gui Has Focus
2024/6/29 星期六 下午 05:33:17 [19320, WinNUT]: Update Icon
2024/6/29 星期六 下午 05:33:17 [19320, WinNUT]: Open Pref Gui From Menu
2024/6/29 星期六 下午 05:33:17 [19320, Pref_Gui]: Load Pref Gui
2024/6/29 星期六 下午 05:33:17 [19320, WinNUT]: Main Gui Lose Focus
2024/6/29 星期六 下午 05:33:17 [19320, WinNUT]: Update Icon
2024/6/29 星期六 下午 05:33:17 [19320, Pref_Gui]: Pref Gui Opened.
2024/6/29 星期六 下午 05:33:18 [19320, Pref_Gui]: Setting LogControl statuses.
2024/6/29 星期六 下午 05:33:19 [19320, Pref_Gui]: Show LogFile
2024/6/29 星期六 下午 05:33:22 [19320, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/29 星期六 下午 05:33:22 [19320, UPS_Device]: output.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:22 [19320, UPS_Device]: Apply Fallback Value when retrieving output.frequency
2024/6/29 星期六 下午 05:33:22 [19320, UPS_Device]: input.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:22 [19320, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/29 星期六 下午 05:33:22 [19320, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/29 星期六 下午 05:33:27 [19320, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/29 星期六 下午 05:33:27 [19320, UPS_Device]: output.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:27 [19320, UPS_Device]: Apply Fallback Value when retrieving output.frequency
2024/6/29 星期六 下午 05:33:27 [19320, UPS_Device]: input.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:27 [19320, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/29 星期六 下午 05:33:27 [19320, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/29 星期六 下午 05:33:32 [19320, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/29 星期六 下午 05:33:32 [19320, UPS_Device]: output.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:32 [19320, UPS_Device]: Apply Fallback Value when retrieving output.frequency
2024/6/29 星期六 下午 05:33:32 [19320, UPS_Device]: input.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:32 [19320, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/29 星期六 下午 05:33:32 [19320, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/29 星期六 下午 05:33:37 [19320, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/29 星期六 下午 05:33:37 [19320, UPS_Device]: output.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:37 [19320, UPS_Device]: Apply Fallback Value when retrieving output.frequency
2024/6/29 星期六 下午 05:33:37 [19320, UPS_Device]: input.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:37 [19320, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/29 星期六 下午 05:33:37 [19320, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/29 星期六 下午 05:33:39 [19320, WinNUT]: Main Gui Has Focus
2024/6/29 星期六 下午 05:33:39 [19320, WinNUT]: Update Icon
2024/6/29 星期六 下午 05:33:40 [19320, WinNUT]: Main Gui Lose Focus
2024/6/29 星期六 下午 05:33:40 [19320, WinNUT]: Update Icon
2024/6/29 星期六 下午 05:33:42 [19320, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/29 星期六 下午 05:33:42 [19320, UPS_Device]: output.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:42 [19320, UPS_Device]: Apply Fallback Value when retrieving output.frequency
2024/6/29 星期六 下午 05:33:42 [19320, UPS_Device]: input.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:42 [19320, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/29 星期六 下午 05:33:42 [19320, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/29 星期六 下午 05:33:47 [19320, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/29 星期六 下午 05:33:47 [19320, UPS_Device]: output.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:47 [19320, UPS_Device]: Apply Fallback Value when retrieving output.frequency
2024/6/29 星期六 下午 05:33:47 [19320, UPS_Device]: input.frequency is not supported by server.
2024/6/29 星期六 下午 05:33:47 [19320, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/29 星期六 下午 05:33:47 [19320, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/29 星期六 下午 05:33:48 [19320, WinNUT]: Main Gui Has Focus
2024/6/29 星期六 下午 05:33:48 [19320, WinNUT]: Update Icon
2024/6/29 星期六 下午 05:33:49 [19320, WinNUT]: Main Gui Lose Focus
2024/6/29 星期六 下午 05:33:49 [19320, WinNUT]: Update Icon
2024/6/29 星期六 下午 05:33:49 [19320, Pref_Gui]: Show LogFile

Thanks again for your help.

gbakeman commented 1 week ago

Could you please verify for me that the IP address of the computer running WinNUT has been added to the Permitted Diskstation Devices list on your Synology? (Please see here for more info.)

timmyhbk commented 1 week ago

Yes, my settings are consistent with that article.

gbakeman commented 1 week ago

Going back to when you said "the GUI doesn't change", do the gauges remain in a frozen state as if you were still connected to the UPS, even though you aren't? I've had issues with the gauges losing their state during a disconnection, although the rest of this is odd... I'm not really seeing the output I'd expect in your logs, so I'm going to need to ask you to do a slightly more involved test for me.

First thing, please open the settings in WinNUT and make sure log output is set to Debug. Afterwards, hit the Ok button and exit WinNUT. Then navigate to the log files located at C:\Users\{ username }\AppData\Roaming\NUTDotNet\WinNUT Client\2.3.8892.21649\ and clear out all current log files.

Now, please restart WinNUT and do the following things for me:

  1. Connect if it's not already
  2. Open and close UPS Variable dialog
  3. Suspend/sleep your system
  4. Wait for about 5 seconds after it's suspended
  5. Resume operation again
  6. Open and close UPS Variable dialog again
  7. Exit WinNUT

After doing all of that, please directly attach the log file to your next comment here. Don't worry about translating anything, although I appreciate you doing that for me. And thank you for working with me to troubleshoot this issue.

timmyhbk commented 1 week ago

Going back to when you said "the GUI doesn't change", do the gauges remain in a frozen state as if you were still connected to the UPS, even though you aren't? I've had issues with the gauges losing their state during a disconnection, although the rest of this is odd...

I've noticed that if I put Windows to sleep and wake it up within a short period of time, I'm also experiencing gauge loss. And when there is a longer interval between sleep and wake (e.g. 5+mins), the gauge freezes in its state before sleep.

This is the Log after following the instructions:

2024/6/30 星期日 上午 12:34:20 [22196, Logger]: WinNUT Client 2.3.8892.21649 Log file init
==== History of 21 previous events ====
[1] 2024/6/30 星期日 上午 12:34:20 [22196, MyApplication]: MyApplication_Startup complete.
[2] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: NotifyIcons Initialised
[3] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Windows 10 Toast Notification Not Available. Required Version: 10.0.18362.0, Current: 6.2.9200.0
[4] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Windows App Use Dark Theme
[5] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Windows Use Dark Theme
[6] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
未連線
[7] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Status Icon Changed
[8] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: New Icon Value For Systray : 1216
[9] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: New Icon Value For Gui : 1216
[10] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Update Icon at Startup
[11] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Beginning ApplyApplicationPreferences subroutine.
[12] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Initializing all display values and configurations.
[13] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Parameter Dial Input Voltage Need to be Updated
[14] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Parameter Dial Input Voltage Updated
[15] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Parameter Dial Input Frequency Need to be Updated
[16] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Parameter Dial Input Frequency Updated
[17] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Parameter Dial Output Voltage Need to be Updated
[18] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Parameter Dial Output Voltage Updated
[19] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Parameter Dial Voltage Battery Need to be Updated
[20] 2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Parameter Dial Voltage Battery Updated
[21] 2024/6/30 星期日 上午 12:34:20 [22196, Logger]: WinNUT Client 2.3.8892.21649 Log file init
==== Begin Live Log ====
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: WinNut Preferences Applied.
2024/6/30 星期日 上午 12:34:20 [22196, String]: New Log to CB_Current Log : WinNUT 設定已變更
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Run Automatic Update
2024/6/30 星期日 上午 12:34:20 [22196, Update_Gui]: Verify Update
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: WinNUT Client v2.3.8892.21649 completed initialization.
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Main GUI activated.
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: WinNUT_Shown for the first time.
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Minimize WinNut On Start
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Minimize Main Gui To Notify Icon
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Main Gui Lose Focus
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Auto-connecting to UPS on startup.
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Client UPS_Connect subroutine beginning.
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Beginning connection: upsmon@192.168.1.101:3493, Name: ups [AutoReconnect]
2024/6/30 星期日 上午 12:34:20 [22196, Nut_Socket]: Attempting TCP socket connection to 192.168.1.101:3493...
2024/6/30 星期日 上午 12:34:20 [22196, Nut_Socket]: Connection established and streams ready for 192.168.1.101:3493
2024/6/30 星期日 上午 12:34:20 [22196, Nut_Socket]: Attempting authentication...
2024/6/30 星期日 上午 12:34:20 [22196, Nut_Socket]: Error while attempting to log in: INVALIDARGUMENT (ERR INVALID-ARGUMENT)
Query: LOGIN
2024/6/30 星期日 上午 12:34:20 [22196, Nut_Socket]: NUT server reports VER: DSM7-2-1-NewModel-repack-64570-230831 NETVER: 1.2
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Retrieving basic UPS product information...
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: ups.serial is not supported by server.
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Apply Fallback Value when retrieving ups.serial
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: ups.firmware is not supported by server.
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Apply Fallback Value when retrieving ups.firmware
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Initializing other well-known UPS variables...
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: output.current is not supported by server.
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: output.voltage: 111
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: output.realpower is not supported by server.
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Determining best method to calculate power usage...
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: ups.realpower is not supported by server.
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Using RPNomLoadPct method.
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: battery.capacity is not supported by server.
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Apply Fallback Value when retrieving battery.capacity
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: output.frequency.nominal is not supported by server.
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Apply Fallback Value when retrieving output.frequency.nominal
2024/6/30 星期日 上午 12:34:20 [22196, UPS_Device]: Completed retrieval of basic UPS product information.
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: ups has indicated it's ready to start sending data.
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
2024/6/30 星期日 上午 12:34:20 [22196, WinNUT]: Connection to Nut Host Established
2024/6/30 星期日 上午 12:34:20 [22196, String]: New Log to CB_Current Log : 連線到 NUT 伺服器 192.168.1.101:3493 成功
2024/6/30 星期日 上午 12:34:21 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:21 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:21 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:21 [22196, UPS_Device]: UPS statuses have CHANGED...
2024/6/30 星期日 上午 12:34:21 [22196, UPS_Device]: Current statuses: OL
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: Handling new UPS status(es)...
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: Status Icon Changed
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: New Icon Value For Systray : 1136
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: New Icon Value For Gui : 1136
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:21 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:22 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:22 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:22 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:22 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:22 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:22 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:22 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:22 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:22 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:22 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:22 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:23 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:23 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:23 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:23 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:23 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:23 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:23 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:23 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:23 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:23 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:23 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Restore Main Gui On Mouse Click Notify Icon
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Main GUI activated.
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Main Gui Lose Focus
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:24 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:24 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:24 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:24 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:24 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:25 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:25 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:25 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:25 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:25 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:25 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:25 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:25 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:25 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:25 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:25 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:25 [22196, WinNUT]: Main GUI activated.
2024/6/30 星期日 上午 12:34:25 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:26 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:26 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:26 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:26 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:26 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:26 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:26 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:26 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:26 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:26 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:26 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:27 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:27 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:27 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:27 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:27 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:27 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:27 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:27 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:27 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:27 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:27 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:28 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:28 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:28 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:28 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:28 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:28 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:28 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:28 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:28 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:28 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:28 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:29 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:29 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:29 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:29 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:29 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:29 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:29 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:29 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:29 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:29 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:29 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:30 [22196, WinNUT]: Open List Var Gui
2024/6/30 星期日 上午 12:34:30 [22196, List_Var_Gui]: Load List Var Gui
2024/6/30 星期日 上午 12:34:30 [22196, List_Var_Gui]: Populate TreeView
2024/6/30 星期日 上午 12:34:30 [22196, UPS_Device]: UPS device updating status is now [False]
2024/6/30 星期日 上午 12:34:30 [22196, UPS_Device]: Enter GetUPS_ListVar
2024/6/30 星期日 上午 12:34:30 [22196, UPS_Device]: UPS device updating status is now [True]
2024/6/30 星期日 上午 12:34:30 [22196, WinNUT]: Main Gui Lose Focus
2024/6/30 星期日 上午 12:34:30 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:31 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:31 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:31 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:31 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:31 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:31 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:31 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:31 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:31 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:31 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:31 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:32 [22196, List_Var_Gui]: Close List Var Gui
2024/6/30 星期日 上午 12:34:32 [22196, WinNUT]: Main GUI activated.
2024/6/30 星期日 上午 12:34:32 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:32 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:32 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:32 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:32 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:32 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:32 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:32 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:32 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:32 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:32 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:32 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Received FormClosing event. Reason: UserClosing
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Minimize Main Gui To Notify Icon
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Minimize Main Gui To Notify Icon
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Main Gui Lose Focus
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:33 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:33 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:33 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:33 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:33 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:34 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:34 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:34 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:34 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:34 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:34 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:34 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:34 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:34 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:34 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:34 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:35 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:34:35 [22196, UPS_Device]: input.frequency is not supported by server.
2024/6/30 星期日 上午 12:34:35 [22196, UPS_Device]: Apply Fallback Value when retrieving input.frequency
2024/6/30 星期日 上午 12:34:35 [22196, UPS_Device]: UPS statuses have not changed since last update, skipping.
2024/6/30 星期日 上午 12:34:35 [22196, WinNUT]: Updating UPS data for Form.
2024/6/30 星期日 上午 12:34:35 [22196, WinNUT]: Updating battery icons based on charge percent: 100%
2024/6/30 星期日 上午 12:34:35 [22196, WinNUT]: Calculated estimated remaining battery time: 00:29:04
2024/6/30 星期日 上午 12:34:35 [22196, WinNUT]: Update Dial
2024/6/30 星期日 上午 12:34:35 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:34:35 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
已連線
由市電供電
電池正常
2024/6/30 星期日 上午 12:34:35 [22196, WinNUT]: Battery Status => Charged
2024/6/30 星期日 上午 12:34:35 [22196, WinNUT]: PowerModeChangedEvent: Suspend
2024/6/30 星期日 上午 12:34:36 [22196, UPS_Device]: Enter Retrieve_UPS_Datas
2024/6/30 星期日 上午 12:35:01 [22196, UPS_Device]: Something went wrong in Retrieve_UPS_Datas:
2024/6/30 星期日 上午 12:35:01 [22196, UPS_Device]: System.IO.IOException thrown in System
Message: 無法從傳輸連接讀取資料: 連線已被您主機上的軟體中止。。
   於 System.Net.Sockets.NetworkStream.Read(Byte[] buffer, Int32 offset, Int32 size)
   於 System.IO.StreamReader.ReadBuffer()
   於 System.IO.StreamReader.ReadLine()
   於 WinNUT_Client_Common.Nut_Socket.Query_Data(String Query_Msg) 於 C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\Nut_Socket.vb: 行 237
   於 WinNUT_Client_Common.UPS_Device.GetUPSVar(String varName, Object Fallback_value, Boolean recursing) 於 C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\UPS_Device.vb: 行 442
   於 WinNUT_Client_Common.UPS_Device.Retrieve_UPS_Datas(Object sender, EventArgs e) 於 C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\UPS_Device.vb: 行 325

2024/6/30 星期日 上午 12:35:01 [22196, UPS_Device]: Inner exception present:
2024/6/30 星期日 上午 12:35:01 [22196, IOException]: System.Net.Sockets.SocketException thrown in System
Message: 連線已被您主機上的軟體中止。
   於 System.Net.Sockets.Socket.Receive(Byte[] buffer, Int32 offset, Int32 size, SocketFlags socketFlags)
   於 System.Net.Sockets.NetworkStream.Read(Byte[] buffer, Int32 offset, Int32 size)

2024/6/30 星期日 上午 12:35:01 [22196, Logger]: Exception report complete.
2024/6/30 星期日 上午 12:35:01 [22196, Logger]: Exception report complete.
2024/6/30 星期日 上午 12:35:01 [22196, UPS_Device]: Processing request to disconnect...
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Initializing all display values and configurations.
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Status Icon Changed
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: New Icon Value For Systray : 1216
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: New Icon Value For Gui : 1216
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
未連線
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Battery Status => Unknown
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Disconnected from Nut Host
2024/6/30 星期日 上午 12:35:01 [22196, String]: New Log to CB_Current Log : 已與 NUT 伺服器中斷連線。
2024/6/30 星期日 上午 12:35:01 [22196, UPS_Device]: Socket has reported a Broken event.
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Notify user of lost connection
2024/6/30 星期日 上午 12:35:01 [22196, String]: New Log to CB_Current Log : 中斷與 192.168.1.101 的連線:3493
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Initializing all display values and configurations.
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Status Icon Changed
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: New Icon Value For Systray : 1344
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: New Icon Value For Gui : 1344
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
中斷與 192.168.1.101 的連線:3493
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Battery Status => Unknown
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:01 [22196, UPS_Device]: Reconnection Process Started
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: PowerModeChangedEvent: Resume
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Restarting WinNUT after waking up from Windows
2024/6/30 星期日 上午 12:35:01 [22196, String]: New Log to CB_Current Log : 從睡眠喚醒 Windows 後重新啟動 WinNUT。
2024/6/30 星期日 上午 12:35:01 [22196, WinNUT]: Client UPS_Connect subroutine beginning.
2024/6/30 星期日 上午 12:35:01 [22196, UPS_Device]: Beginning connection: upsmon@192.168.1.101:3493, Name: ups [AutoReconnect]
2024/6/30 星期日 上午 12:35:01 [22196, Nut_Socket]: Attempting TCP socket connection to 192.168.1.101:3493...
2024/6/30 星期日 上午 12:35:01 [22196, Nut_Socket]: Connection established and streams ready for 192.168.1.101:3493
2024/6/30 星期日 上午 12:35:01 [22196, Nut_Socket]: Attempting authentication...
2024/6/30 星期日 上午 12:35:01 [22196, Nut_Socket]: Error while attempting to log in: ACCESSDENIED (ERR ACCESS-DENIED)
Query: USERNAME upsmon
2024/6/30 星期日 上午 12:35:01 [22196, UPS_Device]: NUT protocol error encoutnered:
WinNUT_Client_Common.NutException: ACCESSDENIED (ERR ACCESS-DENIED)
Query: VER
   於 WinNUT_Client_Common.Nut_Socket.Query_Data(String Query_Msg) 於 C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\Nut_Socket.vb: 行 247
   於 WinNUT_Client_Common.Nut_Socket.Connect() 於 C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\Nut_Socket.vb: 行 120
   於 WinNUT_Client_Common.UPS_Device.Connect_UPS(Object retryOnConnFailure) 於 C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\UPS_Device.vb: 行 152
2024/6/30 星期日 上午 12:35:06 [22196, UPS_Device]: Try Reconnect 1 / 30
2024/6/30 星期日 上午 12:35:06 [22196, String]: New Log to CB_Current Log : 重試連線 1 / 30
2024/6/30 星期日 上午 12:35:06 [22196, UPS_Device]: Beginning connection: upsmon@192.168.1.101:3493, Name: ups [AutoReconnect]
2024/6/30 星期日 上午 12:35:06 [22196, Nut_Socket]: Attempting TCP socket connection to 192.168.1.101:3493...
2024/6/30 星期日 上午 12:35:06 [22196, Nut_Socket]: Connection established and streams ready for 192.168.1.101:3493
2024/6/30 星期日 上午 12:35:06 [22196, Nut_Socket]: Attempting authentication...
2024/6/30 星期日 上午 12:35:06 [22196, Nut_Socket]: Error while attempting to log in: ACCESSDENIED (ERR ACCESS-DENIED)
Query: USERNAME upsmon
2024/6/30 星期日 上午 12:35:06 [22196, UPS_Device]: NUT protocol error encoutnered:
WinNUT_Client_Common.NutException: ACCESSDENIED (ERR ACCESS-DENIED)
Query: VER
   於 WinNUT_Client_Common.Nut_Socket.Query_Data(String Query_Msg) 於 C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\Nut_Socket.vb: 行 247
   於 WinNUT_Client_Common.Nut_Socket.Connect() 於 C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\Nut_Socket.vb: 行 120
   於 WinNUT_Client_Common.UPS_Device.Connect_UPS(Object retryOnConnFailure) 於 C:\Users\Glen\Repositories\nutdotnet\WinNUT-Client\WinNUT_V2\WinNUT-Client_Common\UPS_Device.vb: 行 152
2024/6/30 星期日 上午 12:35:06 [22196, UPS_Device]: Nut Host Reconnected
2024/6/30 星期日 上午 12:35:09 [22196, WinNUT]: Restore Main Gui On Mouse Click Notify Icon
2024/6/30 星期日 上午 12:35:09 [22196, WinNUT]: Main GUI activated.
2024/6/30 星期日 上午 12:35:09 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:09 [22196, WinNUT]: Main Gui Lose Focus
2024/6/30 星期日 上午 12:35:09 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:11 [22196, WinNUT]: Main GUI activated.
2024/6/30 星期日 上午 12:35:11 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:12 [22196, WinNUT]: Main Gui Lose Focus
2024/6/30 星期日 上午 12:35:12 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:16 [22196, WinNUT]: Main GUI activated.
2024/6/30 星期日 上午 12:35:16 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:18 [22196, WinNUT]: Open List Var Gui
2024/6/30 星期日 上午 12:35:18 [22196, List_Var_Gui]: Load List Var Gui
2024/6/30 星期日 上午 12:35:18 [22196, List_Var_Gui]: Populate TreeView
2024/6/30 星期日 上午 12:35:18 [22196, UPS_Device]: UPS device updating status is now [False]
2024/6/30 星期日 上午 12:35:18 [22196, UPS_Device]: Enter GetUPS_ListVar
2024/6/30 星期日 上午 12:35:18 [22196, WinNUT]: Main Gui Lose Focus
2024/6/30 星期日 上午 12:35:18 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:20 [22196, WinNUT]: Main GUI activated.
2024/6/30 星期日 上午 12:35:20 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:20 [22196, WinNUT]: Main Gui Lose Focus
2024/6/30 星期日 上午 12:35:20 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:22 [22196, List_Var_Gui]: Close List Var Gui
2024/6/30 星期日 上午 12:35:22 [22196, WinNUT]: Main GUI activated.
2024/6/30 星期日 上午 12:35:22 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Close WinNut From Menu Quit
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Received FormClosing event. Reason: ApplicationExitCall
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Init Disconnecting Before Close WinNut
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Running Client disconnect subroutine.
2024/6/30 星期日 上午 12:35:24 [22196, UPS_Device]: Processing request to disconnect...
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Initializing all display values and configurations.
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Update Icon
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Status Icon Changed
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: New Icon Value For Systray : 1216
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: New Icon Value For Gui : 1216
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: NotifyIcon Text => 
WinNUT Client - 2.3
未連線
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Battery Status => Unknown
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Disconnected from Nut Host
2024/6/30 星期日 上午 12:35:24 [22196, String]: New Log to CB_Current Log : 已與 NUT 伺服器中斷連線。
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Main Gui Lose Focus
2024/6/30 星期日 上午 12:35:24 [22196, WinNUT]: Update Icon
gbakeman commented 1 week ago

Thank you once again for doing that. I think I'm starting to understand what the issue may be - the Synology version of NUT server may be unhappy that WinNUT disappears without doing the LOGOUT command, and then doesn't accept any commands following that. Let me wrap up something I'm working on, then I'll take a deeper dive into this.

gbakeman commented 1 week ago

Just had a chance to dig into this. To be honest, I'm shooting in the dark a little bit, but I picked what looked like an obvious low-hanging fruit; implementing basic support for system suspend events. There's a debug build up here, please give it a try and let me know how it goes. Thanks for your patience and testing efforts!

timmyhbk commented 1 week ago

After several tests. The first few times I woke up after a short sleep (about 5sec), the connection was successfully restored. However, after extending the interval between sleep and wakeup (5+mins), the connection still can't be resumed. During this time, I encountered several crashes.

Strangely. Now I can't restore the connection after sleep in any way :(

Thank you!

Crash Report: CrashReport_2024-07-02T14.13.13.txt CrashReport_2024-07-02T18.13.09.txt CrashReport_2024-07-02T19.51.41.txt

Some Log WinNUT-Client-2024-07-02(5+).log WinNUT-Client-2024-07-02(5sec).log WinNUT-Client-2024-07-02(15+).log

gbakeman commented 6 days ago

Wow, that is not what I was expecting! 😅

Your detailed logs have led me to a deeper dive in WinNUT, and I've discovered several issues and cleaned up some dusty code that should have it handling connections better. I also discovered that it was using the NUT LOGIN command incorrectly, so WinNUT will now Login to the UPS properly. Please go ahead and test the latest debug build again. I want to let you know that I'll be leaving in two days and won't be around for a couple of weeks, so I may disappear. But hopefully we'll have this fixed soon.

timmyhbk commented 6 days ago

The new version still encounters the same situation. Sometimes it works. But most of the time the connection is still not restored. And sometimes it crashes.

Log: WinNUT-Client-2024-07-03-1.log WinNUT-Client-2024-07-03-2.log WinNUT-Client-2024-07-03-3.log

Crash Report: CrashReport_2024-07-03T13.33.58.txt CrashReport_2024-07-03T16.23.14.txt

I tried deleting user.config from appdata and resetting it. At first it appeared differently than before. It kept trying to reconnect 30 times. But in the end it still could not reconnect. But after I switched the log level to debug it was not reproducible. (Even if I change it back to Notice)

Here is the log for that time: WinNUT-Client-2024-07-03(Notice).log

gbakeman commented 6 days ago

I'm surprised I have such a hard time reproducing these problems you're experiencing. All the same, your detailed error reports are helping me find yet more bugs to fix. Another build is up, thank you again for your tests!

timmyhbk commented 5 days ago

It still doesn't seem to work. But it didn't crash this time.

Log WinNUT-Client-2024-07-04-1.log WinNUT-Client-2024-07-04-2.log WinNUT-Client-2024-07-04-3.log WinNUT-Client-2024-07-04-4.log WinNUT-Client-2024-07-04-5.log

There were a couple of long sleep-wake intervals. It succeeded to get back on line.

Log that successfully restored the connection. not sure if that helps. WinNUT-Client-2024-07-04(s).log

Thanks again for your time!

gbakeman commented 4 days ago

And thank you for your patience while we get to the bottom of this! I'm glad to hear that the crashes seem to have been fixed at least. I'm currently away now so we'll have to take a break, but I'll be back on this in the second half of the month.