dovecot - Jul 2014 - 2.2.13 + hg: Panic: file ioloop.c: line 39 (io_add_file): assertion failed: (fd >= 0)

Hi,

Found this in logfiles:
Jul 25 14:12:38 dovecot: pop3(cen at so.red): Error: UIDL: File name lookup 
failed: Message was expunged
Jul 25 14:12:38 dovecot: pop3(cen at so.red): Disconnected: POP3 UIDLs 
couldn't be listed top=187/356348, retr=0/0, del=0/1207, size=789346199
Jul 25 14:12:38 dovecot: pop3(cen at so.red): Panic: file ioloop.c: line 39 
(io_add_file): assertion failed: (fd >= 0)
Jul 25 14:12:38 dovecot: pop3(cen at so.red): Error: Raw backtrace: 
/usr/lib/dovecot/libdovecot.so.0 [0xbdfc1f] -> 
/usr/lib/dovecot/libdovecot.so.0 [0xbdfc9d] -> 
/usr/lib/dovecot/libdovecot.so.0 [0xbdf514] -> 
/usr/lib/dovecot/libdovecot.so.0 [0xbf162d] -> 
/usr/lib/dovecot/libdovecot.so.0(io_add_istream+0x3f) [0xbf272f] -> 
dovecot/pop3 [0x804d149] -> /usr/lib/dovecot/libdovecot.so.0 [0xbff17a] 
-> /usr/lib/dovecot/libdovecot.so.0(io_loop_call_io+0x48) [0xbf1d88] -> 
/usr/lib/dovecot/libdovecot.so.0(io_loop_handler_run_internal+0xff) 
[0xbf375f] -> /usr/lib/dovecot/libdovecot.so.0(io_loop_handler_run+0x1e) 
[0xbf1e2e] -> /usr/lib/dovecot/libdovecot.so.0(io_loop_run+0x48) 
[0xbf1eb8] -> /usr/lib/dovecot/libdovecot.so.0(master_service_run+0x2d) 
[0xb9842d] -> dovecot/pop3(main+0x2a9) [0x804b3b9] -> 
/lib/i686/nosegneg/libc.so.6(__libc_start_main+0xdc) [0x6f7dec] -> 
dovecot/pop3 [0x804aeb1]
Jul 25 14:12:38 dovecot: pop3(cen at so.red): Fatal: master: service(pop3): 
child 27510 killed with signal 6 (core dumped)

(gdb) bt
#0  0x00b1a402 in __kernel_vsyscall ()
#1  0x0070af30 in raise () from /lib/i686/nosegneg/libc.so.6
#2  0x0070c911 in abort () from /lib/i686/nosegneg/libc.so.6
#3  0x00bdfc14 in default_fatal_finish (type=<value optimized out>, 
status=0) at failures.c:193
#4  0x00bdfc9d in i_internal_fatal_handler (ctx=0xbf82cd34, 
format=0xc0c784 "file %s: line %d (%s): assertion failed: (%s)", 
args=0xbf82cd54 "\202\232?") at failures.c:657
#5  0x00bdf514 in i_panic (format=0xc0c784 "file %s: line %d (%s): 
assertion failed: (%s)") at failures.c:267
#6  0x00bf162d in io_add_file (fd=-1, condition=IO_READ, 
source_linenum=816, callback=0x804d150 <client_input>, 
context=0x83ba628) at ioloop.c:40
#7  0x00bf272f in io_add_istream (input=0x83ba960, source_linenum=816, 
callback=0x804d150 <client_input>, context=0x83ba628) at ioloop.c:86
#8  0x0804d149 in client_output (client=0x83ba628) at pop3-client.c:815
#9  0x00bff17a in stream_send_io (fstream=0x83baa48) at ostream-file.c:468
#10 0x00bf1d88 in io_loop_call_io (io=0x83baaf8) at ioloop.c:441
#11 0x00bf375f in io_loop_handler_run_internal (ioloop=0x83a5498) at 
ioloop-epoll.c:220
#12 0x00bf1e2e in io_loop_handler_run (ioloop=0x83a5498) at ioloop.c:488
#13 0x00bf1eb8 in io_loop_run (ioloop=0x83a5498) at ioloop.c:465
#14 0x00b9842d in master_service_run (service=0x83a53c0, 
callback=0x804b4e0 <client_connected>) at master-service.c:566
#15 0x0804b3b9 in main (argc=Cannot access memory at address 0x0
) at main.c:277
(gdb)

Thanks,
Toni

On 25 Jul 2014, at 14:12, Toni Mattila <toni at solu.fi> wrote:
> Jul 25 14:12:38 dovecot: pop3(cen at so.red): Error: UIDL: File name lookup
failed: Message was expunged
> Jul 25 14:12:38 dovecot: pop3(cen at so.red): Disconnected: POP3 UIDLs
couldn't be listed top=187/356348, retr=0/0, del=0/1207, size=789346199
> Jul 25 14:12:38 dovecot: pop3(cen at so.red): Panic: file ioloop.c: line 39
(io_add_file): assertion failed: (fd >= 0)
This should fix it: http://hg.dovecot.org/dovecot-2.2/rev/d14f30ccd118