Bug#280647: [exim] Why did this message get frozen?
John Goerzen
John Goerzen <jgoerzen@complete.org>, 280647@bugs.debian.org
Thu, 11 Nov 2004 08:23:48 -0600
--UlVJffcvxoiEqYs2
Content-Type: text/plain; charset=us-ascii
Content-Disposition: inline
On Thu, Nov 11, 2004 at 10:09:21AM +0000, Philip Hazel wrote:
> On Wed, 10 Nov 2004, John Goerzen wrote:
>
> > Here is the note Exim sent me:
>
> Which release of Exim?
This is 4.34, which is unfortunately the latest version currently
available in Debian. I am CCing this message to the Debian maintainer
and a bug report I submitted there regarding the segfault.
I can also show you this, which may be of interest:
# host -t mx ihst.ru
ihst.ru MX 10 luna.ihst.ru
$ telnet luna.ihst.ru smtp
Trying 195.19.12.3...
Connected to luna.ihst.ru.
Escape character is '^]'.
220 Ihst.RU ESMTP CommuniGate Pro 4.1.8
EHLO glockenspiel.complete.org
250-Ihst.RU we trust you glockenspiel.complete.org
250-HELP
250-PIPELINING
250-ETRN
250-DSN
250-TURN
250-ATRN
250-SIZE 10485760
250-STARTTLS
250-AUTH=LOGIN
250-AUTH LOGIN PLAIN CRAM-MD5 DIGEST-MD5 MSN
250-8BITMIME
250 EHLO
MAIL FROM:<jgoerzen@complete.org>
250 jgoerzen@complete.org sender accepted
RCPT TO:<glad@ihst.ru>
550 glad@ihst.ru unknown user account
Connection closed by foreign host.
I've also attached the portion of the debug log relating to the segfault
on the delivery to this recipient.
> > Message 1CRm0w-0002fM-Dr has been frozen.
>
> The reason for freezing should be in the main Exim log and in the
> message's own message log.
All I see either place is "Frozen". I do see the sig11 logged. I
didn't know that would cause it to freeze. So that makes sense, I
suppose.
> might give some clue as to why the crash is happening. If you are not
> running the latest release, please upgrade to the latest release and try
> that.
Not the easiest thing on Debian since there isn't a 4.43 packaged, but
if the maintainer doesn't package it, I will try to do that myself.
Anyway, the debug log is attached.
-- John
--UlVJffcvxoiEqYs2
Content-Type: text/plain; charset=us-ascii
Content-Disposition: attachment; filename="debug.txt"
2686 Remote delivery process started
2686 changed uid/gid: remote delivery to glad@ihst.ru with transport=remote_smtp
2686 uid=107 gid=107 pid=2686
2686 auxiliary group list: <none>
2686 set_process_info: 2686 delivering 1CRm0w-0002fM-Dr using remote_smtp
2686 T: remote_smtp for glad@ihst.ru
2686 remote_smtp transport entered
2686 glad@ihst.ru
2686 checking status of luna.ihst.ru
2686 locking /var/spool/exim4/db/retry.lockfile
2686 locked /var/spool/exim4/db/retry.lockfile
2686 opened hints database /var/spool/exim4/db/retry: flags=0
2686 dbfn_read: key=T:luna.ihst.ru:195.19.12.3
2686 dbfn_read: key=T:luna.ihst.ru:195.19.12.3:1CRm0w-0002fM-Dr
2686 no message retry record
2686 luna.ihst.ru [195.19.12.3] status = usable
2686 195.19.12.3 in serialize_hosts? no (option unset)
2686 delivering 1CRm0w-0002fM-Dr to luna.ihst.ru [195.19.12.3] (glad@ihst.ru)
2686 set_process_info: 2686 delivering 1CRm0w-0002fM-Dr to luna.ihst.ru [195.19.12.3] (glad@ihst.ru)
2686 Connecting to luna.ihst.ru [195.19.12.3]:25 ... connected
2686 read response data: size=41
2686 SMTP<< 220 Ihst.RU ESMTP CommuniGate Pro 4.1.8
2686 195.19.12.3 in hosts_avoid_esmtp? no (option unset)
2686 SMTP>> EHLO glockenspiel.complete.org
2686 read response data: size=236
2686 SMTP<< 250-Ihst.RU we trust you glockenspiel.complete.org
2686 250-HELP
2686 250-PIPELINING
2686 250-ETRN
2686 250-DSN
2686 250-TURN
2686 250-ATRN
2686 250-SIZE 10485760
2686 250-STARTTLS
2686 250-AUTH=LOGIN
2686 250-AUTH LOGIN PLAIN CRAM-MD5 DIGEST-MD5 MSN
2686 250-8BITMIME
2686 250 EHLO
2686 195.19.12.3 in hosts_avoid_tls? no (option unset)
2686 SMTP>> STARTTLS
2686 read response data: size=35
2686 SMTP<< 220 please start a TLS connection
2686 initializing GnuTLS as a client
2686 read RSA and D-H parameters from file
2686 initialized RSA and D-H parameters
2686 certificate file = /etc/ssl/certs/glockenspiel.complete.org.key.pem
2686 key file = /etc/ssl/certs/glockenspiel.complete.org.key.pem
2686 initialized certificate stuff
2686 initialized GnuTLS session
2686 cipher: TLS-1.0:RSA_ARCFOUR_SHA:16
2686 SMTP>> EHLO glockenspiel.complete.org
2686 tls_do_write(bfffcc70, 32)
2686 gnutls_record_send(SSL, bfffcc70, 32)
2686 outbytes=32
2686 Calling gnutls_record_recv(813ce08, bfffd070, 4096)
2686 read response data: size=222
2686 SMTP<< 250-Ihst.RU we trust you glockenspiel.complete.org
2686 250-HELP
2686 250-PIPELINING
2686 250-ETRN
2686 250-DSN
2686 250-TURN
2686 250-ATRN
2686 250-SIZE 10485760
2686 250-AUTH=LOGIN
2686 250-AUTH LOGIN PLAIN CRAM-MD5 DIGEST-MD5 MSN
2686 250-8BITMIME
2686 250 EHLO
2686 using PIPELINING
2686 195.19.12.3 in hosts_require_auth? no (option unset)
2686 195.19.12.3 in hosts_try_auth? no (option unset)
2686 SMTP>> MAIL FROM:<[hidden for public display]> SIZE=3598
2686 SMTP>> RCPT TO:<glad@ihst.ru>
2686 SMTP>> DATA
2686 tls_do_write(bfffcc70, 84)
2686 gnutls_record_send(SSL, bfffcc70, 84)
2686 outbytes=84
2686 Calling gnutls_record_recv(813ce08, bfffd070, 4096)
2686 read response data: size=52
2686 SMTP<< 250 [hidden for public display] sender accepted
2686 Calling gnutls_record_recv(813ce08, bfffd070, 4096)
2686 read response data: size=39
2686 SMTP<< 550 glad@ihst.ru unknown user account
2686 Calling gnutls_record_recv(813ce08, bfffd070, 4096)
2686 Got TLS_EOF
2686 Remote host luna.ihst.ru [195.19.12.3] closed connection in response to pipelined DATA
2686 error for DATA ignored: pipelining is in use and there were no good recipients
2686 ok=1 send_quit=1 send_rset=1 continue_more=0 yield=0 first_address=0
2686 195.19.12.3 in hosts_nopass_tls? no (option unset)
2686 transport_check_waiting entered
2686 sequence=1 local_max=500 global_max=-1
2686 locking /var/spool/exim4/db/wait-remote_smtp.lockfile
2686 locked /var/spool/exim4/db/wait-remote_smtp.lockfile
2686 opened hints database /var/spool/exim4/db/wait-remote_smtp: flags=2
2686 dbfn_read: key=luna.ihst.ru
2686 dbfn_write: key=luna.ihst.ru
2686 SMTP>> RSET
2686 tls_do_write(bfffcc70, 6)
2686 gnutls_record_send(SSL, bfffcc70, 6)
2686 outbytes=6
2686 Calling gnutls_record_recv(813ce08, bfffd070, 4096)
reading pipe for subprocess 2686 (not ended)
read() yielded 0
remote delivery process 2686 ended: status=000b
set_process_info: 2593 delivering 1CRm0w-0002fM-Dr
post-process glad@ihst.ru (1)
LOG: MAIN
== glad@ihst.ru R=dnslookup T=remote_smtp defer (-1): smtp transport process returned non-zero status 0x000b: terminated by signal 11
set_process_info: 2593 delivering 1CRm0w-0002fM-Dr: waiting for a remote delivery subprocess to finish
selecting on subprocess pipes
selecting on subprocess pipes
selecting on subprocess pipes
--UlVJffcvxoiEqYs2--