2 Replies Latest reply on Jul 19, 2010 10:32 AM by DBO

    No DSN with drop message

    DBO

      One person sent 3 days ago an invitation to 6 groups outside of the company.  Ironmail generated 2 e-mail from one of those, one for  the recipient in the @dir.xxxxxxxxxx.ca domain and the second for the member of the @xxxxxxxxxx.ca domain (same primary domain).  It look like nearly or all members of the second e-mail didn't received the invitation and it has created problem.

       

      A search in the log show that effectively, the first message is mark delivered and the second got status: Dropped.  A search of the log confirmed that the sender never received an DSN.  How is it possible?  The only clues I have found are:

      • This is IM 6.7.1 HF7
      • There were some wrong addresses in the 30 destination address of the second message
      • BATV was active
      • There were 4 retries to send the message

       

      BATV seem to interfere with the internal DSN return address. With BATV activated, a message sent to a non-existant domain generate a DSN.  A message sent to a non-existant user but in a valid domain generate no DSN.  If I deactivate BATV, I start to receive DSN error message

       

      Any idea?

       

       

      20100713:14:52:15|6771782|9475|Max retry attempts -|4|
      20100713:14:52:15|6771782|9476|Starting to process msgid -|6771782|
      20100713:14:52:15|6771782|9481|Processing Domain -|xxxxxxxx.ca|
      20100713:14:52:15|6771782|9515|DNS Lookup Returned -|[(10, 'mail.xxxxxxxx.ca', ('206.162.178.252',))] fromCache=False|
      20100713:14:52:15|6771782|9516|Connecting to Domain -|xxxxxxxx.ca|
      20100713:14:52:15|6771782|9487|Block timeout in seconds -|300|
      20100713:14:52:15|6771782|9488|Connecting to MX -|mail.xxxxxxxx.ca|
      20100713:14:52:15|6771782|9489|Connecting to A -|206.162.178.252|
      20100713:14:52:15|6771782|9491|Channels Vip vipid:bindhost -|0:192.197.135.59|
      20100713:14:52:15|6771782|4099|Connecting to <BindHost:ConnectHost:ConnectPort> -|<192.197.135.59:206.162.178.252:25>|
      20100713:14:52:16|6771782|9492|Connection Status <status> -|1|
      20100713:14:52:16|6771782|9523|Starting SendSmtpMsg in domain -|xxxxxxxx.ca|
      20100713:14:52:16|6771782|9570|BATV values are DSN_BVP_enable: <IsEnabled> mail_from: <Mail From> mdoutbound <IsOutbound> selfdeliveryMode <Delivery Mode> -|1:claudette.leclerc@loto-quebec.com:1:0|
      20100713:14:52:16|6771782|9571|After calling do BATV on outbound Signed Mail From is -|prvs=1803030330=claudette.leclerc@loto-quebec.com|
      20100713:14:52:27|6771782|4097|-|('EXCEPTION', ('/build/ct/common/src/pythonframework/ctsocket.py', '_mangle_exceptions', '91'), 'CTSocketReadError', (error(54, 'Connection reset by peer'),), '[smtpo_server.py|deliverDomain|971] [smtpo_server.py|sendSmtpMsg|1318] [/build/ct/common/src/pythonframework/smtplib.py|sendmail|276] [/build/ct/common/src/pythonframework/smtplib.py|rcpt|772] [/build/ct/common/src/pythonframework/smtplib.py|docmd|628] [/build/ct/common/src/pythonframework/smtplib.py|getreply|586] [/build/ct/common/src/pythonframework/any_client.py|getreply|70] [/build/ct/common/src/pythonframework/any_channel.py|reply_terminator|504] [/build/ct/common/src/pythonframework/any_channel.py|rhandle_read|474] [/build/ct/common/src/pythonframework/ctsocket.py|<lambda>|315] [/build/ct/common/src/pythonframework/ctsocket.py|_mangle_exceptions|91]')|
      20100713:14:52:27|6771782|9506|Closing SMTP Connection||
      20100713:14:52:27|6771782|9522|Domain address Invalid. Attempting to generate DSN -|xxxxxxxx.ca|
      20100713:14:52:27|6771782|9525|Generating DSN||
      20100713:14:52:27|6771782|9526|No DSN to be generated for this message.||
      20100713:14:52:27|6771782|9521|Retry will be attempted for the Message. <Retry Count> -|4|
      20100713:14:52:27|6771782|9480|Finished processing msgid -|6771782|
      20100713:17:52:31|6771782|9474|Channel outbound flag -|1|
      20100713:17:52:31|6771782|9475|Max retry attempts -|4|
      20100713:17:52:31|6771782|9476|Starting to process msgid -|6771782|
      20100713:17:52:31|6771782|9481|Processing Domain -|xxxxxxxx.ca|
      20100713:17:52:31|6771782|9515|DNS Lookup Returned -|[(10, 'mail.xxxxxxxx.ca', ('206.162.178.252',))] fromCache=False|
      20100713:17:52:31|6771782|9516|Connecting to Domain -|xxxxxxxx.ca|
      20100713:17:52:31|6771782|9487|Block timeout in seconds -|300|
      20100713:17:52:31|6771782|9488|Connecting to MX -|mail.xxxxxxxx.ca|
      20100713:17:52:31|6771782|9489|Connecting to A -|206.162.178.252|
      20100713:17:52:31|6771782|9491|Channels Vip vipid:bindhost -|0:192.197.135.59|
      20100713:17:52:31|6771782|4099|Connecting to <BindHost:ConnectHost:ConnectPort> -|<192.197.135.59:206.162.178.252:25>|
      20100713:17:52:31|6771782|9492|Connection Status <status> -|1|
      20100713:17:52:31|6771782|9523|Starting SendSmtpMsg in domain -|xxxxxxxx.ca|
      20100713:17:52:31|6771782|9570|BATV values are DSN_BVP_enable: <IsEnabled> mail_from: <Mail From> mdoutbound <IsOutbound> selfdeliveryMode <Delivery Mode> -|1:claudette.leclerc@loto-quebec.com:1:0|
      20100713:17:52:31|6771782|9571|After calling do BATV on outbound Signed Mail From is -|prvs=1803030330=claudette.leclerc@loto-quebec.com|
      20100713:17:52:42|6771782|4097|-|('EXCEPTION', ('/build/ct/common/src/pythonframework/ctsocket.py', '_mangle_exceptions', '91'), 'CTSocketReadError', (error(54, 'Connection reset by peer'),), '[smtpo_server.py|deliverDomain|971] [smtpo_server.py|sendSmtpMsg|1318] [/build/ct/common/src/pythonframework/smtplib.py|sendmail|276] [/build/ct/common/src/pythonframework/smtplib.py|rcpt|772] [/build/ct/common/src/pythonframework/smtplib.py|docmd|628] [/build/ct/common/src/pythonframework/smtplib.py|getreply|586] [/build/ct/common/src/pythonframework/any_client.py|getreply|70] [/build/ct/common/src/pythonframework/any_channel.py|reply_terminator|504] [/build/ct/common/src/pythonframework/any_channel.py|rhandle_read|474] [/build/ct/common/src/pythonframework/ctsocket.py|<lambda>|315] [/build/ct/common/src/pythonframework/ctsocket.py|_mangle_exceptions|91]')|
      20100713:17:52:42|6771782|9506|Closing SMTP Connection||
      20100713:17:52:42|6771782|9522|Domain address Invalid. Attempting to generate DSN -|xxxxxxxx.ca|
      20100713:17:52:42|6771782|9525|Generating DSN||
      20100713:17:52:42|6771782|9527|DSN to <addr> -|prvs=1803030330=claudette.leclerc@loto-quebec.com|
      20100713:17:52:42|6771782|9529|Args received in parsing email addr <args> -|prvs=1803030330=claudette.leclerc@loto-quebec.com|
      20100713:17:52:42|6771782|6658|QUEU COMMAND RECEIVED <mailfrom:frm_addr:rcptList:rcptLineList:ipaddress:msgtype:ehloDomain:notifysen der:forgedDomain> -|<<claudette.leclerc@loto-quebec.com>:{0: '', 1: '', 2: ''}:{(0, 0L): ['prvs=1803030330=claudette.leclerc@loto-quebec.com']}:{(0, 0L): ['<prvs=1803030330=claudette.leclerc@loto-quebec.com>']}:192.197.135.59:4:secv50006p.loto-quebec.com:1:False>|
      20100713:17:52:42|6771782|6664|Message Details ID||FILENAME||FROMADDR||TOADDR|VIPID <msgid:filename:fromaddr:toaddr:vip> -|<6785875:/ct/data/mss/00/00/67/85/875::['prvs=1803030330=claudette.leclerc@loto-quebec.com']:0>|
      20100713:17:52:42|6771782|6665|Created new Message ID and File <msgid:file> -|<6785875:/ct/data/mss/00/00/67/85/875>|
      20100713:17:52:42|6771782|9542|Failed to deliver, dropping message id -|6771782|
      20100713:17:52:42|6771782|9480|Finished processing msgid -|6771782|

        • 1. Re: No DSN with drop message

          Can we see the SMTPO log for message 6785875?  That is the ID of the DSN that was genreated.

          • 2. Re: No DSN with drop message
            DBO

            20100713:17:52:42|6771782|6664|Message Details ID||FILENAME||FROMADDR||TOADDR|VIPID <msgid:filename:fromaddr:toaddr:vip> -|<6785875:/ct/data/mss/00/00/67/85/875::['prvs=1803030330=claudette.leclerc@loto-quebec.com']:0>|
            20100713:17:52:42|6771782|6665|Created new Message ID and File <msgid:file> -|<6785875:/ct/data/mss/00/00/67/85/875>|
            20100713:17:52:43|6785875|9474|Channel outbound flag -|0|
            20100713:17:52:43|6785875|9475|Max retry attempts -|4|
            20100713:17:52:43|6785875|9476|Starting to process msgid -|6785875|
            20100713:17:52:43|6785875|9481|Processing Domain -|loto-quebec.com|
            20100713:17:52:43|6785875|9515|DNS Lookup Returned -|[(1, '192.197.135.126', ('192.197.135.126',)), (2, '192.197.135.127', ('192.197.135.127',))] fromCache=False|
            20100713:17:52:43|6785875|9516|Connecting to Domain -|loto-quebec.com|
            20100713:17:52:43|6785875|9487|Block timeout in seconds -|300|
            20100713:17:52:43|6785875|9488|Connecting to MX -|192.197.135.126|
            20100713:17:52:43|6785875|9489|Connecting to A -|192.197.135.126|
            20100713:17:52:43|6785875|9491|Channels Vip vipid:bindhost -|0:192.197.135.59|
            20100713:17:52:43|6785875|4099|Connecting to <BindHost:ConnectHost:ConnectPort> -|<192.197.135.59:192.197.135.126:25>|
            20100713:17:52:43|6785875|9492|Connection Status <status> -|1|
            20100713:17:52:43|6785875|9523|Starting SendSmtpMsg in domain -|loto-quebec.com|
            20100713:17:52:43|6785875|9570|BATV values are DSN_BVP_enable: <IsEnabled> mail_from: <Mail From> mdoutbound <IsOutbound> selfdeliveryMode <Delivery Mode> -|1::0:0|
            20100713:17:52:43|6785875|9506|Closing SMTP Connection||
            20100713:17:52:43|6785875|9480|Finished processing msgid -|6785875|