top of page

Forum Comments

"Unable to process unformatted KISS data"
In VarAC - HF discussion forum
smwilson182
Sep 10, 2025
Thanks Irad. Here is a section of the debug VarAC log from just now. I contacted an operator of one of the gateway beacons that will not process and asked that he attempt again to send a gateway beacon. If you need more just let me know. 10/09/2025 19:03:03 - Starting write_command_stream_log 10/09/2025 19:03:03 - Writing event to command stream log 10/09/2025 19:03:03 - End of write_command_stream_log 10/09/2025 19:03:08 - Starting write_command_stream_log 10/09/2025 19:03:08 - Writing event to command stream log 10/09/2025 19:03:08 - End of write_command_stream_log 10/09/2025 19:03:08 - KISS BEACON received from N4WXI 10/09/2025 19:03:08 - KISS CQ Data: Tag:0C Loc:EM63MH Type: 10/09/2025 19:03:08 - Received beacon tag: 0C 10/09/2025 19:03:08 - Starting write_data_last_heard_log 10/09/2025 19:03:08 - DB: SELECT 1 FROM qso WHERE callsign = @var1 AND snr_received != '' AND snr_sent != '' AND is_deleted = false LIMIT 1 10/09/2025 19:03:08 - DB: SELECT name, qth, comments FROM contact WHERE callsign = @var1 AND is_deleted = false ORDER BY time_added desc LIMIT 1 10/09/2025 19:03:08 - DB: SELECT 1 FROM qso WHERE callsign = @var1 AND band = @var2 AND is_deleted = false LIMIT 1 10/09/2025 19:03:08 - Unable to process unformatted KISS data. Skipping.Index was outside the bounds of the array. at System.Windows.Forms.Control.MarshaledInvoke(Control caller, Delegate method, Object[] args, Boolean synchronous) at System.Windows.Forms.Control.Invoke(Delegate method, Object[] args) at VarAC.VarAC.write_data_last_heard_log(String log_type, String callsign, String bw, Int32 his_sn_last, DateTime log_time, String band, Boolean history_load, String slot, String data, String locator, Boolean is_emcomm, Int64 frequency, Boolean is_email_gateway) at VarAC.VarAC.b__129_1() 10/09/2025 19:03:09 - Starting write_command_stream_log 10/09/2025 19:03:09 - Writing event to command stream log 10/09/2025 19:03:09 - End of write_command_stream_log 10/09/2025 19:03:12 - Starting write_command_stream_log 10/09/2025 19:03:12 - Writing event to command stream log 10/09/2025 19:03:12 - End of write_command_stream_log
0
0
"Unable to process unformatted KISS data"
In VarAC - HF discussion forum
smwilson182
Sep 07, 2025
I still cannot upload the entire VarAC.log file through the forum log system but here is the beginning of the log after the reload with some interesting entries that might help: 31/08/2025 20:57:17 - Starting VarAC (V12.0.0) 31/08/2025 20:57:17 - OS: Microsoft Windows NT 6.2.9200.0 31/08/2025 20:57:17 - OS: Microsoft Windows NT 6.2.9200.0 31/08/2025 20:57:17 - Debug mode disabled 31/08/2025 20:57:18 - FREQ Schedule off 31/08/2025 20:57:18 - Error: updating instance email gateway status in SQLite:SQL logic error no such table: instance    at System.Data.SQLite.SQLite3.Prepare(SQLiteConnection cnn, String strSql, SQLiteStatement previous, UInt32 timeoutMS, String& strRemain)    at System.Data.SQLite.SQLiteCommand.BuildNextCommand()    at System.Data.SQLite.SQLiteCommand.GetStatement(Int32 index)    at System.Data.SQLite.SQLiteDataReader.NextResult()    at System.Data.SQLite.SQLiteDataReader..ctor(SQLiteCommand cmd, CommandBehavior behave)    at System.Data.SQLite.SQLiteCommand.ExecuteReader(CommandBehavior behavior)    at System.Data.SQLite.SQLiteCommand.ExecuteNonQuery(CommandBehavior behavior)    at System.Data.SQLite.SQLiteCommand.ExecuteNonQuery()    at VarAC.VarAC.update_instance_email_gateway_status(Int32 instance_id, Boolean email_gateway_active, Boolean email_gateway_sender_node) 31/08/2025 20:57:18 - Unattended links enabled 31/08/2025 20:57:18 - Setting unattended links ON (load) 31/08/2025 20:57:18 - PSKReporter: logging enabled 31/08/2025 20:57:18 - PSKReporter: Connected 31/08/2025 20:57:18 - Can not refresh mailbox counters now. skipping. 31/08/2025 20:57:18 - Error: unable to get relay notification count from SQLite:SQL logic error no such table: vmail_relay_notification    at System.Data.SQLite.SQLite3.Prepare(SQLiteConnection cnn, String strSql, SQLiteStatement previous, UInt32 timeoutMS, String& strRemain)    at System.Data.SQLite.SQLiteCommand.BuildNextCommand()    at System.Data.SQLite.SQLiteCommand.GetStatement(Int32 index)    at System.Data.SQLite.SQLiteDataReader.NextResult()    at System.Data.SQLite.SQLiteDataReader..ctor(SQLiteCommand cmd, CommandBehavior behave)    at System.Data.SQLite.SQLiteCommand.ExecuteReader(CommandBehavior behavior)    at System.Data.SQLite.SQLiteCommand.ExecuteReader()    at VarAC.VarAC.refresh_relay_notification_count() 31/08/2025 20:57:18 - Error: unable to get alerts count from SQLite:SQL logic error no such table: alert    at System.Data.SQLite.SQLite3.Prepare(SQLiteConnection cnn, String strSql, SQLiteStatement previous, UInt32 timeoutMS, String& strRemain)    at System.Data.SQLite.SQLiteCommand.BuildNextCommand()    at System.Data.SQLite.SQLiteCommand.GetStatement(Int32 index)    at System.Data.SQLite.SQLiteDataReader.NextResult()    at System.Data.SQLite.SQLiteDataReader..ctor(SQLiteCommand cmd, CommandBehavior behave)    at System.Data.SQLite.SQLiteCommand.ExecuteReader(CommandBehavior behavior)    at System.Data.SQLite.SQLiteCommand.ExecuteReader()    at VarAC.VarAC.refresh_alerts_count() 31/08/2025 20:57:18 - Simple Mode enabled 31/08/2025 20:57:18 - Opening DB connection 31/08/2025 20:57:18 - DB: Initializing VarAC DB for the first time 31/08/2025 20:57:18 - Upgrading SQLite DB schema from V1 to V2 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V2 to V3 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V3 to V4 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V4 to V5 31/08/2025 20:57:19 - Creating contacts list based on QSO history. 31/08/2025 20:57:19 - Creating contacts list ended successfully. 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V5 to V6 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V6 to V7 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V7 to V8 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V8 to V9 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V9 to V10 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V10 to V11 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V11 to V12 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V12 to V13 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V13 to V14 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V14 to V15 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V15 to V16 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V16 to V17 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V17 to V18 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V18 to V19 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V19 to V20 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V20 to V21 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V21 to V22 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V22 to V23 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V23 to V24 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V24 to V25 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V25 to V26 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V26 to V27 31/08/2025 20:57:19 - Upgrading SQLite DB schema from V27 to V28 31/08/2025 20:57:19 - Data stream log file C:\VarAC\VarAC_traffic.logDoes not exist. Skipping SQLite DB conversion. 31/08/2025 20:57:19 - Applications launcher disabled 31/08/2025 20:57:19 - Opening COM port 31/08/2025 20:58:36 - Shutting down VarAC... 31/08/2025 20:58:39 - Exiting - Closing Relat notifications and broadcast thread 31/08/2025 20:58:39 - Closing VarAC 31/08/2025 20:58:39 - Change frequency: to last frequency used before shutdown. 31/08/2025 20:58:40 - VarAC base directory: C:\VarAC\ 31/08/2025 20:58:40 - Checking for VarAC update. 31/08/2025 20:58:40 - Starting VarAC (V12.0.0) 31/08/2025 20:58:40 - OS: Microsoft Windows NT 6.2.9200.0 31/08/2025 20:58:40 - OS: Microsoft Windows NT 6.2.9200.0 31/08/2025 20:58:41 - Debug mode disabled 31/08/2025 20:58:41 - FREQ Schedule off 31/08/2025 20:58:41 - Unattended links enabled 31/08/2025 20:58:41 - Setting unattended links ON (load) 31/08/2025 20:58:41 - PSKReporter: logging enabled 31/08/2025 20:58:41 - PSKReporter: Connected 31/08/2025 20:58:41 - Simple Mode enabled 31/08/2025 20:58:42 - Opening DB connection 31/08/2025 20:58:42 - Current VarAC DB version: 28 31/08/2025 20:58:42 - Applications launcher disabled 31/08/2025 20:58:42 - Opening COM port 31/08/2025 20:58:47 - Connecting VARA Main Modem Command interface... 31/08/2025 20:58:47 - Connecting VARA Main Modem data stream... 31/08/2025 20:58:47 - Connecting VARA Main Modem KISS Command interface... 31/08/2025 20:58:47 - Connected to VARA modem 31/08/2025 20:58:47 - Setting Bandwith to 500Hz 31/08/2025 20:58:47 - Change frequency: to last frequency used before shutdown. 31/08/2025 20:58:47 - VARA version: VARA HF v4.8.9 31/08/2025 20:59:02 - VarAC base directory: C:\VarAC\ 31/08/2025 20:59:02 - Checking for VarAC update. 31/08/2025 20:59:19 - Debug mode disabled 31/08/2025 20:59:20 - Setting unattended links ON (load) 31/08/2025 20:59:22 - Closing Rig comport 31/08/2025 20:59:22 - Closing GPS comport 31/08/2025 20:59:22 - Closing Rig TCP port 31/08/2025 21:00:02 - PSKReporter self report: Logged successfully 31/08/2025 21:00:02 - PSKReporter: Sending accumulated records 31/08/2025 21:00:49 - PSKReporter: Logged successfully (N0PTK) 31/08/2025 21:00:49 - PSKReporter: Sending accumulated records 31/08/2025 21:01:07 - Debug mode disabled 31/08/2025 21:01:07 - Setting unattended links ON (load) 31/08/2025 21:01:15 - Closing Rig comport 31/08/2025 21:01:15 - Closing GPS comport 31/08/2025 21:01:15 - Closing Rig TCP port 31/08/2025 21:02:09 - Debug mode disabled 31/08/2025 21:02:09 - Setting unattended links ON (load) 31/08/2025 21:02:12 - Closing Rig comport 31/08/2025 21:02:12 - Closing GPS comport 31/08/2025 21:02:12 - Closing Rig TCP port 31/08/2025 21:02:57 - Debug mode disabled 31/08/2025 21:02:58 - Setting unattended links ON (load) 31/08/2025 21:03:03 - Closing Rig comport 31/08/2025 21:03:03 - Closing GPS comport 31/08/2025 21:03:03 - Closing Rig TCP port 31/08/2025 21:03:27 - Debug mode disabled 31/08/2025 21:03:27 - Setting unattended links ON (load) 31/08/2025 21:03:31 - Closing Rig comport 31/08/2025 21:03:31 - Closing GPS comport 31/08/2025 21:03:31 - Closing Rig TCP port 31/08/2025 21:04:18 - Debug mode disabled 31/08/2025 21:04:18 - Setting unattended links ON (load) 31/08/2025 21:04:23 - Changing frequency: user selection from dropdown menu. 31/08/2025 21:04:23 - Opening COM port 31/08/2025 21:05:12 - Connecting N4WXI 31/08/2025 21:05:23 - PSKReporter self report: Logged successfully 31/08/2025 21:05:23 - PSKReporter: Sending accumulated records 31/08/2025 21:05:23 - Connected to N4WXI 31/08/2025 21:05:33 - Advanced Mode enabled 31/08/2025 21:05:51 - Changing frequency: per user QSY request 31/08/2025 21:06:23 - Report Received: 5 31/08/2025 21:06:52 - PSKReporter self report: Logged successfully 31/08/2025 21:06:52 - PSKReporter: Sending accumulated records 31/08/2025 21:07:04 - Disconnecting N4WXI 31/08/2025 21:07:11 - Disconnected from N4WXI 31/08/2025 21:07:11 - Logging QSO to DB: N4WXI 31/08/2025 21:07:11 - Logging QSO to ADIF and loggers: N4WXI 31/08/2025 21:07:11 - Logging Contact to DB: N4WXI 31/08/2025 21:07:19 - Changing frequency: per user QSY request 31/08/2025 21:08:20 - PSKReporter self report: Logged successfully 31/08/2025 21:08:20 - PSKReporter: Sending accumulated records 31/08/2025 21:12:28 - Calling CQ 31/08/2025 21:12:48 - Switching to Slot 3 31/08/2025 21:12:59 - Changing frequency: user selection from dropdown menu. 31/08/2025 21:12:59 - Resetting to Slot 0 31/08/2025 21:13:05 - Sending beacons every 15 minutes 31/08/2025 21:13:25 - Sending beacon 31/08/2025 21:13:25 - KISS BEACON sent 31/08/2025 21:14:00 - PSKReporter self report: Logged successfully 31/08/2025 21:14:00 - PSKReporter: Sending accumulated records 31/08/2025 21:14:07 - Closing Rig comport 31/08/2025 21:14:07 - Closing GPS comport 31/08/2025 21:14:07 - Closing Rig TCP port 31/08/2025 21:14:16 - Debug mode disabled 31/08/2025 21:14:17 - Setting unattended links ON (load) 31/08/2025 21:19:20 - KISS BEACON received from N4WXI 31/08/2025 21:19:20 - Unable to process unformatted KISS data. Skipping.Index was outside the bounds of the array.    at System.Windows.Forms.Control.MarshaledInvoke(Control caller, Delegate method, Object[] args, Boolean synchronous)    at System.Windows.Forms.Control.Invoke(Delegate method, Object[] args)    at VarAC.VarAC.write_data_last_heard_log(String log_type, String callsign, String bw, Int32 his_sn_last, DateTime log_time, String band, Boolean history_load, String slot, String data, String locator, Boolean is_emcomm, Int64 frequency, Boolean is_email_gateway)    at VarAC.VarAC.b__129_1() 31/08/2025 21:20:21 - PSKReporter: Logged successfully (PY2TI) 31/08/2025 21:20:21 - PSKReporter: Sending accumulated records 31/08/2025 21:20:33 - Connecting PY2TI 31/08/2025 21:20:33 - Opening COM port 31/08/2025 21:20:42 - Connected to PY2TI 31/08/2025 21:21:10 - Changing frequency: per user QSY request 31/08/2025 21:21:48 - Report Received: -9 31/08/2025 21:22:11 - PSKReporter self report: Logged successfully 31/08/2025 21:22:11 - PSKReporter: Sending accumulated records
0
"Unable to process unformatted KISS data"
In VarAC - HF discussion forum
smwilson182
Sep 07, 2025
I attempted to attach the entire log file using the upload button below but the forum file system rejects the full VarAC.log upload. So here is copy of the last few minutes of the log from today with three failed beacons, all from different call signs. Some beacons do continue to be processed which I assume are not email gateway beacons. As others have said, I've never seen the lightning bolt indicator except in screenshots from others showing me what it should look like. Both VarAC and Vara HF have been reloaded with current versions and the Dell laptop was updated to Win11 some time ago. 07/09/2025 16:50:33 - PSKReporter: Sending accumulated records 07/09/2025 16:54:25 - KISS BEACON received from NO6GN 07/09/2025 16:54:25 - Unable to process unformatted KISS data. Skipping.Index was outside the bounds of the array. at System.Windows.Forms.Control.MarshaledInvoke(Control caller, Delegate method, Object[] args, Boolean synchronous) at System.Windows.Forms.Control.Invoke(Delegate method, Object[] args) at VarAC.VarAC.write_data_last_heard_log(String log_type, String callsign, String bw, Int32 his_sn_last, DateTime log_time, String band, Boolean history_load, String slot, String data, String locator, Boolean is_emcomm, Int64 frequency, Boolean is_email_gateway) at VarAC.VarAC.b__129_1() 07/09/2025 16:57:29 - PSKReporter: Logged successfully (KC9DGP) 07/09/2025 16:57:29 - PSKReporter: Sending accumulated records 07/09/2025 16:59:06 - KISS BEACON received from N2PPI 07/09/2025 16:59:06 - Unable to process unformatted KISS data. Skipping.Index was outside the bounds of the array. at System.Windows.Forms.Control.MarshaledInvoke(Control caller, Delegate method, Object[] args, Boolean synchronous) at System.Windows.Forms.Control.Invoke(Delegate method, Object[] args) at VarAC.VarAC.write_data_last_heard_log(String log_type, String callsign, String bw, Int32 his_sn_last, DateTime log_time, String band, Boolean history_load, String slot, String data, String locator, Boolean is_emcomm, Int64 frequency, Boolean is_email_gateway) at VarAC.VarAC.b__129_1() 07/09/2025 17:00:24 - PSKReporter: Logged successfully (KK6QMS) 07/09/2025 17:00:24 - PSKReporter: Sending accumulated records 07/09/2025 17:02:18 - KISS BEACON received from KM4UDX 07/09/2025 17:02:18 - Unable to process unformatted KISS data. Skipping.Index was outside the bounds of the array. at System.Windows.Forms.Control.MarshaledInvoke(Control caller, Delegate method, Object[] args, Boolean synchronous) at System.Windows.Forms.Control.Invoke(Delegate method, Object[] args) at VarAC.VarAC.write_data_last_heard_log(String log_type, String callsign, String bw, Int32 his_sn_last, DateTime log_time, String band, Boolean history_load, String slot, String data, String locator, Boolean is_emcomm, Int64 frequency, Boolean is_email_gateway) at VarAC.VarAC.b__129_1()
0
"Unable to process unformatted KISS data"
In VarAC - HF discussion forum
"Unable to process unformatted KISS data"
In VarAC - HF discussion forum

smwilson182

More actions
bottom of page