I've got the email set correctly and have passed email along when my station is used as a gateway. For no reason the color green email gate turns orange. If I click on the Email Gate it changes color back to green. The SMTP test email passes. The IMAP test passes but it also says "Success Inbox contains 9 messages while 9 are new.
If I go to Tools - Mailbox the Inbox shows 0 new messages.
??? Thanks in advance.
Terry / K8TJM
Still happening: VarAC Cluster on VarAC 12.0.4
Pretty sure this log entry is related! CN:20) Unable to log QSO with VU2ROE ,missing information
Log:
25/08/2025 20:40:59 - (CN:20) Sending beacon
25/08/2025 20:40:59 - (CN:20) KISS BEACON sent
25/08/2025 20:41:23 - (CN:20) KISS packet received
25/08/2025 20:41:23 - (CN:20) Async message received: TO:4Z5PE FROM:VU2ROE DATA:<SMP>
25/08/2025 20:41:33 - (CN:20) Resetting to Slot 0
25/08/2025 20:41:33 - (CN:20) Connecting VU2ROE
25/08/2025 20:41:47 - (CN:20) Connected to VU2ROE
25/08/2025 20:43:45 - (CN:20) Disconnected from VU2ROE
25/08/2025 20:43:45 - (CN:20) Logging QSO to DB: VU2ROE
25/08/2025 20:43:45 - (CN:20) Unable to log QSO with VU2ROE ,missing information
25/08/2025 20:43:49 - (CN:20) Clearing outgoing queues.
25/08/2025 20:43:55 - (CN:20) Connecting VU2ROE
25/08/2025 20:44:12 - (CN:20) Disconnected from VU2ROE
25/08/2025 20:44:12 - (CN:20) Logging QSO to DB: VU2ROE
Screen capture:
Here is a new example of this bug - the EMAIL GATE indicators turned ORANGE:
Toggling PTT Lock did NOT clear the issue, this time!
The QO-100 instance is the email handler. It remained GREEN.
All the other instances turned ORANGE!
Is it related to incomplete QSO info and automated logging failure?
Log file
27/07/2025 08:14:12 - (CN:1) Connected to DL0VBK
27/07/2025 08:14:37 - (CN:1) Incoming message.
27/07/2025 08:14:53 - (CN:1) Disconnected from DL0VBK
27/07/2025 08:14:53 - (CN:1) Logging QSO to DB: DL0VBK
27/07/2025 08:14:53 - (CN:1) Unable to log QSO with DL0VBK ,missing information
27/07/2025 08:14:56 - (CN:1) Clearing outgoing queues.
27/07/2025 08:15:53 - (CN:1) Debug mode disabled
27/07/2025 08:15:54 - (CN:1) Instance number: 1
27/07/2025 08:15:54 - (CN:1) Setting unattended links ON (load)
27/07/2025 08:15:54 - (CN:1) Resetting to Slot 0
27/07/2025 08:15:54 - (CN:1) Opening COM port
27/07/2025 08:16:08 - (CN:1) Sending beacon
27/07/2025 08:16:08 - (CN:1) KISS BEACON sent
27/07/2025 08:17:15 - (CN:1) Error: unable to load QSO data: Value was either too large or too small for an Int32.
at System.Convert.ToInt32(Int64 value)
at System.Int64.System.IConvertible.ToInt32(IFormatProvider provider)
at System.Convert.ToInt32(Object value)
at VarAC.VarAC.get_qso_details(String guid)
at VarAC.Form15.dg_ch_adif_history_SelectionChanged(Object sender, EventArgs e)
27/07/2025 08:17:15 - (CN:1) Error: unable to load QSO data: Value was either too large or too small for an Int32.
at System.Convert.ToInt32(Int64 value)
at System.Int64.System.IConvertible.ToInt32(IFormatProvider provider)
at System.Convert.ToInt32(Object value)
at VarAC.VarAC.get_qso_details(String guid)
at VarAC.Form15.dg_ch_adif_history_SelectionChanged(Object sender, EventArgs e)
27/07/2025 08:17:17 - (CN:1) Error: unable to load QSO data: Value was either too large or too small for an Int32.
at System.Convert.ToInt32(Int64 value)
at System.Int64.System.IConvertible.ToInt32(IFormatProvider provider)
at System.Convert.ToInt32(Object value)
at VarAC.VarAC.get_qso_details(String guid)
at VarAC.Form15.dg_ch_adif_history_SelectionChanged(Object sender, EventArgs e)
27/07/2025 08:17:21 - (CN:1) Error: updating instance keepalive in SQLite:database is locked
database is locked
at System.Data.SQLite.SQLite3.Step(SQLiteStatement stmt)
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_keepalive(Int32 instance_id)
27/07/2025 08:17:21 - (CN:20) Error: updating instance keepalive in SQLite:database is locked
database is locked
at System.Data.SQLite.SQLite3.Step(SQLiteStatement stmt)
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_keepalive(Int32 instance_id)
27/07/2025 08:17:21 - (CN:40) Error: updating instance keepalive in SQLite:database is locked
database is locked
at System.Data.SQLite.SQLite3.Step(SQLiteStatement stmt)
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_keepalive(Int32 instance_id)
27/07/2025 08:17:21 - (CN:10) Error: updating instance keepalive in SQLite:database is locked
database is locked
at System.Data.SQLite.SQLite3.Step(SQLiteStatement stmt)
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_keepalive(Int32 instance_id)
27/07/2025 08:17:22 - (CN:1) Error: unable to update instance busy status in SQLite:database is locked
database is locked
at System.Data.SQLite.SQLite3.Step(SQLiteStatement stmt)
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_busy_state(Int32 instance_id, Boolean is_busy)
27/07/2025 08:17:22 - (CN:40) Error: unable to update instance busy status in SQLite:database is locked
database is locked
at System.Data.SQLite.SQLite3.Step(SQLiteStatement stmt)
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_busy_state(Int32 instance_id, Boolean is_busy)
27/07/2025 08:17:24 - (CN:1) Error: unable to load QSO data: Value was either too large or too small for an Int32.
at System.Convert.ToInt32(Int64 value)
at System.Int64.System.IConvertible.ToInt32(IFormatProvider provider)
at System.Convert.ToInt32(Object value)
at VarAC.VarAC.get_qso_details(String guid)
at VarAC.Form15.dg_ch_adif_history_SelectionChanged(Object sender, EventArgs e)
27/07/2025 08:17:35 - (CN:1) Error: unable to load QSO data: Value was either too large or too small for an Int32.
at System.Convert.ToInt32(Int64 value)
at System.Int64.System.IConvertible.ToInt32(IFormatProvider provider)
at System.Convert.ToInt32(Object value)
at VarAC.VarAC.get_qso_details(String guid)
at VarAC.Form15.dg_ch_adif_history_SelectionChanged(Object sender, EventArgs e)
27/07/2025 08:17:39 - (CN:1) Error: unable to load QSO data: Value was either too large or too small for an Int32.
at System.Convert.ToInt32(Int64 value)
at System.Int64.System.IConvertible.ToInt32(IFormatProvider provider)
at System.Convert.ToInt32(Object value)
at VarAC.VarAC.get_qso_details(String guid)
at VarAC.Form15.dg_ch_adif_history_SelectionChanged(Object sender, EventArgs e)
27/07/2025 08:19:52 - (CN:1) PSKReporter: Logged successfully (FR4KF)
27/07/2025 08:19:52 - (CN:1) PSKReporter: Sending accumulated records
27/07/2025 08:20:57 - (CN:1) Closing Rig comport
27/07/2025 08:20:57 - (CN:1) Closing GPS comport
27/07/2025 08:20:57 - (CN:1) Closing Rig TCP port
Thanks Irad. I had one letter wrong when using the show button. Thanks for your help.
ok - there is a bug that on the TEST button uses the password of the SMTP and not IMAP.
So I am 99% sure your password on the IMAP side is not correctly instered.
make sure you enter the same thing. use the SHOW button.
Hello Irad,
Thanks for answering the post. I've inserted the error part of the log:
09/07/2025 22:35:14 - Email gateway error: Unable to receive email from IMAP server. Invalid credentials (Failure)
09/07/2025 22:35:14 - Failed to receive Email from IMAP server. Retry 1/5.
09/07/2025 22:36:20 - Closing Rig comport
09/07/2025 22:36:20 - Closing GPS comport
09/07/2025 22:36:20 - Closing Rig TCP port
09/07/2025 22:36:39 - Email sent to varactjm@gmail.com through Email gateway successfully.
09/07/2025 22:36:58 - Debug mode disabled
09/07/2025 22:36:58 - Setting away status to true (load)
09/07/2025 22:36:58 - Setting unattended links ON (load)
09/07/2025 22:37:11 - Debug mode disabled
09/07/2025 22:37:11 - Setting away status to true (load)
09/07/2025 22:37:11 - Setting unattended links ON (load)
09/07/2025 22:38:24 - Closing Rig comport
09/07/2025 22:38:24 - Closing GPS comport
09/07/2025 22:38:24 - Closing Rig TCP port
09/07/2025 22:40:15 - Email gateway error: Unable to receive email from IMAP server. Invalid credentials (Failure)
09/07/2025 22:40:15 - Failed to receive Email from IMAP server. Retry 2/5.
09/07/2025 22:40:15 - Debug mode disabled
09/07/2025 22:40:15 - Setting away status to true (load)
09/07/2025 22:40:15 - Setting unattended links ON (load)
09/07/2025 22:40:25 - Debug mode disabled
09/07/2025 22:40:25 - Setting away status to true (load)
09/07/2025 22:40:25 - Setting unattended links ON (load)
09/07/2025 22:41:15 - Debug mode disabled
09/07/2025 22:41:15 - Setting away status to true (load)
09/07/2025 22:41:15 - Setting unattended links ON (load)
09/07/2025 22:42:03 - Debug mode disabled
09/07/2025 22:42:03 - Setting away status to true (load)
09/07/2025 22:42:03 - Setting unattended links ON (load)
09/07/2025 22:45:15 - Email gateway error: Unable to receive email from IMAP server. Invalid credentials (Failure)
09/07/2025 22:45:15 - Failed to receive Email from IMAP server. Retry 3/5.
09/07/2025 22:47:41 - Sending beacon
09/07/2025 22:47:41 - KISS BEACON sent
09/07/2025 22:48:28 - Closing Rig comport
09/07/2025 22:48:28 - Closing GPS comport
09/07/2025 22:48:28 - Closing Rig TCP port
09/07/2025 22:50:16 - Email gateway error: Unable to receive email from IMAP server. Invalid credentials (Failure)
09/07/2025 22:50:16 - Failed to receive Email from IMAP server. Retry 4/5.
09/07/2025 22:51:50 - Debug mode disabled
09/07/2025 22:51:51 - Setting away status to true (load)
09/07/2025 22:51:51 - Setting unattended links ON (load)
09/07/2025 22:54:20 - Debug mode disabled
09/07/2025 22:54:21 - Setting away status to true (load)
09/07/2025 22:54:21 - Setting unattended links ON (load)
09/07/2025 22:55:13 - Debug mode disabled
09/07/2025 22:55:13 - Setting away status to true (load)
09/07/2025 22:55:13 - Setting unattended links ON (load)
09/07/2025 22:55:17 - Email gateway error: Unable to receive email from IMAP server. Invalid credentials (Failure)
09/07/2025 22:55:17 - Failed to receive Email from IMAP server. Retry 5/5.
09/07/2025 23:00:18 - Email gateway error: Unable to receive email from IMAP server. Invalid credentials (Failure)
09/07/2025 23:00:18 - SHUTTING DOWN EMAIL GATEWAY. Too many retries (exceeded limit of 5 retries)
09/07/2025 23:01:52 - Email Gateway activated (Manually)
09/07/2025 23:01:53 - Email Gateway disabled (Manually)
09/07/2025 23:01:53 - Email Gateway activated (Manually)
09/07/2025 23:02:21 - Closing Rig comport
09/07/2025 23:02:21 - Closing GPS comport
09/07/2025 23:02:21 - Closing Rig TCP port
09/07/2025 23:02:33 - Debug mode disabled
09/07/2025 23:02:33 - Setting away status to true (load)
09/07/2025 23:02:33 - Setting unattended links ON (load)
09/07/2025 23:02:41 - Sending beacon
09/07/2025 23:02:41 - KISS BEACON sent
09/07/2025 23:06:02 - Shutting down VarAC...
09/07/2025 23:06:05 - Exiting - Closing main command stream thread
Log messages are needed. when it turns orange there is some kind of a failure that will always reflect in the log file as an error message. please share the error message and we can try to assist you