To many open Connections for Exchange Server

[cracker0dks]

• Platform: Windows
• Delta Chat Desktop Version: 1.2.0
• Expected behavior: Only 2 Connections to the server
• Actual behavior: To many open connections (more than 16)
• Steps to reproduce the problem: Don't know if this is a Exchange only problem so maybe check the connection count
• Screenshots: We have a limit of 16 Connections per user.

Our external Exchange Expert wrote to me:

"Ich nehme an dass hier die Anwendung ihre Sessions nicht sauber trennt bevor sie neue aufbaut oder tatsächlich viele gleichzeitig betreiben will. Um beim Test sicher zu gehen parallel keine anderen IMAP clients betreiben. Bitte kontaktieren Sie den Hersteller und bitten um support."

English something like:

"I think your application does not close the session correctly before establishing a new one. [...] Please ask the software producer for help."

I closed Thunderbird and any other mail client and still got this error.

In the DeltaChat client / and any other mail client I want to connect then, I can't login for a short amount of time (Message: User/Password wrong) If I close the DC Desktop Client, then wait a few seconds, I can login from any other client again.

• DC Logs:

  "2020-03-25T16:28:19.627Z"  "main/index"    "INFO"      "cwd C:\\Users\\Cracker\\AppData\\Local\\DeltaChat"
  "2020-03-25T16:28:19.628Z"  "main/deltachat/login"  "INFO"      "Using deltachat instance C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\7261706861656c2e6672697473636840726575746c696e67656e2d756e69766572736974792e6465"
  "2020-03-25T16:28:19.677Z"  "main/menu" "INFO"      "rebuilding menu with locale en"
  "2020-03-25T16:28:19.691Z"  "main/deltachat/login"  "INFO"      "Ready"
  "2020-03-25T16:28:19.698Z"  "main/deltachat/login"  "INFO"      "dc_get_info"   {"bcc_self":"1","messages_in_contact_requests":"51","sentbox_watch":"1","level":"awesome","number_of_contacts":"406","number_of_chat_messages":"2123","private_key_count":"1","deltachat_core_version":"v1.26.0","database_dir":"C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\7261706861656c2e6672697473636840726575746c696e67656e2d756e69766572736974792e6465\\db.sqlite","public_key_count":"61","sqlite_version":"3.30.1","inbox_watch":"0","fingerprint":"60D912A11A45EDA3CA12A1F18DBE901D955170ED","number_of_chats":"47","is_configured":"1","mdns_enabled":"1","display_name":"Raphael","configured_sentbox_folder":"Gesendete Elemente","database_version":"63","mvbox_move":"0","blobdir":"C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\7261706861656c2e6672697473636840726575746c696e67656e2d756e69766572736974792e6465\\db.sqlite-blobs","selfavatar":"/data/data/chat.delta/files/avatars/raphael.fritsch@reutlingen-university.de","configured_mvbox_folder":"DeltaChat","entered_account_settings":"raphael.fritsch@reutlingen-university.de imap:unset:***:unset:0:cert_automatic smtp:unset:0:unset:0:cert_automatic 0","e2ee_enabled":"1","folders_configured":"3","arch":"64","used_account_settings":"raphael.fritsch@reutlingen-university.de imap:raphael.fritsch@reutlingen-university.de:***:exchange.reutlingen-university.de:143:cert_automatic smtp:raphael.fritsch@reutlingen-university.de:***:exchange.reutlingen-university.de:587:cert_automatic AUTH_NORMAL 0x4IMAP_STARTTLS 0x100SMTP_STARTTLS 0x10000","mvbox_watch":"1"}
  "2020-03-25T16:28:20.695Z"  "main/state"    "INFO"      "Saving state to C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\config.json"
  "2020-03-25T16:28:22.280Z"  "main/state"    "INFO"      "Saving state to C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\config.json"
  "2020-03-25T16:28:27.318Z"  "main/state"    "INFO"      "Saving state to C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\config.json"
  "2020-03-25T16:28:49.737Z"  "main/state"    "INFO"      "Saving state to C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\config.json"
  "2020-03-25T16:28:51.821Z"  "main/state"    "INFO"      "Saving state to C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\config.json"
  "2020-03-25T16:29:00.237Z"  "main/state"    "INFO"      "Saving state to C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\config.json"
  "2020-03-25T16:29:51.995Z"  "main/state"    "INFO"      "Saving state to C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\config.json"
  "2020-03-25T16:31:09.819Z"  "main/state"    "INFO"      "Saving state to C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\config.json"
  "2020-03-25T16:31:28.907Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\mimeparser.rs:421: Ignoring nested protected headers"
  "2020-03-25T16:31:39.692Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:31:39.694Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\job_thread.rs:185: SENTBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:34:53.917Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:34:53.919Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\job_thread.rs:185: MVBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:35:38.008Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:35:38.009Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\job_thread.rs:185: SENTBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:38:45.506Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:38:45.506Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\job_thread.rs:185: SENTBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:39:21.263Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:39:21.264Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\job_thread.rs:185: MVBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:41:53.480Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:41:53.480Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\job_thread.rs:185: SENTBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:42:35.813Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:42:35.814Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\job_thread.rs:185: MVBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:45:39.547Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:45:39.548Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\job_thread.rs:185: SENTBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:46:26.868Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:46:26.869Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\job_thread.rs:185: MVBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:48:43.954Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:48:43.957Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\job_thread.rs:185: SENTBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:49:44.175Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:49:44.178Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(20) src\\job_thread.rs:185: MVBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:52:32.916Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\idle.rs:116: Idle wait errored: Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:52:32.917Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\job_thread.rs:185: SENTBOX-IDLE failed: IMAP IDLE protocol failed to init/complete -> reconnecting"
  "2020-03-25T16:52:33.375Z"  "main/deltachat"    "ERROR" "\nonError (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:228:17),\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:234:13),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:657:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"    "Cannot login as \"raphael.fritsch@reutlingen-university.de\". Please check if the email address and the password are correct. (no response: code: None, info: Some(\"LOGIN failed.\"))"
  "2020-03-25T16:52:33.376Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\mod.rs:410: failed to setup imap handle: IMAP Could not login as cannot login as raphael.fritsch@reutlingen-university.de"
  "2020-03-25T16:52:33.376Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\job_thread.rs:90: connect+fetch failed: \"IMAP Connection Failed params: raphael.fritsch@reutlingen-university.de imap:raphael.fritsch@reutlingen-university.de:***:exchange.reutlingen-university.de:143:cert_automatic smtp:raphael.fritsch@reutlingen-university.de:***:exchange.reutlingen-university.de:587:cert_automatic AUTH_NORMAL 0x4IMAP_STARTTLS 0x100SMTP_STARTTLS 0x10000\", reconnect & retry"
  "2020-03-25T16:52:33.384Z"  "renderer/ipc"  "ERROR" "\nEventEmitter.<anonymous> (file:///C:/Users/Cracker/AppData/Local/Programs/deltachat-desktop/resources/app.asar/html-dist/bundle.js:117:631),\nEventEmitter.emit (events.js:205:15),\nObject.onMessage (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\electron.asar\\renderer\\init.js:42:16)"  "Cannot login as \"raphael.fritsch@reutlingen-university.de\". Please check if the email address and the password are correct. (no response: code: None, info: Some(\"LOGIN failed.\"))"
  "2020-03-25T16:52:33.748Z"  "main/deltachat"    "ERROR" "\nonError (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:228:17),\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:234:13),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:657:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"    "Cannot login as \"raphael.fritsch@reutlingen-university.de\". Please check if the email address and the password are correct. (no response: code: None, info: Some(\"LOGIN failed.\"))"
  "2020-03-25T16:52:33.748Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\mod.rs:410: failed to setup imap handle: IMAP Could not login as cannot login as raphael.fritsch@reutlingen-university.de"
  "2020-03-25T16:52:33.748Z"  "renderer/ipc"  "ERROR" "\nEventEmitter.<anonymous> (file:///C:/Users/Cracker/AppData/Local/Programs/deltachat-desktop/resources/app.asar/html-dist/bundle.js:117:631),\nEventEmitter.emit (events.js:205:15),\nObject.onMessage (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\electron.asar\\renderer\\init.js:42:16)"  "Cannot login as \"raphael.fritsch@reutlingen-university.de\". Please check if the email address and the password are correct. (no response: code: None, info: Some(\"LOGIN failed.\"))"
  "2020-03-25T16:52:33.749Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\job_thread.rs:93: connect+fetch failed: \"IMAP Connection Failed params: raphael.fritsch@reutlingen-university.de imap:raphael.fritsch@reutlingen-university.de:***:exchange.reutlingen-university.de:143:cert_automatic smtp:raphael.fritsch@reutlingen-university.de:***:exchange.reutlingen-university.de:587:cert_automatic AUTH_NORMAL 0x4IMAP_STARTTLS 0x100SMTP_STARTTLS 0x10000\""
  "2020-03-25T16:52:34.148Z"  "main/deltachat"    "ERROR" "\nonError (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:228:17),\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:234:13),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:657:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"    "Cannot login as \"raphael.fritsch@reutlingen-university.de\". Please check if the email address and the password are correct. (no response: code: None, info: Some(\"LOGIN failed.\"))"
  "2020-03-25T16:52:34.148Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(22) src\\imap\\mod.rs:410: failed to setup imap handle: IMAP Could not login as cannot login as raphael.fritsch@reutlingen-university.de"
  "2020-03-25T16:52:34.148Z"  "renderer/ipc"  "ERROR" "\nEventEmitter.<anonymous> (file:///C:/Users/Cracker/AppData/Local/Programs/deltachat-desktop/resources/app.asar/html-dist/bundle.js:117:631),\nEventEmitter.emit (events.js:205:15),\nObject.onMessage (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\electron.asar\\renderer\\init.js:42:16)"  "Cannot login as \"raphael.fritsch@reutlingen-university.de\". Please check if the email address and the password are correct. (no response: code: None, info: Some(\"LOGIN failed.\"))"
  "2020-03-25T16:52:34.532Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(14) src\\imap\\mod.rs:920: IMAP failed to store: (3739, +FLAGS (\\Seen)) Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:52:34.706Z"  "main/deltachat"    "WARNING"   "\nDeltaChat.<anonymous> (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\tsc-dist\\main\\deltachat\\controller.js:224:17),\nDeltaChat.emit (events.js:200:13),\nhandleEvent (C:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:628:18),\nC:\\Users\\Cracker\\AppData\\Local\\Programs\\deltachat-desktop\\resources\\app.asar\\node_modules\\deltachat-node\\dist\\deltachat.js:50:13"  "ThreadId(14) src\\imap\\mod.rs:920: IMAP failed to store: (3740, +FLAGS (\\Seen)) Io(Os { code: 10054, kind: ConnectionReset, message: \"Eine vorhandene Verbindung wurde vom Remotehost geschlossen.\" })"
  "2020-03-25T16:52:47.140Z"  "main/state"    "INFO"      "Saving state to C:\\Users\\Cracker\\AppData\\Local\\DeltaChat\\config.json"
  "2020-03-25T16:52:47.142Z"  "main/index"    "INFO"      "Quitting now. Bye."

  This log is from some days ago, but still get the same error from time to time since then so this is still a problem.

Greetings

[r10s]

not sure about desktop in special, but the core typically uses 3 imap-connections. if interaction with non-delta-clients and/or multi device is not needed, the "Watch DeltaChat folder" and "Watch Sent folder" can be disabled at "Settings" and you go down to only 1 imap-connection this way.

this is the theory, of course, there can be bugs :)

[cracker0dks]

Yeah I already removed watch inbox and moved deltaChat msgs into the DeltaChat folder with a server rule. (Also removed watched folders by thunderbird and Android dc client just in case). But still get the error even when only dc desktop is running.

[hpk42]

@cracker0dks do you have and switch between multiple desktop accounts? If you do, can you see to get a recording of the log before/during/after the switch? @jikstra @Simon-Laux @nicodh maybe switching desktop accounts does not terminates the just-left account correctly?

my 2c

[cracker0dks]

This even happens without switch. Fresh start and only using this one account. I will delete the second account, maybe this helps finding the bug.

[gerryfrancis]

@cracker0dks I wonder if the log file you provided really is from Delta Chat Desktop version 1.2.0:

"deltachat_core_version":"v1.26.0"

[cracker0dks]

I wrote: "This log is from some days ago, but still get the same error from time to time" should I post a new log as well ?

[gerryfrancis]

@cracker0dks I guess this log in here is not very helpful, anyway. Please provide another one, the time period should be some hours to see what is going on. Thanks in advance.

[gerryfrancis]

@cracker0dks Any news on this?

[cracker0dks]

Oh sorry, didn't saw your post. I reinstalled 3 Days ago, same problem. Here is the log since then (About 3 Days, ~5MB) https://cloud13.de/index.php/s/XRYqmn7WJ8xBnEe thanks

[gerryfrancis]

@cracker0dks Thank you for the log, though I cannot locate where the problem lies. My best guess is that multiple clients are logged in with your account. (One client may use more than one connection.) Remember, the screenshot in your first post of the issue says "16 objects of type Session", so the maximum of 16 connections per user does include those from/to Outlook and any other client, too.

[cracker0dks]

I closed every other client and still got this problem. Also should work even with all of my 3 clients running because all in all there should not be more than 6 Subed folders (6 Connections). Changed the max connection limits in thunderbird / subed folders and removed DC from watching any other folder than DC (added server rule to move dc mails to dc folder).

[hpk42]

i couldn't read that log -- what's ".tsv"?

On Thu, Apr 09, 2020 at 12:25 -0700, Cracker wrote:

Oh sorry, didn't saw your post. I reinstalled 3 Days ago, same problem. Here is the log since then (About 3 Days, ~5MB) https://cloud13.de/index.php/s/XRYqmn7WJ8xBnEe thanks

-- You are receiving this because you commented. Reply to this email directly or view it on GitHub: https://github.com/deltachat/deltachat-desktop/issues/1527#issuecomment-611710588

[cracker0dks]

logfile from DC Dekstop, just a text file I think.

[gerryfrancis]

logfile from DC Dekstop, just a text file I think.

Correct, all log files from Delta Chat Desktop have this extension.

[hpk42]

ah k -- for some reason my libreoffice decided to suggest opening it with utf16 resulting in chinese signs mostly ... forcing latin1/ascii helped.

anyway, the log file contains tons of failed-to-login messages as warnings. And it seems it does not show INFO messages showing even a single successful login.

I think we first need to get better logs (by default) with desktop as this is not really helpful. cc @jikstra @simon-laux @nicodh At least INFO level messages from core should be shown by default.

On Sat, Apr 11, 2020 at 11:30 -0700, Cracker wrote:

logfile from DC Dekstop, just a text file I think.

-- You are receiving this because you commented. Reply to this email directly or view it on GitHub: https://github.com/deltachat/deltachat-desktop/issues/1527#issuecomment-612484530

[Simon-Laux]

Sure we can change the debug level of core info messages, but this will apply only in the next release after changing it. See the logging options for how to log everything now: https://github.com/deltachat/deltachat-desktop/blob/master/README.md#logging-options

TSV is the same as CSV, only difference is that it uses tabs instead of commas, best opened with ms excel or libreoffice calc. Also the format should be utf-8... strange that you get Chinese signs.

On Apr 12, 2020, at 8:01 PM, holger krekel notifications@github.com wrote:

ah k -- for some reason my libreoffice decided to suggest opening it with utf16 resulting in chinese signs mostly ... forcing latin1/ascii helped.

anyway, the log file contains tons of failed-to-login messages as warnings. And it seems it does not show INFO messages showing even a single successful login.

I think we first need to get better logs (by default) with desktop as this is not really helpful. cc @jikstra @simon-laux @nicodh At least INFO level messages from core should be shown by default.

On Sat, Apr 11, 2020 at 11:30 -0700, Cracker wrote:

logfile from DC Dekstop, just a text file I think.

-- You are receiving this because you commented. Reply to this email directly or view it on GitHub: https://github.com/deltachat/deltachat-desktop/issues/1527#issuecomment-612484530 — You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub, or unsubscribe.

[hpk42]

On Mon, Apr 13, 2020 at 04:58 -0700, Simon Laux wrote:

Sure we can change the debug level of core info messages, but this will apply only in the next release after changing it. See the logging options for how to log everything now: https://github.com/deltachat/deltachat-desktop/blob/master/README.md#logging-options

thanks -- let's also change the default as i don't want to teach users who already submitted a log that they should redo and try to use some command line options ....

TSV is the same as CSV, only difference is that it uses tabs instead of commas, best opened with ms excel or libreoffice calc. Also the format should be utf-8... strange that you get Chinese signs.

maybe libreoffice had some "default" cached from other documents -- whatever. not to worry about.

[gerryfrancis]

Maybe related to https://github.com/deltachat/deltachat-core-rust/issues/1402 .

[cracker0dks]

yes maybe, I only have one account but could be still the problem somehow

[Simon-Laux]

Does this still occur?

[cracker0dks]

I'm not using this server anymore but was present the last time I checked. You can close the issue if you want to.