Message won't send

[metalfoxdev]

• Android version: 13 (LineageOS)
• Device: Galaxy S7
• Delta Chat version: 1.42.4
• Expected behavior: I send a message, the loading icon appears on it then it displays a tick to show it is sent
• Actual behavior: when i send a message, it displays the loading symbol forever without the tick.
• Steps to reproduce the problem: send a message
• Screenshots: https://send.vis.ee/download/ef554ad815f13c1b/#XoS-WKaXaeb_3NdxmoMBNg
• Logs:

  
  --------- beginning of main
  12-01 07:30:56.020 12188 12243 E BufferQueueProducer: [VRI[ConversationListActivity]#26(BLAST Consumer)26](id:2f9c0000001a,api:0,p:-1,c:12188) disconnect: not connected (req=1)
  12-01 07:30:56.020 12188 12243 W libEGL  : EGLNativeWindowType 0x7845e7f490 disconnect failed
  12-01 07:30:56.043 12188 12188 I DeltaChat: ++++++++++++++++++ last ForegroundDetector.onActivityStopped() ++++++++++++++++++
  12-01 07:31:21.145 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #44
  12-01 07:31:28.300 12188 12188 I DeltaChat: ++++++++++++++++++ first ForegroundDetector.onActivityStarted() ++++++++++++++++++
  12-01 07:31:28.303 12188 13962 I DeltaChat: calling maybeNetwork()
  12-01 07:31:28.304 12188 13962 I DeltaChat: maybeNetwork() returned
  12-01 07:31:28.304 12188 12217 I DeltaChat: src/scheduler.rs:760: smtp fake idle - interrupted
  12-01 07:31:28.305 12188 12217 I DeltaChat: src/imap/idle.rs:75: INBOX: Idle wait was interrupted
  12-01 07:31:28.305 12188 12217 I DeltaChat: src/imap/idle.rs:75: DeltaChat: Idle wait was interrupted
  12-01 07:31:28.310 12188 12217 I DeltaChat: src/smtp.rs:652: Selected rows from SMTP queue: [404, 408, 409].
  12-01 07:31:28.314 12188 12188 I ConversationListFragment: 🤠 resuming chatlist: starting update timer
  12-01 07:31:28.334 12188 12243 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000,  [1440x2560]-format:1
  12-01 07:31:28.334 12188 12243 E OpenGLRenderer: Unable to match the desired swap behavior.
  12-01 07:31:28.370 12188 12188 I ConversationListFragment: 🤠 update timer: refreshing chatlist
  12-01 07:31:28.405 12188 12217 I DeltaChat: src/imap.rs:893: 0 mails read from "DeltaChat".
  12-01 07:31:29.148 12188 12188 I Choreographer: Skipped 44 frames!  The application may be doing too much work on its main thread.
  12-01 07:31:29.180 12188 13023 I OpenGLRenderer: Davey! duration=824ms; Flags=0, FrameTimelineVsyncId=1042200, IntendedVsync=2732837322407, Vsync=2732871220711, InputEventId=0, HandleInputStart=2732877466800, AnimationStart=2732877469992, PerformTraversalsStart=2732877516684, DrawStart=2733650720107, FrameDeadline=2732888717343, FrameInterval=2732877458838, FrameStartTime=16949152, SyncQueued=2733652795954, SyncStart=2733652888723, IssueDrawCommandsStart=2733653309684, SwapBuffers=2733658151223, FrameCompleted=2733662371647, DequeueBufferDuration=20731, QueueBufferDuration=249038, GpuCompleted=2733662371647, SwapBuffersCompleted=2733659612070, DisplayPresentTime=0, CommandSubmissionCompleted=2733658151223, 
  12-01 07:31:29.180 12188 12217 I DeltaChat: src/imap.rs:893: 0 mails read from "INBOX".
  12-01 07:31:29.180 12188 12217 I DeltaChat: src/scheduler.rs:629: IMAP session supports IDLE, using it.
  12-01 07:31:29.182 12188 12217 I DeltaChat: src/imap/scan_folders.rs:27: Starting full folder scan
  12-01 07:31:29.207 12188 12217 I DeltaChat: src/imap/idle.rs:54: DeltaChat: Idle entering wait-on-remote state
  12-01 07:31:29.271 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "Sent".
  12-01 07:31:29.364 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "[Gmail]".
  12-01 07:31:29.397 12188 12188 I ConversationListFragment: 🤠 pausing chatlist: cancel update timer
  12-01 07:31:29.418 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "[Gmail]/Sent Mail".
  12-01 07:31:29.460 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "[Gmail]/Spam".
  12-01 07:31:29.515 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "INBOX".
  12-01 07:31:29.569 12188 12217 I DeltaChat: src/scheduler.rs:629: IMAP session supports IDLE, using it.
  12-01 07:31:29.596 12188 12217 I DeltaChat: src/imap/idle.rs:54: INBOX: Idle entering wait-on-remote state
  12-01 07:31:29.727 12188 12217 W DeltaChat: src/scheduler.rs:711: send_smtp_messages failed: failed to send message: failed to load message Msg#1714 from the database: Query returned no rows
  12-01 07:31:29.727 12188 12217 I DeltaChat: src/scheduler.rs:728: smtp fake idle - started
  12-01 07:31:29.727 12188 12217 I DeltaChat: src/scheduler.rs:740: smtp has messages to retry, planning to retry 177 seconds later
  12-01 07:31:29.849 12188 12188 I DeltaChat: ++++++++++++++++++ last ForegroundDetector.onActivityStopped() ++++++++++++++++++
  12-01 07:31:29.868 12188 12243 E BufferQueueProducer: [VRI[ConversationListActivity]#27(BLAST Consumer)27](id:2f9c0000001b,api:0,p:-1,c:12188) disconnect: not connected (req=1)
  12-01 07:31:29.868 12188 12243 W libEGL  : EGLNativeWindowType 0x7845ef4600 disconnect failed
  12-01 07:31:30.276 12188 12463 I DirectShareUtil: Updated dynamic shortcuts, success: true
  12-01 07:31:45.561 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #45
  12-01 07:31:54.690 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #46
  12-01 07:31:57.742 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #47
  12-01 07:32:00.797 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #48
  12-01 07:32:22.101 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #49
  12-01 07:33:07.728 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #50
  12-01 07:33:22.901 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #51
  12-01 07:33:35.135 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #52
  12-01 07:34:26.728 12188 12217 I DeltaChat: src/scheduler.rs:760: smtp fake idle - interrupted
  12-01 07:34:26.740 12188 12217 I DeltaChat: src/smtp.rs:652: Selected rows from SMTP queue: [404, 408, 409].
  12-01 07:34:26.741 12188 12217 I DeltaChat: src/smtp.rs:91: Closing stale connection
  12-01 07:34:26.784 12188 12217 I DeltaChat: src/net.rs:71: Resolved smtp.gmail.com:465 into 74.125.206.109:465.
  12-01 07:34:26.788 12188 12217 I DeltaChat: src/net.rs:71: Resolved smtp.gmail.com:465 into [2a00:1450:400c:c04::6d]:465.
  12-01 07:34:28.781 12188 12217 W DeltaChat: src/scheduler.rs:711: send_smtp_messages failed: failed to send message: failed to load message Msg#1714 from the database: Query returned no rows
  12-01 07:34:28.781 12188 12217 I DeltaChat: src/scheduler.rs:728: smtp fake idle - started
  12-01 07:34:28.781 12188 12217 I DeltaChat: src/scheduler.rs:740: smtp has messages to retry, planning to retry 268 seconds later
  12-01 07:34:29.947 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #53
  12-01 07:34:39.135 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #54
  12-01 07:34:48.339 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #55
  12-01 07:34:51.385 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #56
  12-01 07:35:00.544 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #57
  12-01 07:35:03.593 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #58
  12-01 07:35:06.622 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #59
  12-01 07:35:12.662 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #60
  12-01 07:35:15.685 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #61
  12-01 07:35:21.763 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #62
  12-01 07:35:33.912 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #63
  12-01 07:35:36.992 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #64
  12-01 07:36:13.633 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #65
  12-01 07:36:19.673 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #66
  12-01 07:36:20.872 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #67
  12-01 07:36:21.675 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #68
  12-01 07:36:21.943 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #69
  12-01 07:36:21.974 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #70
  12-01 07:36:22.013 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #71
  12-01 07:36:22.714 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #72
  12-01 07:36:59.279 12188 12188 W PassphraseRequiredActionBarActivity: onCreate(null)
  12-01 07:36:59.397 12188 12188 I DeltaChat: ++++++++++++++++++ first ForegroundDetector.onActivityStarted() ++++++++++++++++++
  12-01 07:36:59.400 12188 15379 I DeltaChat: calling maybeNetwork()
  12-01 07:36:59.400 12188 15379 I DeltaChat: maybeNetwork() returned
  12-01 07:36:59.406 12188 12217 I DeltaChat: src/imap/idle.rs:75: DeltaChat: Idle wait was interrupted
  12-01 07:36:59.406 12188 12217 I DeltaChat: src/scheduler.rs:760: smtp fake idle - interrupted
  12-01 07:36:59.407 12188 12217 I DeltaChat: src/imap/idle.rs:75: INBOX: Idle wait was interrupted
  12-01 07:36:59.411 12188 12217 I DeltaChat: src/smtp.rs:652: Selected rows from SMTP queue: [404, 408, 409].
  12-01 07:36:59.411 12188 12217 I DeltaChat: src/smtp.rs:91: Closing stale connection
  12-01 07:36:59.411 12188 12463 I ConversationListFragment: executing debounced chatlist loading
  12-01 07:36:59.423 12188 12188 I ConversationListFragment: 🤠 resuming chatlist: starting update timer
  12-01 07:36:59.429 12188 12243 W Parcel  : Expecting binder but got null!
  12-01 07:36:59.447 12188 12217 I DeltaChat: src/net.rs:71: Resolved smtp.gmail.com:465 into 74.125.206.109:465.
  12-01 07:36:59.462 12188 12217 I DeltaChat: src/net.rs:71: Resolved smtp.gmail.com:465 into [2a00:1450:400c:c04::6c]:465.
  12-01 07:36:59.495 12188 12243 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000,  [1440x2560]-format:1
  12-01 07:36:59.495 12188 12243 E OpenGLRenderer: Unable to match the desired swap behavior.
  12-01 07:36:59.632 12188 12217 I DeltaChat: src/imap.rs:893: 0 mails read from "DeltaChat".
  12-01 07:36:59.812 12188 12217 I DeltaChat: src/scheduler.rs:629: IMAP session supports IDLE, using it.
  12-01 07:36:59.836 12188 12217 I DeltaChat: src/imap/idle.rs:54: DeltaChat: Idle entering wait-on-remote state
  12-01 07:36:59.850 12188 12217 I DeltaChat: src/imap.rs:893: 0 mails read from "INBOX".
  12-01 07:36:59.856 12188 12217 I DeltaChat: src/imap/scan_folders.rs:27: Starting full folder scan
  12-01 07:37:00.190 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "Sent".
  12-01 07:37:00.228 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "[Gmail]".
  12-01 07:37:00.358 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "[Gmail]/Sent Mail".
  12-01 07:37:00.470 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "[Gmail]/Spam".
  12-01 07:37:00.842 12188 12217 I DeltaChat: src/imap.rs:711: No new emails in folder "INBOX".
  12-01 07:37:00.918 12188 12217 I DeltaChat: src/scheduler.rs:629: IMAP session supports IDLE, using it.
  12-01 07:37:00.958 12188 12217 I DeltaChat: src/imap/idle.rs:54: INBOX: Idle entering wait-on-remote state
  12-01 07:37:01.140 12188 12198 I .b44t.messenger: NativeAlloc concurrent copying GC freed 27838(1267KB) AllocSpace objects, 5(292KB) LOS objects, 81% free, 5453KB/29MB, paused 168us,68us total 139.482ms
  12-01 07:37:01.391 12188 12217 W DeltaChat: src/scheduler.rs:711: send_smtp_messages failed: failed to send message: failed to load message Msg#1714 from the database: Query returned no rows
  12-01 07:37:01.391 12188 12217 I DeltaChat: src/scheduler.rs:728: smtp fake idle - started
  12-01 07:37:01.393 12188 12217 I DeltaChat: src/scheduler.rs:740: smtp has messages to retry, planning to retry 268 seconds later
  12-01 07:37:01.448 12188 12243 W Parcel  : Expecting binder but got null!
  12-01 07:37:01.450 12188 12463 I DirectShareUtil: Updated dynamic shortcuts, success: true
  12-01 07:37:01.503 12188 12243 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000,  [910x896]-format:1
  12-01 07:37:01.503 12188 12243 E OpenGLRenderer: Unable to match the desired swap behavior.
  12-01 07:37:01.734 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #73
  12-01 07:37:01.878 12188 12188 W Choreographer: Frame time is 0.003381 ms in the future!  Check that graphics HAL is generating vsync timestamps using the correct timebase.
  12-01 07:37:02.165 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #74
  12-01 07:37:03.336 12188 12188 I ConversationListFragment: 🤠 pausing chatlist: cancel update timer
  12-01 07:37:03.390 12188 12188 W PassphraseRequiredActionBarActivity: onCreate(null)
  12-01 07:37:03.444 12188 12243 W Parcel  : Expecting binder but got null!
  12-01 07:37:03.473 12188 12243 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000,  [1440x2560]-format:1
  12-01 07:37:03.473 12188 12243 E OpenGLRenderer: Unable to match the desired swap behavior.
  12-01 07:37:03.660 12188 12243 E BufferQueueProducer: [VRI[PopupWindow:72ad36]#29(BLAST Consumer)29](id:2f9c0000001d,api:0,p:-1,c:12188) disconnect: not connected (req=1)
  12-01 07:37:03.660 12188 12243 W libEGL  : EGLNativeWindowType 0x7845e9d170 disconnect failed
  12-01 07:37:03.660 12188 12243 D OpenGLRenderer: endAllActiveAnimators on 0x77d5f24a50 (MenuPopupWindow$MenuDropDownListView) with handle 0x76e5ef04a0
  12-01 07:37:04.104 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #75
  12-01 07:37:04.122 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #76
  12-01 07:37:04.126 12188 12243 E BufferQueueProducer: [VRI[RoutingActivity]#28(BLAST Consumer)28](id:2f9c0000001c,api:0,p:-1,c:12188) disconnect: not connected (req=1)
  12-01 07:37:04.126 12188 12243 W libEGL  : EGLNativeWindowType 0x7845eb2610 disconnect failed
  12-01 07:37:04.135 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #77
  12-01 07:37:05.154 12188 12226 I DeltaChat: ++++++++++++++++++ NetworkCallback.onCapabilitiesChanged() #78
  12-01 07:37:06.801 12188 12243 W Parcel  : Expecting binder but got null!
  12-01 07:37:06.831 12188 12243 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000,  [1440x2560]-format:1
  12-01 07:37:06.831 12188 12243 E OpenGLRenderer: Unable to match the desired swap behavior.

[r10s]

hm, for whatever reason, the core is not able to read the message from the database, we're getting failed to load message Msg#1714 from the database: Query returned no rows instead

does that happen for all messages? maybe do a backup first and then try to delete the stuck messages and try to send new ones, that may at least fix your issue - without knowing the reason, however

[metalfoxdev]

Thanks @r10s, i did a backup then restored it and it fixed the issue!

[r10s]

thanks for coming back, @metalfoxdev! if this ever happens again, please report!