Welcome to the Cumulus Support forum.

Latest Cumulus MX V4 release 4.4.2 (build 4085) - 12 March 2025

Latest Cumulus MX V3 release 3.28.6 (build 3283) - 21 March 2024

Legacy Cumulus 1 release 1.9.4 (build 1099) - 28 November 2014
(a patch is available for 1.9.4 build 1099 that extends the date range of drop-down menus to 2030)

Download the Software (Cumulus MX / Cumulus 1 and other related items) from the Wiki

If you are posting a new Topic about an error or if you need help PLEASE read this first viewtopic.php?p=164080#p164080

B3196 SFTP failure

From build 3044 the development baton passed to Mark Crossley. Mark has been responsible for all the Builds since. He has made the code available on GitHub. It is Mark's hope that others will join in this development, but at the very least he welcomes your ideas for future developments (see Cumulus MX Development suggestions).

Moderator: mcrossley

Post Reply
water01
Posts: 3670
Joined: Sat 13 Aug 2011 9:33 am
Weather Station: Ecowitt HP2551
Operating System: Windows 10/11 64bit Synology NAS
Location: Burnham-on-Sea
Contact:

B3196 SFTP failure

Post by water01 »

Mark my SFTP upload failed as it lost the connection but it threw some errors. Once I fixed the connection it recovered but I thought you ought to see the errors.
2022-07-29 13:40:00.462 Updating CWOP
2022-07-29 13:40:13.774 Ecowitt Gateway uptime = 0 secs - 00:00:00
2022-07-29 13:45:00.159 DoLogFile: Writing log entry for 29/07/2022 13:45:00
2022-07-29 13:45:00.174 DoLogFile: log entry for 29/07/2022 13:45:00 written
2022-07-29 13:45:00.174 Writing today.ini, LastUpdateTime = 29/07/2022 13:45:00 raindaystart = 12.213 rain counter = 12.213
2022-07-29 13:50:00.556 DoLogFile: Writing log entry for 29/07/2022 13:50:00
2022-07-29 13:50:00.556 DoLogFile: log entry for 29/07/2022 13:50:00 written
2022-07-29 13:50:00.556 Writing today.ini, LastUpdateTime = 29/07/2022 13:50:00 raindaystart = 12.213 rain counter = 12.213
2022-07-29 13:50:00.556 Updating CWOP
2022-07-29 13:54:07.051 SFTP[62]: Error uploading realtime.txt to /home/dmjsyste/public_html/weatherbos/realtime.txttmp : An established connection was aborted by the server.
2022-07-29 13:54:07.051 Realtime[62]: Aborting this upload
2022-07-29 13:54:07.051 Realtime[62]: Error during realtime FTP update that requires reconnection
2022-07-29 13:54:07.051 RealtimeReconnect: Realtime ftp attempting disconnect
2022-07-29 13:54:07.051 RealtimeReconnect: Realtime ftp attempting to reconnect
2022-07-29 13:54:07.051 RealtimeReconnect: Realtime ftp attempting to reinitialise the connection
2022-07-29 13:54:07.051 RealtimeSSHLogin: Attempting realtime SFTP connect to host 87.247.241.226 on port 3784
2022-07-29 13:54:26.254 Realtime[62]: Error encountered during MySQL operation = Connect Timeout expired.
2022-07-29 13:54:28.097 RealtimeSSHLogin: Error connecting SFTP - A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond
2022-07-29 13:54:28.097 RealtimeReconnect: Realtime ftp connection failed to connect after reinitialisation
2022-07-29 13:54:28.097 RealtimeReconnect: Sleeping for 20 seconds before trying again...
2022-07-29 13:54:32.878 Realtime[63]: Error encountered during MySQL operation = Connect Timeout expired.
2022-07-29 13:54:32.878 SendEmail: Sending email, to [david@dmjsystems.co.uk], subject [Cumulus MX Alarm], body ["A Cumulus MX alarm has been triggered.\r\nMySQL uploads are failing.\r\nLast error: C" +
"onnect Timeout expired."]...
2022-07-29 13:54:43.972 SendEmail: Error - System.Net.Sockets.SocketException (0x80004005): No such host is known
at System.Net.Dns.HostResolutionEndHelper(IAsyncResult asyncResult)
at System.Net.Dns.EndGetHostAddresses(IAsyncResult asyncResult)
at System.Threading.Tasks.TaskFactory`1.FromAsyncCoreLogic(IAsyncResult iar, Func`2 endFunction, Action`1 endAction, Task`1 promise, Boolean requiresSynchronization)
--- End of stack trace from previous location where exception was thrown ---
at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
at MailKit.Net.SocketUtils.<ConnectAsync>d__0.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
at MailKit.Net.SocketUtils.<ConnectAsync>d__1.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
at MailKit.MailService.<ConnectNetwork>d__74.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd(Task task)
at MailKit.Net.Smtp.SmtpClient.<ConnectAsync>d__100.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd(Task task)
at CumulusMX.EmailSender.<SendEmail>d__4.MoveNext()
2022-07-29 13:54:47.862 Realtime[64]: Failed MySQL updates are present
2022-07-29 13:54:48.112 RealtimeReconnect: Realtime ftp attempting disconnect
2022-07-29 13:54:48.112 RealtimeReconnect: Realtime ftp disconnected
2022-07-29 13:54:48.112 RealtimeReconnect: Realtime ftp attempting to reconnect
2022-07-29 13:55:00.393 *** Data input appears to have stopped
2022-07-29 13:55:02.878 Realtime[64]: Connection to MySQL server has failed, adding this update to the failed list
2022-07-29 13:55:09.174 RealtimeReconnect: Realtime ftp attempting to reinitialise the connection
2022-07-29 13:55:09.174 RealtimeSSHLogin: Attempting realtime SFTP connect to host 87.247.241.226 on port 3784
2022-07-29 13:55:24.689 RealtimeSSHLogin: Realtime SFTP connected
2022-07-29 13:55:24.689 RealtimeReconnect: Realtime ftp connection reinitialised
2022-07-29 13:55:24.689 RealtimeReconnect: Realtime ftp testing the connection
2022-07-29 13:55:24.689 RealtimeReconnect: Realtime ftp connection test found Present Working Directory OK - [/home/dmjsyste]
2022-07-29 13:55:24.689 RealtimeReconnect: Realtime FTP now connected to server (tested)
2022-07-29 13:55:24.689 RealtimeReconnect: Realtime FTP operations will be restarted
2022-07-29 13:56:18.884 Realtime[67]: Failed MySQL updates are present
2022-07-29 13:56:18.978 MySqlCheckConnection: Connected to server ok, default database = dmjsyste_cumulus
2022-07-29 13:56:19.494 Realtime[67]: Connection to MySQL server is OK, trying to upload 3 failed commands
2022-07-29 13:56:19.634 Realtime[67]: Upload of failed MySQL commands complete
David
Image
User avatar
mcrossley
Posts: 14388
Joined: Thu 07 Jan 2010 9:44 pm
Weather Station: Davis VP2/WLL
Operating System: Bullseye Lite rPi
Location: Wilmslow, Cheshire, UK
Contact:

Re: B3196 SFTP failure

Post by mcrossley »

Thanks David, that all looks OK, the sort of errors expected, but the important bit was that it recovered OK!
Post Reply