Ralf!! Exactally!!!
The major delay is at (c=connection setup time including DNS, HELO and TLS). Thats what is taking too long, but ONLY when I use sender ZOOM4U.COM.BR as the domain name. Any idea?? Thanks a lot! On Tue, Mar 15, 2011 at 1:30 PM, Ralf Hildebrandt <ralf.hildebra...@charite.de> wrote: > * Rafael Azevedo <raf...@gmail.com>: >> Sorry! I forgot the log files.. >> >> In order to "reduce" the logs I've made a test with 2 destinations per >> domain sender, as follows: >> >> >> # TEST 1: >> 13:15:14 - Sending email #1...OK >> 13:15:15 - Sending email #2...OK >> >> # TEST 2 >> 13:15:15 - Sending email #1...OK >> 13:15:15 - Sending email #2...OK >> >> POSTFIX LOGS: >> >> Mar 15 13:16:23 mxcluster postfix/smtpd[31423]: connect from >> srv01.iagentemail.com.br[189.38.86.124] >> Mar 15 13:16:23 mxcluster postfix/smtpd[31423]: D40E120EAA8: >> client=srv01.iagentemail.com.br[189.38.86.124] >> Mar 15 13:16:23 mxcluster postfix/cleanup[31427]: D40E120EAA8: >> message-id=<da148727b8e4e2c708f2247e952e3...@iagentemail.com.br> >> Mar 15 13:16:24 mxcluster dkim-filter[4513]: D40E120EAA8 "DKIM-Signature" >> header added >> Mar 15 13:16:24 mxcluster postfix/qmgr[6659]: D40E120EAA8: >> from=<reto...@iagentemail.com.br>, size=631, nrcpt=2 (queue active) >> Mar 15 13:16:24 mxcluster postfix/smtp[31429]: D40E120EAA8: >> to=<di...@iagente.com.br>, relay=mx2.iagente.com.br[189.38.95.92]:25, >> delay=0.67, delays=0.52/0.01/0.02/0.12, dsn=2.0.0, status=sent (250 2.0.0 >> Ok: queued as F1EAF6DFA4E64) >> Mar 15 13:16:27 mxcluster postfix/smtp[29978]: D40E120EAA8: >> to=<raf...@gmail.com>, relay=gmail-smtp-in.l.google.com[74.125.67.27]:25, >> delay=3.1, delays=0.52/0/0.45/2.2, dsn=2.0.0, status=sent (250 2.0.0 OK >> 1300205714 x34si22095693anx.127) >> Mar 15 13:16:27 mxcluster postfix/qmgr[6659]: D40E120EAA8: removed > >> Mar 15 13:16:24 mxcluster postfix/smtpd[31423]: 5E9C320EAC6: >> client=srv01.iagentemail.com.br[189.38.86.124] >> Mar 15 13:16:24 mxcluster postfix/cleanup[31427]: 5E9C320EAC6: >> message-id=<bbf2745b30c38b261c50af0e222b7...@iagentemail.com.br> >> Mar 15 13:16:24 mxcluster dkim-filter[4513]: 5E9C320EAC6 "DKIM-Signature" >> header added >> Mar 15 13:16:24 mxcluster postfix/qmgr[6659]: 5E9C320EAC6: >> from=<reto...@iagentemail.com.br>, size=631, nrcpt=2 (queue active) >> Mar 15 13:16:27 mxcluster postfix/smtp[31429]: 5E9C320EAC6: >> to=<raf...@gmail.com>, relay=gmail-smtp-in.l.google.com[74.125.67.27]:25, >> delay=3.1, delays=0.58/0/0.45/2.1, dsn=2.0.0, status=sent (250 2.0.0 OK >> 1300205714 p50si22191243yhi.8) >> Mar 15 13:16:35 mxcluster postfix/smtp[31431]: 5E9C320EAC6: >> to=<di...@iagente.com.br>, relay=mx1.iagente.com.br[189.38.95.91]:25, >> delay=11, delays=0.58/0.01/5.2/5.2, dsn=2.0.0, status=sent (250 2.0.0 Ok: >> queued as CFB4A6DB6AC99) >> Mar 15 13:16:24 mxcluster postfix/smtpd[31423]: lost connection after RSET >> from srv01.iagentemail.com.br[189.38.86.124] >> Mar 15 13:16:24 mxcluster postfix/smtpd[31423]: disconnect from >> srv01.iagentemail.com.br[189.38.86.124] > >> Mar 15 13:16:24 mxcluster postfix/smtpd[31423]: connect from >> srv01.iagentemail.com.br[189.38.86.124] >> Mar 15 13:16:24 mxcluster postfix/smtpd[31423]: EE82220EB26: >> client=srv01.iagentemail.com.br[189.38.86.124] >> Mar 15 13:16:25 mxcluster postfix/cleanup[31427]: EE82220EB26: >> message-id=<49aacc28e1c170356dc8fb54834a8...@iagentemail.com.br> >> Mar 15 13:16:25 mxcluster dkim-filter[4513]: EE82220EB26 "DKIM-Signature" >> header added >> Mar 15 13:16:25 mxcluster postfix/qmgr[6659]: EE82220EB26: >> from=<reto...@iagentemail.com.br>, size=632, nrcpt=2 (queue active) >> Mar 15 13:16:25 mxcluster postfix/smtp[31438]: EE82220EB26: >> to=<di...@iagente.com.br>, relay=mx3.iagente.com.br[189.38.95.5]:25, >> delay=0.47, delays=0.1/0.02/0.15/0.21, dsn=2.0.0, status=sent (250 2.0.0 Ok: >> queued as DB5861FDE7702) >> Mar 15 13:16:27 mxcluster postfix/smtp[31437]: EE82220EB26: >> to=<raf...@gmail.com>, relay=gmail-smtp-in.l.google.com[74.125.67.27]:25, >> delay=2.7, delays=0.1/0.01/0.45/2.1, dsn=2.0.0, status=sent (250 2.0.0 OK >> 1300205715 m1si10205166ybn.28) >> Mar 15 13:16:27 mxcluster postfix/qmgr[6659]: EE82220EB26: removed > >> Mar 15 13:16:25 mxcluster postfix/smtpd[31423]: 133F620EB53: >> client=srv01.iagentemail.com.br[189.38.86.124] >> Mar 15 13:16:25 mxcluster postfix/cleanup[31427]: 133F620EB53: >> message-id=<dfcd063ee7c7c3843829ad4c45969...@iagentemail.com.br> >> Mar 15 13:16:25 mxcluster dkim-filter[4513]: 133F620EB53 "DKIM-Signature" >> header added >> Mar 15 13:16:25 mxcluster postfix/qmgr[6659]: 133F620EB53: >> from=<reto...@iagentemail.com.br>, size=632, nrcpt=2 (queue active) >> Mar 15 13:16:25 mxcluster postfix/smtpd[31423]: lost connection after RSET >> from srv01.iagentemail.com.br[189.38.86.124] >> Mar 15 13:16:25 mxcluster postfix/smtpd[31423]: disconnect from >> srv01.iagentemail.com.br[189.38.86.124] >> Mar 15 13:16:25 mxcluster postfix/smtp[31440]: 133F620EB53: >> to=<di...@iagente.com.br>, relay=mx2.iagente.com.br[189.38.95.92]:25, >> delay=0.43, delays=0.11/0.01/0.13/0.17, dsn=2.0.0, status=sent (250 2.0.0 >> Ok: queued as EA8BA6DFA521F) >> Mar 15 13:16:27 mxcluster postfix/smtp[31439]: 133F620EB53: >> to=<raf...@gmail.com>, relay=gmail-smtp-in.l.google.com[74.125.67.27]:25, >> delay=2.6, delays=0.11/0.01/0.45/2, dsn=2.0.0, status=sent (250 2.0.0 OK >> 1300205715 o2si378647ybn.42) >> Mar 15 13:16:27 mxcluster postfix/qmgr[6659]: 133F620EB53: removed > > You're sending 4 Emails to two recipients each. Sending to > iagente.com.br is often faster than sending to gmail.com. Such things > happen. gmail may not be "very close" in terms of network distance. If > you look at the delays= values you'll notice identical timings except > for the 3rd and 4th value (c and d), meaning: > > a=time before queue manager, including message transmission; > b=time in queue manager; > c=connection setup time including DNS, HELO and TLS; > d=message transmission time. > > So, transmitting an email to a gmail server takes much longer. > > -- > Ralf Hildebrandt > Geschäftsbereich IT | Abteilung Netzwerk > Charité - Universitätsmedizin Berlin > Campus Benjamin Franklin > Hindenburgdamm 30 | D-12203 Berlin > Tel. +49 30 450 570 155 | Fax: +49 30 450 570 962 > ralf.hildebra...@charite.de | http://www.charite.de > >
