Hi Marco,

I've seen this, too. I couldn't reproduce the hang-on-boot yet after
experiencing it once, but the segfaults are pretty reliable. Here's
an exemplary crash and the accompanying debug log (attached).

I'm away over the weekend, but I'll gladly help when I get back if
you need core dumps or more test runs.


Regards,

Jan
r...@apocatequil:/mnt# udevd --debug 2> /root/udev_heap_corruption.log
*** glibc detected *** udevd: free(): invalid next size (fast): 0x097814f8 ***
======= Backtrace: =========
/lib/i686/cmov/libc.so.6[0xb7e188f4]
/lib/i686/cmov/libc.so.6(cfree+0x96)[0xb7e1a896]
udevd[0x8055690]
/lib/i686/cmov/libc.so.6(__libc_start_main+0xe5)[0xb7dc07a5]
udevd[0x804a071]
======= Memory map: ========
08048000-08065000 r-xp 00000000 08:02 2330236    /sbin/udevd
08065000-08066000 rw-p 0001d000 08:02 2330236    /sbin/udevd
0976f000-097c7000 rw-p 00000000 00:00 0          [heap]
b7c00000-b7c21000 rw-p 00000000 00:00 0 
b7c21000-b7d00000 ---p 00000000 00:00 0 
b7d3e000-b7d68000 r-xp 00000000 08:02 523601     /lib/libgcc_s.so.1
b7d68000-b7d69000 rw-p 00029000 08:02 523601     /lib/libgcc_s.so.1
b7d69000-b7d73000 r-xp 00000000 08:02 533647     
/lib/i686/cmov/libnss_files-2.9.so
b7d73000-b7d74000 r--p 00009000 08:02 533647     
/lib/i686/cmov/libnss_files-2.9.so
b7d74000-b7d75000 rw-p 0000a000 08:02 533647     
/lib/i686/cmov/libnss_files-2.9.so
b7d75000-b7d8a000 r-xp 00000000 08:02 533649     /lib/i686/cmov/libnsl-2.9.so
b7d8a000-b7d8b000 r--p 00014000 08:02 533649     /lib/i686/cmov/libnsl-2.9.so
b7d8b000-b7d8c000 rw-p 00015000 08:02 533649     /lib/i686/cmov/libnsl-2.9.so
b7d8c000-b7d8e000 rw-p 00000000 00:00 0 
b7da4000-b7da5000 rw-p 00000000 00:00 0 
b7da5000-b7da7000 r-xp 00000000 08:02 533657     /lib/i686/cmov/libdl-2.9.so
b7da7000-b7da8000 r--p 00001000 08:02 533657     /lib/i686/cmov/libdl-2.9.so
b7da8000-b7da9000 rw-p 00002000 08:02 533657     /lib/i686/cmov/libdl-2.9.so
b7da9000-b7daa000 rw-p 00000000 00:00 0 
b7daa000-b7f02000 r-xp 00000000 08:02 533393     /lib/i686/cmov/libc-2.9.so
b7f02000-b7f03000 ---p 00158000 08:02 533393     /lib/i686/cmov/libc-2.9.so
b7f03000-b7f05000 r--p 00158000 08:02 533393     /lib/i686/cmov/libc-2.9.so
b7f05000-b7f06000 rw-p 0015a000 08:02 533393     /lib/i686/cmov/libc-2.9.so
b7f06000-b7f09000 rw-p 00000000 00:00 0 
b7f09000-b7f22000 r-xp 00000000 08:02 655868     /lib/libselinux.so.1
b7f22000-b7f23000 r--p 00018000 08:02 655868     /lib/libselinux.so.1
b7f23000-b7f24000 rw-p 00019000 08:02 655868     /lib/libselinux.so.1
b7f25000-b7f2e000 r-xp 00000000 08:02 533653     
/lib/i686/cmov/libnss_nis-2.9.so
b7f2e000-b7f2f000 r--p 00008000 08:02 533653     
/lib/i686/cmov/libnss_nis-2.9.so
b7f2f000-b7f30000 rw-p 00009000 08:02 533653     
/lib/i686/cmov/libnss_nis-2.9.so
b7f30000-b7f37000 r-xp 00000000 08:02 533399     
/lib/i686/cmov/libnss_compat-2.9.so
b7f37000-b7f38000 r--p 00006000 08:02 533399     
/lib/i686/cmov/libnss_compat-2.9.so
b7f38000-b7f39000 rw-p 00007000 08:02 533399     
/lib/i686/cmov/libnss_compat-2.9.so
b7f39000-b7f3c000 rw-p 00000000 00:00 0 
b7f3c000-b7f3d000 r-xp 00000000 00:00 0          [vdso]
b7f3d000-b7f59000 r-xp 00000000 08:02 524277     /lib/ld-2.9.so
b7f59000-b7f5a000 r--p 0001b000 08:02 524277     /lib/ld-2.9.so
b7f5a000-b7f5b000 rw-p 0001c000 08:02 524277     /lib/ld-2.9.so
bfea3000-bfeb8000 rw-p 00000000 00:00 0          [stack]
Aborted (core dumped)
1252111429.509218 [19694] udev_device_new_from_syspath: device 0x97702c0 has 
devpath 
'/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
1252111429.540598 [19694] udev_device_read_db: device 0x97702c0 filled with db 
file data
1252111429.540620 [19694] udev_watch_restore: restoring old watch on '/dev/sdb'
1252111429.540635 [19694] udev_watch_begin: adding watch on '/dev/sdb'
1252111429.541322 [19694] parse_file: reading 
'/etc/udev/rules.d/025_libgphoto2.rules' as rules file
1252111429.552345 [19694] parse_file: reading 
'/etc/udev/rules.d/035_kino.rules' as rules file
1252111429.552444 [19694] parse_file: reading 
'/lib/udev/rules.d/45-libmtp8.rules' as rules file
1252111429.558203 [19694] parse_file: reading 
'/lib/udev/rules.d/50-udev-default.rules' as rules file
1252111429.558750 [19694] parse_file: reading '/lib/udev/rules.d/55-dm.rules' 
as rules file
1252111429.558829 [19694] add_rule: name empty, node creation suppressed
1252111429.558948 [19694] parse_file: reading 
'/lib/udev/rules.d/60-libsane-extras.rules' as rules file
1252111429.559075 [19694] parse_file: reading 
'/lib/udev/rules.d/60-libsane.rules' as rules file
1252111429.564638 [19694] parse_file: reading 
'/lib/udev/rules.d/60-persistent-alsa.rules' as rules file
1252111429.564778 [19694] parse_file: reading 
'/lib/udev/rules.d/60-persistent-input.rules' as rules file
1252111429.565093 [19694] parse_file: reading 
'/lib/udev/rules.d/60-persistent-serial.rules' as rules file
1252111429.565259 [19694] parse_file: reading 
'/lib/udev/rules.d/60-persistent-storage-dm.rules' as rules file
1252111429.565439 [19694] parse_file: reading 
'/lib/udev/rules.d/60-persistent-storage-tape.rules' as rules file
1252111429.565647 [19694] parse_file: reading 
'/lib/udev/rules.d/60-persistent-storage.rules' as rules file
1252111429.566197 [19694] parse_file: reading 
'/lib/udev/rules.d/60-persistent-v4l.rules' as rules file
1252111429.566359 [19694] parse_file: reading 
'/lib/udev/rules.d/61-mobile-action.rules' as rules file
1252111429.566467 [19694] parse_file: reading 
'/lib/udev/rules.d/61-option-modem-modeswitch.rules' as rules file
1252111429.566827 [19694] parse_file: reading 
'/etc/udev/rules.d/65_dmsetup.rules' as rules file
1252111429.567038 [19694] parse_file: reading '/lib/udev/rules.d/70-acl.rules' 
as rules file
1252111429.567287 [19694] parse_file: reading 
'/lib/udev/rules.d/70-hid2hci.rules' as rules file
1252111429.567447 [19694] parse_file: reading 
'/etc/udev/rules.d/70-persistent-cd.rules' as rules file
1252111429.567631 [19694] parse_file: reading 
'/etc/udev/rules.d/70-persistent-net.rules' as rules file
1252111429.567755 [19694] parse_file: reading 
'/lib/udev/rules.d/75-cd-aliases-generator.rules' as rules file
1252111429.567856 [19694] parse_file: reading 
'/lib/udev/rules.d/75-net-description.rules' as rules file
1252111429.567995 [19694] parse_file: reading 
'/lib/udev/rules.d/75-persistent-net-generator.rules' as rules file
1252111429.568397 [19694] parse_file: reading 
'/lib/udev/rules.d/75-tty-description.rules' as rules file
1252111429.568535 [19694] parse_file: reading 
'/lib/udev/rules.d/78-sound-card.rules' as rules file
1252111429.568949 [19694] parse_file: reading 
'/lib/udev/rules.d/79-fstab_import.rules' as rules file
1252111429.569046 [19694] parse_file: reading '/lib/udev/rules.d/80-alsa.rules' 
as rules file
1252111429.569112 [19694] parse_file: reading 
'/lib/udev/rules.d/80-drivers.rules' as rules file
1252111429.569391 [19694] parse_file: reading 
'/lib/udev/rules.d/85-hwclock.rules' as rules file
1252111429.569485 [19694] parse_file: reading 
'/etc/udev/rules.d/85-pcmcia.rules' as rules file
1252111429.569592 [19694] parse_file: reading '/lib/udev/rules.d/90-hal.rules' 
as rules file
1252111429.569654 [19694] parse_file: reading 
'/lib/udev/rules.d/91-permissions.rules' as rules file
1252111429.570689 [19694] parse_file: reading 
'/lib/udev/rules.d/95-dm-notify.rules' as rules file
1252111429.570764 [19694] parse_file: reading 
'/lib/udev/rules.d/95-keymap.rules' as rules file
1252111429.571408 [19694] parse_file: reading 
'/lib/udev/rules.d/95-udev-late.rules' as rules file
1252111429.571531 [19694] parse_file: reading 
'/lib/udev/rules.d/99-LOCAL.rules' as rules file
1252111429.571596 [19694] parse_file: reading 
'/etc/udev/rules.d/z60_gpsd.rules' as rules file
1252111429.571768 [19694] parse_file: reading 
'/etc/udev/rules.d/z60_hdparm.rules' as rules file
1252111429.571837 [19694] parse_file: reading 
'/etc/udev/rules.d/z60_libfprint0.rules' as rules file
1252111429.572048 [19694] parse_file: reading 
'/etc/udev/rules.d/z60_virtualbox-ose.rules' as rules file
1252111429.572121 [19694] udev_rules_new: rules use 143556 bytes tokens (11963 
* 12 bytes), 20027 bytes buffer
1252111429.572139 [19694] udev_rules_new: temporary index used 37760 bytes 
(1888 * 20 bytes)
1252111429.572537 [19694] main: initialize max_childs to 379
1252111442.488479 [19694] event_queue_insert: seq 1393 queued, 'change' 'block'
1252111442.488816 [19694] worker_new: seq 1393 forked new worker [19699]
1252111442.488954 [19694] event_queue_insert: seq 1394 queued, 'add' 'block'
1252111442.489016 [19694] event_queue_insert: seq 1395 queued, 'add' 'block'
1252111442.489620 [19699] worker_new: seq 1393 running
1252111442.489774 [19699] udev_device_new_from_syspath: device 0x976f1f0 has 
devpath 
'/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
1252111442.489947 [19699] udev_device_read_db: device 0x976f1f0 filled with db 
file data
1252111442.489979 [19699] udev_watch_end: removing watch on '/dev/sdb'
1252111442.490085 [19699] udev_rules_apply_to_event: LINK 'block/8:16' 
/lib/udev/rules.d/50-udev-default.rules:1
1252111442.490247 [19699] udev_device_new_from_syspath: device 0x9780cf8 has 
devpath 
'/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0'
1252111442.490360 [19699] udev_device_new_from_syspath: device 0x97814c0 has 
devpath '/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0'
1252111442.490429 [19699] udev_device_new_from_syspath: device 0x97816e0 has 
devpath '/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5'
1252111442.490493 [19699] udev_device_new_from_syspath: device 0x97818e8 has 
devpath '/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0'
1252111442.490543 [19699] udev_device_new_from_syspath: device 0x9781a80 has 
devpath '/devices/pci0000:00/0000:00:1a.7/usb1/1-3'
1252111442.490591 [19699] udev_device_new_from_syspath: device 0x9781c40 has 
devpath '/devices/pci0000:00/0000:00:1a.7/usb1'
1252111442.490638 [19699] udev_device_new_from_syspath: device 0x9781df8 has 
devpath '/devices/pci0000:00/0000:00:1a.7'
1252111442.490698 [19699] udev_device_new_from_syspath: device 0x9781fb0 has 
devpath '/devices/pci0000:00'
1252111442.490901 [19699] udev_rules_apply_to_event: IMPORT 'usb_id --export 
/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
 /lib/udev/rules.d/60-persistent-storage.rules:49
1252111442.490944 [19699] util_run_program: 'usb_id --export 
/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
 started
1252111442.494833 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_VENDOR=Generic-'
1252111442.494862 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_VENDOR_ENC=Generic-'
1252111442.494877 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_VENDOR_ID=0bda'
1252111442.494891 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_MODEL=Multi-Card'
1252111442.494904 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_MODEL_ENC=Multi-Card\x20\x20\x20\x20\x20\x20'
1252111442.494918 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_MODEL_ID=0158'
1252111442.494932 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_REVISION=1.00'
1252111442.494946 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_SERIAL=Generic-_Multi-Card_20060413092100000-0:0'
1252111442.494959 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_SERIAL_SHORT=20060413092100000'
1252111442.494973 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_TYPE=disk'
1252111442.494986 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_INSTANCE=0:0'
1252111442.495051 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_BUS=usb'
1252111442.495066 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_USB_INTERFACES=:080650:'
1252111442.495080 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_USB_INTERFACE_NUM=00'
1252111442.495092 [19699] util_run_program: '/lib/udev/usb_id' (stdout) 
'ID_USB_DRIVER=usb-storage'
1252111442.495142 [19699] util_run_program: 'usb_id --export 
/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
 returned with exitcode 0
1252111442.495245 [19699] udev_rules_apply_to_event: IMPORT 'edd_id --export 
/dev/sdb' /lib/udev/rules.d/60-persistent-storage.rules:71
1252111442.495283 [19699] util_run_program: 'edd_id --export /dev/sdb' started
1252111442.498477 [19699] util_run_program: '/lib/udev/edd_id' (stderr) 'no 
kernel EDD support'
1252111442.498529 [19699] util_run_program: 'edd_id --export /dev/sdb' returned 
with exitcode 2
1252111442.498570 [19699] udev_rules_apply_to_event: IMPORT 'path_id 
/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
 /lib/udev/rules.d/60-persistent-storage.rules:80
1252111442.498589 [19699] util_run_program: 'path_id 
/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
 started
1252111442.504657 [19699] util_run_program: '/lib/udev/path_id' (stdout) 
'ID_PATH=pci-0000:00:1a.7-usb-0:3:1.0-scsi-0:0:0:0'
1252111442.504856 [19699] util_run_program: 'path_id 
/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
 returned with exitcode 0
1252111442.504924 [19699] udev_rules_apply_to_event: LINK 
'disk/by-id/usb-Generic-_Multi-Card_20060413092100000-0:0' 
/lib/udev/rules.d/60-persistent-storage.rules:99
1252111442.504969 [19699] udev_rules_apply_to_event: LINK 
'disk/by-path/pci-0000:00:1a.7-usb-0:3:1.0-scsi-0:0:0:0' 
/lib/udev/rules.d/60-persistent-storage.rules:110
1252111442.505020 [19699] udev_rules_apply_to_event: IMPORT '/sbin/blkid -o 
udev -p /dev/sdb' /lib/udev/rules.d/60-persistent-storage.rules:124
1252111442.505057 [19699] util_run_program: '/sbin/blkid -o udev -p /dev/sdb' 
started
1252111442.536134 [19699] util_run_program: '/sbin/blkid -o udev -p /dev/sdb' 
returned with exitcode 2
1252111442.536232 [19699] udev_rules_apply_to_event: RUN 
'socket:@/org/freedesktop/hal/udev_event' /lib/udev/rules.d/90-hal.rules:2
1252111442.536267 [19699] udev_rules_apply_to_event: GROUP 6 
/lib/udev/rules.d/91-permissions.rules:9
1252111442.536285 [19699] udev_rules_apply_to_event: GROUP 25 
/lib/udev/rules.d/91-permissions.rules:10
1252111442.536452 [19699] udev_rules_apply_to_event: GROUP 25 
/lib/udev/rules.d/91-permissions.rules:14
1252111442.536662 [19699] udev_event_execute_rules: no node name set, will use 
kernel supplied name 'sdb'
1252111442.536742 [19699] udev_device_update_db: created db file for 
'/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
 in 
'/dev/.udev/db/\x2fdevices\x2fpci0000:00\x2f0000:00:1a.7\x2fusb1\x2f1-3\x2f1-3:1.0\x2fhost5\x2ftarget5:0:0\x2f5:0:0:0\x2fblock\x2fsdb'
1252111442.536835 [19699] udev_node_add: creating device node '/dev/sdb', 
devnum=8:16, mode=0660, uid=0, gid=25
1252111442.536868 [19699] udev_node_mknod: preserve file '/dev/sdb', because it 
has correct dev_t
1252111442.536998 [19699] update_link: found 2 devices with name 
'/dev/block/8:16'
1252111442.537057 [19699] update_link: '/dev/block/8:16' with target '/dev/sdb' 
has the highest priority 0, create it
1252111442.537090 [19699] node_symlink: preserve already existing symlink 
'/dev/block/8:16' to '../sdb'
1252111442.537177 [19699] update_link: found 2 devices with name 
'/dev/disk/by-id/usb-Generic-_Multi-Card_20060413092100000-0:0'
1252111442.537216 [19699] update_link: 
'/dev/disk/by-id/usb-Generic-_Multi-Card_20060413092100000-0:0' with target 
'/dev/sdb' has the highest priority 0, create it
1252111442.537253 [19699] node_symlink: preserve already existing symlink 
'/dev/disk/by-id/usb-Generic-_Multi-Card_20060413092100000-0:0' to '../../sdb'
1252111442.537371 [19699] update_link: found 2 devices with name 
'/dev/disk/by-path/pci-0000:00:1a.7-usb-0:3:1.0-scsi-0:0:0:0'
1252111442.537410 [19699] update_link: 
'/dev/disk/by-path/pci-0000:00:1a.7-usb-0:3:1.0-scsi-0:0:0:0' with target 
'/dev/sdb' has the highest priority 0, create it
1252111442.537445 [19699] node_symlink: preserve already existing symlink 
'/dev/disk/by-path/pci-0000:00:1a.7-usb-0:3:1.0-scsi-0:0:0:0' to '../../sdb'
1252111442.537725 [19699] udev_monitor_send_device: passed 849 bytes to monitor 
0x977bb18
1252111442.537759 [19699] udev_watch_begin: adding watch on '/dev/sdb'
1252111442.537854 [19699] udev_device_update_db: created db file for 
'/devices/pci0000:00/0000:00:1a.7/usb1/1-3/1-3:1.0/host5/target5:0:0/5:0:0:0/block/sdb'
 in 
'/dev/.udev/db/\x2fdevices\x2fpci0000:00\x2f0000:00:1a.7\x2fusb1\x2f1-3\x2f1-3:1.0\x2fhost5\x2ftarget5:0:0\x2f5:0:0:0\x2fblock\x2fsdb'
1252111442.537943 [19699] udev_monitor_send_device: passed -1 bytes to monitor 
0x976f750
1252111442.537972 [19699] worker_new: seq 1393 processed with 0

Attachment: signature.asc
Description: Digital signature

Reply via email to