Bug 1842655 Comment 7 Edit History

Note: The actual edited comment in the bug view page will always show the original commenter’s name and original timestamp.

Original comment by

Alex Franchuk [:afranchuk]

on 2023-07-19 06:42:53 PDT

I was able to somewhat trivially reproduce this. I closed Thunderbird, turned off my internet connection, then opened Thunderbird. For good measure I waited about 10 minutes; during this time I sent an email to the account that is configured in Thunderbird. I then turned my internet connection back on. I waited for about an hour but Thunderbird never attempted to retrieve mail. Then I clicked Get Messages and the mail came in.

I did this with `IMAP:4` logging. Below is the log before it stopped polling. No other log statements came out until I manually triggered a message retrieval.

```
2023-07-19 12:13:28.418685 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:13:28.418876 UTC - [Parent 4985: IMAP]: D/IMAP ImapThreadMainLoop entering [this=7f2b59a3c900]
2023-07-19 12:13:28.419145 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.419148 UTC - [Parent 4985: Main Thread]: I/IMAP no auth, cnt 1 & no TLS error - q URL:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.419149 UTC - [Parent 4985: Main Thread]: I/IMAP queuing url:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.428152 UTC - [Parent 4985: Main Thread]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:SetupWithUrlCallback: clearing IMAP_CONNECTION_IS_OPEN
2023-07-19 12:13:28.428176 UTC - [Parent 4985: Main Thread]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:SetupSinkProxy: got m_imapMailFolderSink
2023-07-19 12:13:28.428188 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:ProcessCurrentURL: entering
2023-07-19 12:13:28.428192 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:ProcessCurrentURL:imap://afranchuk%40mozilla%2Ecom@imap.gmail.com:993/discoverallboxes:  = currentUrl
2023-07-19 12:13:28.444731 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:CreateNewLineFromSocket: clearing IMAP_CONNECTION_IS_OPEN - rv = 804b001e
2023-07-19 12:13:28.447765 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:TellThreadToDie: close socket connection
2023-07-19 12:13:28.447769 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:CreateNewLineFromSocket: (null)
2023-07-19 12:13:28.447771 UTC - [Parent 4985: IMAP]: D/IMAP SetConnectionStatus(0x804b001e)
2023-07-19 12:13:28.447774 UTC - [Parent 4985: IMAP]: D/IMAP URL failed with code 0x804b001e (imap://afranchuk%40mozilla%2Ecom@imap.gmail.com:993/discoverallboxes)
2023-07-19 12:13:28.452913 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:ProcessCurrentURL: aborting queued urls
2023-07-19 12:13:28.458641 UTC - [Parent 4985: IMAP]: D/IMAP ImapThreadMainLoop leaving [this=7f2b59a3c900]
2023-07-19 12:13:28.568361 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:13:28.568591 UTC - [Parent 4985: IMAP]: D/IMAP ImapThreadMainLoop entering [this=7f2b4f503f00]
2023-07-19 12:13:28.568618 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.568621 UTC - [Parent 4985: Main Thread]: I/IMAP no auth, cnt 1 & no TLS error - q URL:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.568622 UTC - [Parent 4985: Main Thread]: I/IMAP queuing url:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.576922 UTC - [Parent 4985: Main Thread]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:SetupWithUrlCallback: clearing IMAP_CONNECTION_IS_OPEN
2023-07-19 12:13:28.576943 UTC - [Parent 4985: Main Thread]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:SetupSinkProxy: got m_imapMailFolderSink
2023-07-19 12:13:28.577078 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:ProcessCurrentURL: entering
2023-07-19 12:13:28.577082 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:ProcessCurrentURL:imap://afranchuk%40mozilla%2Ecom@imap.gmail.com:993/discoverallboxes:  = currentUrl
2023-07-19 12:13:28.587905 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:CreateNewLineFromSocket: clearing IMAP_CONNECTION_IS_OPEN - rv = 804b001e
2023-07-19 12:13:28.592211 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:TellThreadToDie: close socket connection
2023-07-19 12:13:28.592215 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:CreateNewLineFromSocket: (null)
2023-07-19 12:13:28.592217 UTC - [Parent 4985: IMAP]: D/IMAP SetConnectionStatus(0x804b001e)
2023-07-19 12:13:28.592220 UTC - [Parent 4985: IMAP]: D/IMAP URL failed with code 0x804b001e (imap://afranchuk%40mozilla%2Ecom@imap.gmail.com:993/discoverallboxes)
2023-07-19 12:13:28.592730 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:ProcessCurrentURL: aborting queued urls
2023-07-19 12:13:28.592743 UTC - [Parent 4985: IMAP]: D/IMAP ImapThreadMainLoop leaving [this=7f2b4f503f00]
2023-07-19 12:23:41.549226 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:23:41.549250 UTC - [Parent 4985: Main Thread]: I/IMAP no auth, cnt 0, pwd empty & no win - q URL:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:23:41.549257 UTC - [Parent 4985: Main Thread]: I/IMAP queuing url:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:23:41.549332 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:23:41.549338 UTC - [Parent 4985: Main Thread]: I/IMAP no auth, cnt 0, pwd empty & no win - q URL:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:23:41.549343 UTC - [Parent 4985: Main Thread]: I/IMAP queuing url:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
```

Revision 1 by

Alex Franchuk [:afranchuk]

on 2023-07-19 06:43:17 PDT

I was able to somewhat trivially reproduce this. I closed (exited) Thunderbird, turned off my internet connection, then opened Thunderbird. For good measure I waited about 10 minutes; during this time I sent an email to the account that is configured in Thunderbird. I then turned my internet connection back on. I waited for about an hour but Thunderbird never attempted to retrieve mail. Then I clicked Get Messages and the mail came in.

I did this with `IMAP:4` logging. Below is the log before it stopped polling. No other log statements came out until I manually triggered a message retrieval.

```
2023-07-19 12:13:28.418685 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:13:28.418876 UTC - [Parent 4985: IMAP]: D/IMAP ImapThreadMainLoop entering [this=7f2b59a3c900]
2023-07-19 12:13:28.419145 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.419148 UTC - [Parent 4985: Main Thread]: I/IMAP no auth, cnt 1 & no TLS error - q URL:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.419149 UTC - [Parent 4985: Main Thread]: I/IMAP queuing url:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.428152 UTC - [Parent 4985: Main Thread]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:SetupWithUrlCallback: clearing IMAP_CONNECTION_IS_OPEN
2023-07-19 12:13:28.428176 UTC - [Parent 4985: Main Thread]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:SetupSinkProxy: got m_imapMailFolderSink
2023-07-19 12:13:28.428188 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:ProcessCurrentURL: entering
2023-07-19 12:13:28.428192 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:ProcessCurrentURL:imap://afranchuk%40mozilla%2Ecom@imap.gmail.com:993/discoverallboxes:  = currentUrl
2023-07-19 12:13:28.444731 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:CreateNewLineFromSocket: clearing IMAP_CONNECTION_IS_OPEN - rv = 804b001e
2023-07-19 12:13:28.447765 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:TellThreadToDie: close socket connection
2023-07-19 12:13:28.447769 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:CreateNewLineFromSocket: (null)
2023-07-19 12:13:28.447771 UTC - [Parent 4985: IMAP]: D/IMAP SetConnectionStatus(0x804b001e)
2023-07-19 12:13:28.447774 UTC - [Parent 4985: IMAP]: D/IMAP URL failed with code 0x804b001e (imap://afranchuk%40mozilla%2Ecom@imap.gmail.com:993/discoverallboxes)
2023-07-19 12:13:28.452913 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b59a3c900:imap.gmail.com:NA:ProcessCurrentURL: aborting queued urls
2023-07-19 12:13:28.458641 UTC - [Parent 4985: IMAP]: D/IMAP ImapThreadMainLoop leaving [this=7f2b59a3c900]
2023-07-19 12:13:28.568361 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:13:28.568591 UTC - [Parent 4985: IMAP]: D/IMAP ImapThreadMainLoop entering [this=7f2b4f503f00]
2023-07-19 12:13:28.568618 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.568621 UTC - [Parent 4985: Main Thread]: I/IMAP no auth, cnt 1 & no TLS error - q URL:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.568622 UTC - [Parent 4985: Main Thread]: I/IMAP queuing url:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:13:28.576922 UTC - [Parent 4985: Main Thread]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:SetupWithUrlCallback: clearing IMAP_CONNECTION_IS_OPEN
2023-07-19 12:13:28.576943 UTC - [Parent 4985: Main Thread]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:SetupSinkProxy: got m_imapMailFolderSink
2023-07-19 12:13:28.577078 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:ProcessCurrentURL: entering
2023-07-19 12:13:28.577082 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:ProcessCurrentURL:imap://afranchuk%40mozilla%2Ecom@imap.gmail.com:993/discoverallboxes:  = currentUrl
2023-07-19 12:13:28.587905 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:CreateNewLineFromSocket: clearing IMAP_CONNECTION_IS_OPEN - rv = 804b001e
2023-07-19 12:13:28.592211 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:TellThreadToDie: close socket connection
2023-07-19 12:13:28.592215 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:CreateNewLineFromSocket: (null)
2023-07-19 12:13:28.592217 UTC - [Parent 4985: IMAP]: D/IMAP SetConnectionStatus(0x804b001e)
2023-07-19 12:13:28.592220 UTC - [Parent 4985: IMAP]: D/IMAP URL failed with code 0x804b001e (imap://afranchuk%40mozilla%2Ecom@imap.gmail.com:993/discoverallboxes)
2023-07-19 12:13:28.592730 UTC - [Parent 4985: IMAP]: I/IMAP 7f2b4f503f00:imap.gmail.com:NA:ProcessCurrentURL: aborting queued urls
2023-07-19 12:13:28.592743 UTC - [Parent 4985: IMAP]: D/IMAP ImapThreadMainLoop leaving [this=7f2b4f503f00]
2023-07-19 12:23:41.549226 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:23:41.549250 UTC - [Parent 4985: Main Thread]: I/IMAP no auth, cnt 0, pwd empty & no win - q URL:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:23:41.549257 UTC - [Parent 4985: Main Thread]: I/IMAP queuing url:imap://afranchuk@mozilla.com@imap.gmail.com:993/discoverallboxes
2023-07-19 12:23:41.549332 UTC - [Parent 4985: Main Thread]: I/IMAP check for auth'd:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:23:41.549338 UTC - [Parent 4985: Main Thread]: I/IMAP no auth, cnt 0, pwd empty & no win - q URL:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
2023-07-19 12:23:41.549343 UTC - [Parent 4985: Main Thread]: I/IMAP queuing url:imap://afranchuk@mozilla.com@imap.gmail.com:993/select>/INBOX
```

Back to Bug 1842655 Comment 7