[Dovecot] [dovecot] dovecot freezes when trying to get mail from maildir with mail

postmaster postmaster at mathiesen.info
Tue Feb 21 11:58:27 EET 2012 

[ I'm sorry I can't reply in thread, but at present I'm reading email as 
plain text files directly off the file system - which is a PITA ;-) ]

Bjarne D Mathiesen
København N ; Danmark ; Europa
++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
denne besked er skrevet i et totalt M$-frit miljø
MacOS X 10.7.3 Lion ; 2.8GHz Intel Core i7 ; 16GB 1067MHz DDR3

On a note regarding my hardware :
the computer has three ethernet-interfaces:
but that doesn't really seem to be an issue as telnet from localhost 
also hangs indefinetely
I'm seeing the issue no matter which interface I connect to, whether the 
two external WAN or the internal LAN IP-number .

root# system_profiler SPEthernetDataType
2012-01-22 01:34:36.524 system_profiler[47377:903] Found bsdName
(0x2603) for AppleUSBEthernet
2012-01-22 01:34:36.626 system_profiler[47377:903] Found bsdName
(0x2c03) for AppleUSBEthernet
Ethernet Cards:

     Apple USB Ethernet Adaptor:

       Type: USB
       BSD name: en4
       Kext name: AppleUSBEthernet.kext
       Location:
/System/Library/Extensions/IONetworkingFamily.kext/Contents/PlugIns/AppleUSBEthernet.kext
       Version: 2.1.39
       MAC Address: 00:1f:f3:8a:f3:5a
       Product ID: 5122
       Vendor ID: 1452

     Apple USB Ethernet Adaptor:

       Type: USB
       BSD name: en3
       Kext name: AppleUSBEthernet.kext
       Location:
/System/Library/Extensions/IONetworkingFamily.kext/Contents/PlugIns/AppleUSBEthernet.kext
       Version: 2.1.39
       MAC Address: 00:1f:f3:8b:26:c1
       Product ID: 5122
       Vendor ID: 1452

     Marvell Yukon Gigabit Adapter 88E8053 Singleport Copper SA:

       Name: ethernet
       Type: Ethernet Controller
       Bus: PCI
       Vendor ID: 0x11ab
       Device ID: 0x4362
       Subsystem Vendor ID: 0x11ab
       Subsystem ID: 0x5321
       Revision ID: 0x0022
       Link Width: x1
       BSD name: en0
       Kext name: AppleYukon2.kext
       Location:
/System/Library/Extensions/IONetworkingFamily.kext/Contents/PlugIns/AppleYukon2.kext
       Version: 3.2.1b1

     ethernet:

       Type: Ethernet Controller
       Bus: PCI
       Slot: AirPort
       Vendor ID: 0x168c
       Device ID: 0x001c
       Subsystem Vendor ID: 0x106b
       Subsystem ID: 0x0086
       Revision ID: 0x0001
       Link Width: x1
       BSD name: en1
       Kext name: AirPortAtheros21.kext
       Location:
/System/Library/Extensions/IO80211Family.kext/Contents/PlugIns/AirPortAtheros21.kext
       Version: 425.14.7

root# ifconfig
lo0: flags=8049<UP,LOOPBACK,RUNNING,MULTICAST> mtu 16384
	inet6 ::1 prefixlen 128
	inet6 fe80::1%lo0 prefixlen 64 scopeid 0x1
	inet 127.0.0.1 netmask 0xff000000
gif0: flags=8010<POINTOPOINT,MULTICAST> mtu 1280
stf0: flags=0<> mtu 1280
en0: flags=8863<UP,BROADCAST,SMART,RUNNING,SIMPLEX,MULTICAST> mtu 1500
	ether 00:16:cb:a8:7d:01
	inet6 fe80::216:cbff:fea8:7d01%en0 prefixlen 64 scopeid 0x4
	inet 192.168.1.37 netmask 0xffffff00 broadcast 192.168.1.255
	media: autoselect (1000baseT <full-duplex,flow-control>)
	status: active
en4: flags=8863<UP,BROADCAST,SMART,RUNNING,SIMPLEX,MULTICAST> mtu 1500
	ether 00:1f:f3:8a:f3:5a
	inet6 fe80::21f:f3ff:fe8a:f35a%en4 prefixlen 64 scopeid 0x5
	inet 90.184.13.xxx netmask 0xfffffe00 broadcast 90.184.13.zzz
	media: autoselect (100baseTX <full-duplex,flow-control>)
	status: active
en3: flags=8863<UP,BROADCAST,SMART,RUNNING,SIMPLEX,MULTICAST> mtu 1500
	ether 00:1f:f3:8b:26:c1
	inet6 fe80::21f:f3ff:fe8b:26c1%en3 prefixlen 64 scopeid 0x6
	inet 90.184.12.yyy netmask 0xfffffe00 broadcast 90.184.13.zzz
	media: autoselect (100baseTX <full-duplex,flow-control>)
	status: active
fw0: flags=8863<UP,BROADCAST,SMART,RUNNING,SIMPLEX,MULTICAST> mtu 2030
	lladdr 00:17:f2:ff:fe:8e:e6:d2
	media: autoselect <full-duplex>
	status: inactive
en1: flags=8863<UP,BROADCAST,SMART,RUNNING,SIMPLEX,MULTICAST> mtu 1500
	ether 00:17:f2:52:62:9e
	media: autoselect (<unknown type>)
	status: inactive

root# system_profiler SPHardwareDataType
Hardware:

     Hardware Overview:

       Model Name: Mac mini
       Model Identifier: Macmini1,1
       Processor Name: Intel Core Duo
       Processor Speed: 1,83 GHz
       Number Of Processors: 1
       Total Number Of Cores: 2
       L2 Cache: 2 MB
       Memory: 2 GB
       Bus Speed: 667 MHz
       Boot ROM Version: MM11.0055.B08
       SMC Version (system): 1.3f4

root# system_profiler SPSoftwareDataType
Software:

     System Software Overview:

       System Version: Mac OS X 10.6.8 (10K549)
       Kernel Version: Darwin 10.8.0
       Boot Volume: X
       Boot Mode: Normal
       Computer Name: MiniWeb
       User Name: System Administrator (root)
       Secure Virtual Memory: Enabled
       64-bit Kernel and Extensions: No
       Time since boot: 5 days 1:31



 >On 19.2.2012, at 14.53, postmaster wrote:
 >
 >> Feb 19 11:52:20 4604ds1-ynoe dovecot[443]: auth-worker: Debug:
 >sql(abuse at mathiesen.info,127.0.0.1): SELECT  5000 AS uid , 5000 AS gid ,
 >concat ( '/Volumes/BrugerData/PostFix/mail/' , maildir ) AS home ,
 >concat ( '/Volumes/BrugerData/PostFix/mail/' , maildir ) AS mail FROM
 >mailbox WHERE username =3D 'abuse at mathiesen.info' AND domain =3D
 >'mathiesen.info' AND active =3D 1
 >
 >Probably won't help with your problem, but it's better if you don't
 >fetch "mail" field. Just fetch the home and set:
 >
 >mail_location = maildir:~/
 >
 >This avoids maildir autodetection.

That seemed to fix the autodetection :-)

 >
 >> # OS: Darwin 10.8.0 i386  hfs
 >
 >With HFS+ it's a good idea to set maildir_copy_with_hardlinks = no

OK - set to no as advised

 >
 >> a list "" *
 >> * LIST (\HasNoChildren) "." "INBOX"
 >> a OK List completed.
 >> a select inbox
 >> Connection closed by foreign host.
 >> 4604ds1-ynoe:~ root#
 >
 >You mean the session hangs here until it's killed?

Yes ... It does some of what it's supposed to do :
the dovecot-uidlist.lock is set
email is copied from new to cur, but then nothing more seems to happen :-(

4604ds1-ynoe:mail root# ls -l mathiesen.info/macintosh\@mathiesen.info/
total 40
drwx------  2 5000  5000  4352 Feb 21 09:58 cur
-rw-------  1 5000  5000  8119 Feb 21 10:28 dovecot-uidlist
-rw-------  1 5000  5000    32 Feb 21 10:28 dovecot-uidlist.lock
-rw-------  1 5000  5000     8 Feb 21 10:28 dovecot-uidvalidity
-r--r--r--  1 5000  5000     0 Feb 21 10:28 dovecot-uidvalidity.4f4363ac
-rw-------  1 5000  5000    40 Feb 21 10:28 dovecot.index.log
drwxr-xr-x  2 5000  5000    68 Feb 19 11:18 dovecot.rawlog
drwx------  2 5000  5000    68 Feb 21 09:58 new
drwx------  2 5000  5000    68 Feb 21 09:11 tmp
4604ds1-ynoe:mail root#


 >Try attaching gdb into it:
 >
 >gdb -p <pid of imap session>
 >bt full
4604ds1-ynoe:~ root# ps -axj | grep dovecot
root     40655     1 40655 4d84750    0 Ss     ??    0:00.02 
/macports/sbin/dovecot -c /macports/etc/dovecot/dovecot.conf
_dovecot 40657 40655 40655 4d84750    0 S      ??    0:00.01 dovecot/anvil
root     40658 40655 40655 4d84750    0 S      ??    0:00.03 dovecot/log
root     40660 40655 40655 4d84750    0 S      ??    0:00.06 dovecot/config
_dovecot 40662 40655 40655 4d84750    0 S      ??    0:00.02 dovecot/auth
root     40663 40655 40655 4d84750    0 S      ??    0:00.03 dovecot/auth -w
5000     40677 40655 40655 4d84750    0 S      ??    0:00.01 dovecot/pop3
5000     40689 40655 40655 4d84750    0 S      ??    0:00.01 dovecot/pop3
5000     40803 40655 40655 4d84750    0 S      ??    0:00.01 dovecot/pop3
root     40618   362 40618 5680af8    1 S+   s001    0:00.01 tail -f 
dovecot.log
root     40952   396 40951 4d85d40    2 R+   s003    0:00.00 grep dovecot
4604ds1-ynoe:~ root# gdb -p 40803
GNU gdb 6.3.50-20050815 (Apple version gdb-1518) (Sat Feb 12 02:49:13 
UTC 2011)
Copyright 2004 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
welcome to change it and/or distribute copies of it under certain 
conditions.
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB.  Type "show warranty" for details.
This GDB was configured as "i386-apple-darwin".
/private/var/root/40803: No such file or directory
Attaching to process 40803.
Reading symbols for shared libraries . done
Reading symbols for shared libraries ...... done
0x90003afa in mach_msg_trap ()
(gdb) bt full
#0  0x90003afa in mach_msg_trap ()
No symbol table info available.
#1  0x90004267 in mach_msg ()
No symbol table info available.
#2  0x9001b431 in vproc_mig_look_up2 ()
No symbol table info available.
#3  0x9001b26a in bootstrap_look_up2 ()
No symbol table info available.
#4  0x9001b0e4 in bootstrap_look_up ()
No symbol table info available.
#5  0x9001af30 in notify_register_check ()
No symbol table info available.
#6  0x9001ada7 in notify_register_tz ()
No symbol table info available.
#7  0x9001a621 in tzsetwall_basic ()
No symbol table info available.
#8  0x90041903 in localtime ()
No symbol table info available.
#9  0x0007ba2f in mail_index_update_day_headers ()
No symbol table info available.
#10 0x00077c95 in mail_index_transaction_finish ()
No symbol table info available.
#11 0x0007680a in mail_index_transaction_commit_v ()
No symbol table info available.
#12 0x00076acf in mail_index_transaction_commit_full ()
No symbol table info available.
#13 0x00076b18 in mail_index_transaction_commit ()
No symbol table info available.
#14 0x0007f434 in mail_index_sync_commit ()
No symbol table info available.
#15 0x0004ff02 in maildir_sync_index_finish ()
No symbol table info available.
#16 0x00051376 in maildir_sync_context ()
No symbol table info available.
#17 0x000516f2 in maildir_storage_sync_init ()
No symbol table info available.
#18 0x000125fd in mailbox_sync ()
No symbol table info available.
#19 0x000024ba in client_create ()
No symbol table info available.
#20 0x00001a2a in client_create_from_input ()
No symbol table info available.
#21 0x00001f35 in login_client_connected ()
No symbol table info available.
#22 0x000eb1a8 in master_login_auth_finish ()
No symbol table info available.
#23 0x000eae80 in master_login_auth_callback ()
No symbol table info available.
#24 0x000ebb3a in master_login_auth_input ()
No symbol table info available.
#25 0x001001a7 in io_loop_call_io ()
No symbol table info available.
#26 0x00101492 in io_loop_handler_run ()
No symbol table info available.
#27 0x00100148 in io_loop_run ()
No symbol table info available.
#28 0x000ed25a in master_service_run ()
No symbol table info available.
#29 0x00001df8 in main ()
No symbol table info available.
(gdb) quit
The program is running.  Quit anyway (and detach it)? (y or n) y
Detaching from process 40803.
4604ds1-ynoe:~ root#


 >
 >or alternatively try:
 >
 >gdb --args /usr/local/libexec/dovecot/imap -u user at domain
 >run
 >a select inbox
 ><ctrl-c>
 >bt full

4604ds1-ynoe:~ root# gdb --args /macports/libexec/dovecot/pop3 -u 
postmaster at mathiesen.info
GNU gdb 6.3.50-20050815 (Apple version gdb-1518) (Sat Feb 12 02:49:13 
UTC 2011)
Copyright 2004 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
welcome to change it and/or distribute copies of it under certain 
conditions.
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB.  Type "show warranty" for details.
This GDB was configured as "i386-apple-darwin"...Reading symbols for 
shared libraries ..... done

(gdb) run
Starting program: /macports/libexec/dovecot/pop3 -u 
postmaster at mathiesen.info
Reading symbols for shared libraries ++++. done
Debug: auth input: postmaster at mathiesen.info uid=5000 gid=5000 
home=/Volumes/BrugerData/PostFix/mail/mathiesen.info/postmaster at mathiesen.info/
Debug: Effective uid=5000, gid=5000, 
home=/Volumes/BrugerData/PostFix/mail/mathiesen.info/postmaster at mathiesen.info/
Debug: maildir++: 
root=/Volumes/BrugerData/PostFix/mail/mathiesen.info/postmaster at mathiesen.info/, 
index=, control=, 
inbox=/Volumes/BrugerData/PostFix/mail/mathiesen.info/postmaster at mathiesen.info/, 
alt=
Debug: Namespace : Using permissions from 
/Volumes/BrugerData/PostFix/mail/mathiesen.info/postmaster at mathiesen.info/: 
mode=0700 gid=-1
a select inbox
^C
Program received signal SIGINT, Interrupt.
0x90003afa in mach_msg_trap ()
(gdb) bt full
#0  0x90003afa in mach_msg_trap ()
No symbol table info available.
#1  0x90004267 in mach_msg ()
No symbol table info available.
#2  0x9001b431 in vproc_mig_look_up2 ()
No symbol table info available.
#3  0x9001b26a in bootstrap_look_up2 ()
No symbol table info available.
#4  0x9001b0e4 in bootstrap_look_up ()
No symbol table info available.
#5  0x9001af30 in notify_register_check ()
No symbol table info available.
#6  0x9001ada7 in notify_register_tz ()
No symbol table info available.
#7  0x9001a621 in tzsetwall_basic ()
No symbol table info available.
#8  0x90041903 in localtime ()
No symbol table info available.
#9  0x0007ba2f in mail_index_update_day_headers ()
No symbol table info available.
#10 0x00077c95 in mail_index_transaction_finish ()
No symbol table info available.
#11 0x0007680a in mail_index_transaction_commit_v ()
No symbol table info available.
#12 0x00076acf in mail_index_transaction_commit_full ()
No symbol table info available.
#13 0x00076b18 in mail_index_transaction_commit ()
No symbol table info available.
#14 0x0007f434 in mail_index_sync_commit ()
No symbol table info available.
#15 0x0004ff02 in maildir_sync_index_finish ()
No symbol table info available.
#16 0x00051376 in maildir_sync_context ()
No symbol table info available.
#17 0x000516f2 in maildir_storage_sync_init ()
No symbol table info available.
#18 0x000125fd in mailbox_sync ()
No symbol table info available.
#19 0x000024ba in client_create ()
No symbol table info available.
#20 0x00001a2a in client_create_from_input ()
No symbol table info available.
#21 0x00001d71 in main ()
No symbol table info available.
(gdb) quit
The program is running.  Exit anyway? (y or n) y
4604ds1-ynoe:~ root#

More information about the dovecot mailing list