[Pkg-citadel-devel] Bug#676802: Bug#676802: citadel-server: Fails to relay email via smarthost

Jamie Jones yagisan at yagisan.org
Mon Jun 11 13:05:56 UTC 2012


On Mon, 11 Jun 2012 18:10:29 +0900
"Michael Meskes" <meskes at debian.org> wrote:

> 
> tag 676802 upstream
> thanks
> 
> > Upon upgrading to citadel 8.11-2, however all outbound email fails
> > with “Connection broken during SMTP conversation”
> > 
> > No changes in configuration were made.
> 
> But the smtp code was changed, so it's difiicult to say without
> additional info like the syslog output of citserver from a send
> aproach, and maybe a tcpdump. Also you might want to look at
> http://citadel.org/doku.php?id=faq:mastering_your_os:net_sniff. 
> 
> Michael

I understand upstream has changed the SMTP code. I would expect that
even with a code change, that there would not be such a massive
regression in functionality however.

Ok, I've gone and pulled the logs from before I rolled back to 8.05
release. If you still need a tcp dump, I'll need to do a sandboxed
deployment, as I'm not keen on upgrading from 8.05 to 8.11 - it wasn't
a minor upgrade! 

I've censored the usernames, but left the domain names intact in the
log. I hope you'll find the logs of some use.

Thank you for your time and assistance.

-------- Start Logs --------
Jun  6 10:37:52 mail citserver[636]: -- db checkpoint --
Jun  6 10:37:52 mail citserver[636]: SMTPCQ: processing outbound queue
Jun  6 10:37:52 mail citserver[636]: SMTPCQ: queue run completed; 1 messages processed 0 activated
Jun  6 10:37:52 mail citserver[636]: network: no neighbor nodes are configured - not polling.
Jun  6 10:37:52 mail citserver[636]: No external notifiers configured on system/user
Jun  6 10:38:53 mail citserver[636]: -- db checkpoint --
Jun  6 10:38:53 mail citserver[636]: SMTPCQ: processing outbound queue
Jun  6 10:38:53 mail citserver[636]: SMTPC: Trying <4445> <*******@metro-geek.com> 1 / 1 
Jun  6 10:38:53 mail citserver[636]: SMTPCQ: queue run completed; 1 messages processed 1 activated
Jun  6 10:38:53 mail citserver[636]: network: no neighbor nodes are configured - not polling.
Jun  6 10:38:53 mail citserver[636]: No external notifiers configured on system/user
Jun  6 10:38:53 mail citserver[636]: SMTPC:IO[5]CC[5]S[4445][4] connecting to biglobe.ne.jp [49.129.31.76]:0 ...
Jun  6 10:39:54 mail citserver[636]: -- db checkpoint --
Jun  6 10:39:54 mail citserver[636]: SMTPCQ: processing outbound queue
Jun  6 10:39:54 mail citserver[636]: SMTPCQ: Msg No 4452: already in progress!
Jun  6 10:39:54 mail citserver[636]: SMTPCQ: queue run completed; 1 messages processed 0 activated
Jun  6 10:39:54 mail citserver[636]: network: no neighbor nodes are configured - not polling.
Jun  6 10:39:54 mail citserver[636]: No external notifiers configured on system/user
Jun  6 10:39:56 mail citserver[636]: SMTPC:IO[5]CC[5]S[4445][4] Delivery failed temporarily; will retry later. Time[63.204306s] Recipient <*****> @ <metro-geek.com> (*****) Status message: Connection broken during SMTP conversation
Jun  6 10:39:56 mail citserver[636]: CC[5]Final selection: __CitadelSMTPspoolout__ (Sent Items)
Jun  6 10:39:57 mail citserver[636]: Context: [  5]SRV[SMTP_Send] Session ended.
Jun  6 10:40:00 mail citserver[636]: Context: [  5]SRV[SMTP_Send] Session ended.
Jun  6 10:40:55 mail citserver[636]: -- db checkpoint --
Jun  6 10:40:55 mail citserver[636]: SMTPCQ: processing outbound queue
Jun  6 10:40:55 mail citserver[636]: SMTPCQ: queue run completed; 1 messages processed 0 activated
Jun  6 10:40:55 mail citserver[636]: network: no neighbor nodes are configured - not polling.
Jun  6 10:40:55 mail citserver[636]: No external notifiers configured on system/user
Jun  6 10:41:56 mail citserver[636]: -- db checkpoint --

----8< snip extra logs >8----

Jun  6 23:55:22 mail citserver[948]: -- db checkpoint --
Jun  6 23:55:22 mail citserver[948]: SMTPCQ: processing outbound queue
Jun  6 23:55:22 mail citserver[948]: SMTPC: Trying <4676> <*****@yahoo.com.au> 1 / 1 
Jun  6 23:55:22 mail citserver[948]: SMTPCQ: queue run completed; 9 messages processed 1 activated
Jun  6 23:55:22 mail citserver[948]: network: no neighbor nodes are configured - not polling.
Jun  6 23:55:22 mail citserver[948]: No external notifiers configured on system/user
Jun  6 23:55:22 mail citserver[948]: SMTPC:IO[20]CC[20]S[4676][19] connecting to biglobe.ne.jp [49.129.31.76]:0 ...
Jun  6 23:55:38 mail citserver[948]: [6][yagisan(2)] NOOP
Jun  6 23:56:23 mail citserver[948]: -- db checkpoint --
Jun  6 23:56:23 mail citserver[948]: SMTPCQ: processing outbound queue
Jun  6 23:56:23 mail citserver[948]: SMTPCQ: Msg No 4680: already in progress!
Jun  6 23:56:23 mail citserver[948]: SMTPCQ: queue run completed; 9 messages processed 0 activated
Jun  6 23:56:23 mail citserver[948]: network: no neighbor nodes are configured - not polling.
Jun  6 23:56:23 mail citserver[948]: No external notifiers configured on system/user
Jun  6 23:56:25 mail citserver[948]: SMTPC:IO[20]CC[20]S[4676][19] Delivery failed temporarily; will retry later. Time[63.189310s] Recipient <*****> @ <yahoo.com.au> (*****) Status message: Connection broken during SMTP conversation
Jun  6 23:56:25 mail citserver[948]: CC[20]Final selection: __CitadelSMTPspoolout__ (Sent Items)
Jun  6 23:56:25 mail citserver[948]: Context: [ 20]SRV[SMTP_Send] Session ended.
Jun  6 23:56:29 mail citserver[948]: Context: [ 20]SRV[SMTP_Send] Session ended.
Jun  6 23:57:24 mail citserver[948]: -- db checkpoint --
Jun  6 23:57:24 mail citserver[948]: SMTPCQ: processing outbound queue
Jun  6 23:57:24 mail citserver[948]: SMTPCQ: queue run completed; 9 messages processed 0 activated
Jun  6 23:57:24 mail citserver[948]: network: no neighbor nodes are configured - not polling.
Jun  6 23:57:24 mail citserver[948]: No external notifiers configured on system/user
Jun  6 23:58:25 mail citserver[948]: -- db checkpoint --
Jun  6 23:58:25 mail citserver[948]: SMTPCQ: processing outbound queue
Jun  6 23:58:25 mail citserver[948]: SMTPC: Trying <4546> <*****@yahoo.com.au> 1 / 5 
Jun  6 23:58:25 mail citserver[948]: SMTPC: Trying <4546> <*****@gmail.com> 2 / 5 
Jun  6 23:58:25 mail citserver[948]: SMTPC: Trying <4546> <*****@yahoo.com.au> 3 / 5 
Jun  6 23:58:25 mail citserver[948]: SMTPC: Trying <4546> <*****@gmail.com> 4 / 5 
Jun  6 23:58:25 mail citserver[948]: SMTPC: Trying <4546> <*****@bma.biglobe.ne.jp> 5 / 5 
Jun  6 23:58:25 mail citserver[948]: SMTPCQ: queue run completed; 9 messages processed 5 activated
Jun  6 23:58:25 mail citserver[948]: network: no neighbor nodes are configured - not polling.
Jun  6 23:58:25 mail citserver[948]: No external notifiers configured on system/user
Jun  6 23:58:25 mail citserver[948]: SMTPC:IO[22]CC[22]S[4546][21] connecting to biglobe.ne.jp [49.129.31.76]:0 ...
Jun  6 23:58:25 mail citserver[948]: SMTPC:IO[23]CC[23]S[4546][22] connecting to biglobe.ne.jp [49.129.31.76]:0 ...
Jun  6 23:58:25 mail citserver[948]: SMTPC:IO[24]CC[24]S[4546][23] connecting to biglobe.ne.jp [49.129.31.76]:0 ...
Jun  6 23:58:25 mail citserver[948]: SMTPC:IO[21]CC[21]S[4546][20] connecting to biglobe.ne.jp [49.129.31.76]:0 ...
Jun  6 23:58:25 mail citserver[948]: SMTPC:IO[25]CC[25]S[4546][24] connecting to biglobe.ne.jp [49.129.31.76]:0 ...
Jun  6 23:59:26 mail citserver[948]: -- db checkpoint --
Jun  6 23:59:26 mail citserver[948]: SMTPCQ: processing outbound queue
Jun  6 23:59:26 mail citserver[948]: SMTPCQ: Msg No 4631: already in progress!
Jun  6 23:59:26 mail citserver[948]: SMTPCQ: queue run completed; 9 messages processed 0 activated
Jun  6 23:59:26 mail citserver[948]: network: no neighbor nodes are configured - not polling.
Jun  6 23:59:26 mail citserver[948]: No external notifiers configured on system/user
Jun  6 23:59:28 mail citserver[948]: SMTPC:IO[25]CC[25]S[4546][24] Delivery failed temporarily; will retry later. Time[63.208411s] Recipient <*****> @ <bma.biglobe.ne.jp> (*****) Status message: Connection broken during SMTP conversation
Jun  6 23:59:28 mail citserver[948]: CC[25]Final selection: __CitadelSMTPspoolout__ (Sent Items)
Jun  6 23:59:28 mail citserver[948]: Context: [ 25]SRV[SMTP_Send] Session ended.
Jun  6 23:59:28 mail citserver[948]: SMTPC:IO[21]CC[21]S[4546][20] Delivery failed temporarily; will retry later. Time[63.754827s] Recipient <*****> @ <yahoo.com.au> (*****) Status message: Connection broken during SMTP conversation
Jun  6 23:59:29 mail citserver[948]: CC[21]Final selection: __CitadelSMTPspoolout__ (Sent Items)
Jun  6 23:59:29 mail citserver[948]: Context: [ 25]SRV[SMTP_Send] Session ended.
Jun  6 23:59:29 mail citserver[948]: Context: [ 21]SRV[SMTP_Send] Session ended.
Jun  6 23:59:29 mail citserver[948]: SMTPC:IO[24]CC[24]S[4546][23] Delivery failed temporarily; will retry later. Time[63.747163s] Recipient <*****> @ <gmail.com> (*****) Status message: Connection broken during SMTP conversation
Jun  6 23:59:29 mail citserver[948]: CC[24]Final selection: __CitadelSMTPspoolout__ (Sent Items)
Jun  6 23:59:30 mail citserver[948]: Context: [ 24]SRV[SMTP_Send] Session ended.
Jun  6 23:59:30 mail citserver[948]: SMTPC:IO[23]CC[23]S[4546][22] Delivery failed temporarily; will retry later. Time[63.747163s] Recipient <*****> @ <yahoo.com.au> (*****) Status message: Connection broken during SMTP conversation
Jun  6 23:59:30 mail citserver[948]: CC[23]Final selection: __CitadelSMTPspoolout__ (Sent Items)
Jun  6 23:59:30 mail citserver[948]: Context: [ 23]SRV[SMTP_Send] Session ended.
Jun  6 23:59:30 mail citserver[948]: SMTPC:IO[22]CC[22]S[4546][21] Delivery failed temporarily; will retry later. Time[63.747163s] Recipient <*****> @ <gmail.com> (*****) Status message: Connection broken during SMTP conversation
Jun  6 23:59:30 mail citserver[948]: CC[22]Final selection: __CitadelSMTPspoolout__ (Sent Items)
Jun  6 23:59:30 mail citserver[948]: Context: [ 22]SRV[SMTP_Send] Session ended.
Jun  6 23:59:34 mail citserver[948]: Context: [ 21]SRV[SMTP_Send] Session ended.
Jun  6 23:59:34 mail citserver[948]: Context: [ 22]SRV[SMTP_Send] Session ended.
Jun  6 23:59:34 mail citserver[948]: Context: [ 23]SRV[SMTP_Send] Session ended.
Jun  6 23:59:34 mail citserver[948]: Context: [ 24]SRV[SMTP_Send] Session ended.

-------- End Logs --------

-- 
Jamie Jones
Email: yagisan at yagisan.org

GPG/PGP signed mail preferred.
PGP Key ID 0x4B6E7209
Fingerprint E1FD 9D7E 6BB4 1BD4 AEB9 3091 0027 CEFA 4B6E 7209
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 198 bytes
Desc: not available
URL: <http://lists.alioth.debian.org/pipermail/pkg-citadel-devel/attachments/20120611/4bdf2a37/attachment.pgp>


More information about the Pkg-citadel-devel mailing list