Le 07/01/2010 20:37, Victor Duchovni a écrit :
On Thu, Jan 07, 2010 at 08:29:44PM +0200, Patrick Chemla wrote:
Here the logs:
This is just the qmgr(8) warnings about a clogged queue. Other than
telling us that all the mail is going to "localpc2105.com", this
is not very useful. Where are the logs from smtp(8)?
What transport is "localpc2105.com" destined for? Any earlier
logging about actual delivery attempts for this destination?
Victor, thank you for your interest.
Daily logs are huge.
Here is a sample of deliveries:
Jan 7 22:02:57 postfix postfix/qmgr[26441]: 5B91F873F6: removed
Jan 7 22:02:57 postfix postfix/smtp[27180]: 375DDD5923:
to=<lexoti...@gmail.com>, relay=a139.localpc2105.com[10.0.0.139]:25,
conn_use=59, delay=61550, delays=17019/44435/96/0.17, dsn=2.0.0,
status=sent (250 ok 1262894577 qp 12113)
Jan 7 22:02:57 postfix postfix/qmgr[26441]: 375DDD5923: removed
Jan 7 22:02:58 postfix postfix/smtp[27070]: 7F0F2943B3:
to=<gpo...@wanadoo.fr>, relay=a70.localpc2105.com[10.0.0.70]:25,
conn_use=10, delay=73795, delays=29264/44481/50/0.21, dsn=2.0.0,
status=sent (250 ok 1262894577 qp 23067)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 7F0F2943B3: removed
Jan 7 22:02:58 postfix postfix/smtp[27050]: 32BB182182:
to=<gmarin-jardins-lois...@wanadoo.fr>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=48, delay=73799,
delays=29268/44466/65/0.28, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12121)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 32BB182182: removed
Jan 7 22:02:58 postfix postfix/smtp[26758]: 577D6C7F7D:
to=<gerardtremb...@vinsdusiecle.com>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=60, delay=68451,
delays=23920/44481/50/0.29, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12122)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 577D6C7F7D: removed
Jan 7 22:02:58 postfix postfix/smtp[26935]: CDCE074F53:
to=<christian.lebe...@arcelor.com>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=49, delay=104597,
delays=60065/44421/110/0.3, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12135)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: CDCE074F53: removed
Jan 7 22:02:58 postfix postfix/smtp[26708]: 4B0B6E77FD:
to=<m...@metaproductique.com>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=61, delay=46137,
delays=1606/44461/70/0.31, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12136)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 4B0B6E77FD: removed
Jan 7 22:02:58 postfix postfix/smtp[26794]: D2CB5DC84C:
to=<secretar...@mairie-charly.fr>,
relay=a70.localpc2105.com[10.0.0.70]:25, conn_use=11, delay=58160,
delays=13628/44481/50/0.23, dsn=2.0.0, status=sent (250 ok 1262894578 qp
23076)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: D2CB5DC84C: removed
Jan 7 22:02:58 postfix postfix/smtp[26968]: 1A651E17E0:
to=<davau.br...@orange.fr>, relay=a74.localpc2105.com[10.0.0.74]:25,
conn_use=2, delay=54426, delays=9894/44462/69/0.27, dsn=2.0.0,
status=sent (250 ok 1262894578 qp 7411)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 1A651E17E0: removed
Jan 7 22:02:58 postfix postfix/smtp[27037]: 4CCC486B55:
to=<lenaerts.natuurst...@pandora.be>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=50, delay=45538,
delays=1005/44407/125/0.17, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12150)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 4CCC486B55: removed
Jan 7 22:02:58 postfix postfix/smtp[27188]: D130997201:
to=<cont...@afcmecanum.com>, relay=a74.localpc2105.com[10.0.0.74]:25,
conn_use=2, delay=71536, delays=27004/44448/84/0.28, dsn=2.0.0,
status=sent (250 ok 1262894578 qp 7412)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: D130997201: removed
Jan 7 22:02:59 postfix postfix/smtp[27033]: 6BD743906A:
to=<copyboli...@orange.fr>, relay=a139.localpc2105.com[10.0.0.139]:25,
conn_use=62, delay=81473, delays=36941/44467/65/0.24, dsn=2.0.0,
status=sent (250 ok 1262894579 qp 12157)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 6BD743906A: removed
Jan 7 22:02:59 postfix postfix/smtp[26793]: 84947C14B2:
to=<wgall...@saemshema.com>, relay=a70.localpc2105.com[10.0.0.70]:25,
conn_use=12, delay=69401, delays=24868/44469/63/0.2, dsn=2.0.0,
status=sent (250 ok 1262894578 qp 23084)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 84947C14B2: removed
Jan 7 22:02:59 postfix postfix/smtp[26737]: 6023552F52:
to=<cont...@installation-spa-gard.com>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=51, delay=96132,
delays=51599/44448/84/0.3, dsn=2.0.0, status=sent (250 ok 1262894579 qp
12158)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 6023552F52: removed
Jan 7 22:02:59 postfix postfix/smtp[27134]: connect to
a132.localpc2105.com[10.0.0.132]:25: Connection timed out
Jan 7 22:02:59 postfix postfix/smtp[26717]: 96A447C426:
to=<alain.perignon.aulnaysousb...@reseau.renault.fr>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=63, delay=103800,
delays=59267/44433/99/0.27, dsn=2.0.0, status=sent (250 ok 1262894579 qp
12166)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 96A447C426: removed
Jan 7 22:02:59 postfix postfix/smtp[26727]: connect to
a133.localpc2105.com[10.0.0.133]:25: Connection timed out
Jan 7 22:02:59 postfix postfix/smtp[27204]: 485A39C9E8:
to=<lycoudis.archite...@wanadoo.fr>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=52, delay=69946,
delays=25414/44492/40/0.29, dsn=2.0.0, status=sent (250 ok 1262894579 qp
12172)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 485A39C9E8: removed
Jan 7 22:02:59 postfix postfix/smtp[26727]: E86E9D9F79:
to=<propa...@jdpsquash.com>, relay=a67.localpc2105.com[10.0.0.67]:25,
delay=59696, delays=15163/44433/100/0.17, dsn=2.0.0, status=sent (250 ok
1262894579 qp 3991)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: E86E9D9F79: removed
Jan 7 22:02:59 postfix postfix/smtp[26924]: C6905ACBA3:
to=<linsolitec...@hotmail.fr>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=64, delay=96901,
delays=52368/44474/58/0.24, dsn=2.0.0, status=sent (250 ok 1262894579 qp
12179)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: C6905ACBA3: removed
Everything seems to be OK, emails are relayed to my qmails servers.
But if you have a look on these logs, related to 2 messages, you will
see that messages where posted on the postix a 2:37AM and 9:09 AM and
delivered at 22:03 !!!! 20 hours in the queue, with no errors, no
warnings....
Jan 7 02:37:13 postfix postfix/smtpd[20640]: 485A39C9E8:
client=unknown[10.0.0.241]
Jan 7 02:37:13 postfix postfix/cleanup[20642]: 485A39C9E8:
message-id=<20100107003713.485a39c...@postfix.proacti5.net>
Jan 7 02:37:13 postfix postfix/qmgr[31260]: 485A39C9E8:
from=<brammobilierattala...@emprom7.com>, size=6136, nrcpt=1 (queue active)
Jan 7 05:28:03 postfix postfix/smtpd[3663]: E86E9D9F79:
client=unknown[10.0.0.241]
Jan 7 05:28:03 postfix postfix/cleanup[3955]: E86E9D9F79:
message-id=<20100107032803.e86e9d9...@postfix.proacti5.net>
Jan 7 05:28:04 postfix postfix/qmgr[31260]: E86E9D9F79:
from=<fjb.campai...@emprom9.com>, size=11140, nrcpt=1 (queue active)
Jan 7 08:56:31 postfix postfix/qmgr[21787]: E86E9D9F79:
from=<fjb.campai...@emprom9.com>, size=11140, nrcpt=1 (queue active)
Jan 7 08:56:31 postfix postfix/qmgr[21787]: 485A39C9E8:
from=<brammobilierattala...@emprom7.com>, size=6136, nrcpt=1 (queue active)
Jan 7 09:09:56 postfix postfix/qmgr[23046]: E86E9D9F79:
from=<fjb.campai...@emprom9.com>, size=11140, nrcpt=1 (queue active)
Jan 7 09:09:57 postfix postfix/qmgr[23046]: 485A39C9E8:
from=<brammobilierattala...@emprom7.com>, size=6136, nrcpt=1 (queue active)
Jan 7 09:40:46 postfix poJan 7 22:02:57 postfix postfix/qmgr[26441]:
5B91F873F6: removed
Jan 7 22:02:57 postfix postfix/smtp[27180]: 375DDD5923:
to=<lexoti...@gmail.com>, relay=a139.localpc2105.com[10.0.0.139]:25,
conn_use=59, delay=61550, delays=17019/44435/96/0.17, dsn=2.0.0,
status=sent (250 ok 1262894577 qp 12113)
Jan 7 22:02:57 postfix postfix/qmgr[26441]: 375DDD5923: removed
Jan 7 22:02:58 postfix postfix/smtp[27070]: 7F0F2943B3:
to=<gpo...@wanadoo.fr>, relay=a70.localpc2105.com[10.0.0.70]:25,
conn_use=10, delay=73795, delays=29264/44481/50/0.21, dsn=2.0.0,
status=sent (250 ok 1262894577 qp 23067)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 7F0F2943B3: removed
Jan 7 22:02:58 postfix postfix/smtp[27050]: 32BB182182:
to=<gmarin-jardins-lois...@wanadoo.fr>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=48, delay=73799,
delays=29268/44466/65/0.28, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12121)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 32BB182182: removed
Jan 7 22:02:58 postfix postfix/smtp[26758]: 577D6C7F7D:
to=<gerardtremb...@vinsdusiecle.com>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=60, delay=68451,
delays=23920/44481/50/0.29, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12122)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 577D6C7F7D: removed
Jan 7 22:02:58 postfix postfix/smtp[26935]: CDCE074F53:
to=<christian.lebe...@arcelor.com>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=49, delay=104597,
delays=60065/44421/110/0.3, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12135)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: CDCE074F53: removed
Jan 7 22:02:58 postfix postfix/smtp[26708]: 4B0B6E77FD:
to=<m...@metaproductique.com>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=61, delay=46137,
delays=1606/44461/70/0.31, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12136)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 4B0B6E77FD: removed
Jan 7 22:02:58 postfix postfix/smtp[26794]: D2CB5DC84C:
to=<secretar...@mairie-charly.fr>,
relay=a70.localpc2105.com[10.0.0.70]:25, conn_use=11, delay=58160,
delays=13628/44481/50/0.23, dsn=2.0.0, status=sent (250 ok 1262894578 qp
23076)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: D2CB5DC84C: removed
Jan 7 22:02:58 postfix postfix/smtp[26968]: 1A651E17E0:
to=<davau.br...@orange.fr>, relay=a74.localpc2105.com[10.0.0.74]:25,
conn_use=2, delay=54426, delays=9894/44462/69/0.27, dsn=2.0.0,
status=sent (250 ok 1262894578 qp 7411)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 1A651E17E0: removed
Jan 7 22:02:58 postfix postfix/smtp[27037]: 4CCC486B55:
to=<lenaerts.natuurst...@pandora.be>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=50, delay=45538,
delays=1005/44407/125/0.17, dsn=2.0.0, status=sent (250 ok 1262894578 qp
12150)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: 4CCC486B55: removed
Jan 7 22:02:58 postfix postfix/smtp[27188]: D130997201:
to=<cont...@afcmecanum.com>, relay=a74.localpc2105.com[10.0.0.74]:25,
conn_use=2, delay=71536, delays=27004/44448/84/0.28, dsn=2.0.0,
status=sent (250 ok 1262894578 qp 7412)
Jan 7 22:02:58 postfix postfix/qmgr[26441]: D130997201: removed
Jan 7 22:02:59 postfix postfix/smtp[27033]: 6BD743906A:
to=<copyboli...@orange.fr>, relay=a139.localpc2105.com[10.0.0.139]:25,
conn_use=62, delay=81473, delays=36941/44467/65/0.24, dsn=2.0.0,
status=sent (250 ok 1262894579 qp 12157)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 6BD743906A: removed
Jan 7 22:02:59 postfix postfix/smtp[26793]: 84947C14B2:
to=<wgall...@saemshema.com>, relay=a70.localpc2105.com[10.0.0.70]:25,
conn_use=12, delay=69401, delays=24868/44469/63/0.2, dsn=2.0.0,
status=sent (250 ok 1262894578 qp 23084)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 84947C14B2: removed
Jan 7 22:02:59 postfix postfix/smtp[26737]: 6023552F52:
to=<cont...@installation-spa-gard.com>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=51, delay=96132,
delays=51599/44448/84/0.3, dsn=2.0.0, status=sent (250 ok 1262894579 qp
12158)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 6023552F52: removed
Jan 7 22:02:59 postfix postfix/smtp[27134]: connect to
a132.localpc2105.com[10.0.0.132]:25: Connection timed out
Jan 7 22:02:59 postfix postfix/smtp[26717]: 96A447C426:
to=<alain.perignon.aulnaysousb...@reseau.renault.fr>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=63, delay=103800,
delays=59267/44433/99/0.27, dsn=2.0.0, status=sent (250 ok 1262894579 qp
12166)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 96A447C426: removed
Jan 7 22:02:59 postfix postfix/smtp[26727]: connect to
a133.localpc2105.com[10.0.0.133]:25: Connection timed out
Jan 7 22:02:59 postfix postfix/smtp[27204]: 485A39C9E8:
to=<lycoudis.archite...@wanadoo.fr>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=52, delay=69946,
delays=25414/44492/40/0.29, dsn=2.0.0, status=sent (250 ok 1262894579 qp
12172)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 485A39C9E8: removed
Jan 7 22:02:59 postfix postfix/smtp[26727]: E86E9D9F79:
to=<propa...@jdpsquash.com>, relay=a67.localpc2105.com[10.0.0.67]:25,
delay=59696, delays=15163/44433/100/0.17, dsn=2.0.0, status=sent (250 ok
1262894579 qp 3991)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: E86E9D9F79: removed
Jan 7 22:02:59 postfix postfix/smtp[26924]: C6905ACBA3:
to=<linsolitec...@hotmail.fr>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=64, delay=96901,
delays=52368/44474/58/0.24, dsn=2.0.0, status=sent (250 ok 1262894579 qp
12179)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: C6905ACBA3: removed
stfix/qmgr[26441]: E86E9D9F79: from=<fjb.campai...@emprom9.com>,
size=11140, nrcpt=1 (queue active)
Jan 7 09:40:47 postfix postfix/qmgr[26441]: 485A39C9E8:
from=<brammobilierattala...@emprom7.com>, size=6136, nrcpt=1 (queue active)
Jan 7 22:02:59 postfix postfix/smtp[27204]: 485A39C9E8:
to=<lycoudis.archite...@wanadoo.fr>,
relay=a139.localpc2105.com[10.0.0.139]:25, conn_use=52, delay=69946,
delays=25414/44492/40/0.29, dsn=2.0.0, status=sent (250 ok 1262894579 qp
12172)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: 485A39C9E8: removed
Jan 7 22:02:59 postfix postfix/smtp[26727]: E86E9D9F79:
to=<propa...@jdpsquash.com>, relay=a67.localpc2105.com[10.0.0.67]:25,
delay=59696, delays=15163/44433/100/0.17, dsn=2.0.0, status=sent (250 ok
1262894579 qp 3991)
Jan 7 22:02:59 postfix postfix/qmgr[26441]: E86E9D9F79: removed
It is very strange.
Patrick
