ports/122180: HAL double mounting DVDs, pagefault on umount

Fri Mar 28 06:10:01 UTC 2008

>Number:         122180
>Category:       ports
>Synopsis:       HAL double mounting DVDs, pagefault on umount
>Confidential:   no
>Severity:       serious
>Priority:       medium
>Responsible:    freebsd-ports-bugs
>State:          open
>Quarter:        
>Keywords:       
>Date-Required:
>Class:          sw-bug
>Submitter-Id:   current-users
>Arrival-Date:   Fri Mar 28 06:10:01 UTC 2008
>Closed-Date:
>Last-Modified:
>Originator:     Kevin Downey
>Release:        7.0-STABLE
>Organization:
>Environment:
FreeBSD eskarina.nexus.lan 7.0-STABLE FreeBSD 7.0-STABLE #66: Tue Mar 18 22:21:26 PDT 2008     root at eskarina.nexus.lan:/usr/obj/usr/src/sys/ES  i386

>Description:

kpd at eskarina ~% cat /media/.hal-mtab
/dev/cd0	1001	0	udf	noexec,nosuid	/media/EARTH_2
/dev/cd0	1001	0	udf	noexec,nosuid	/media/EARTH_2_

hal-0.5.11.r2_4

the double mounting has been going on for sometime, but I just ignored it. But now the machine pagefaults when I umount a dvd. It does not panic if I stop hald and mount & umount manuallly. All I see in lshal --monitor is:

22:42:25.452: volume_label_EARTH_2 added
22:42:27.677: volume_label_EARTH_2 property volume.mount_point = '/media/EARTH_2'
22:42:27.683: volume_label_EARTH_2 property volume.is_mounted_read_only = true
22:42:27.689: volume_label_EARTH_2 property volume.is_mounted = true

=== here is the panic message:

Mar 27 22:11:18 eskarina kernel: Fatal trap 12: page fault while in kernel mode
Mar 27 22:11:18 eskarina kernel: cpuid = 1; apic id = 01
Mar 27 22:11:18 eskarina kernel: fault virtual address  = 0x0
Mar 27 22:11:18 eskarina kernel: fault code             = supervisor read, page not present
Mar 27 22:11:18 eskarina kernel: instruction pointer    = 0x20:0xc0510020
Mar 27 22:11:18 eskarina kernel: stack pointer          = 0x28:0xf64bd880
Mar 27 22:11:18 eskarina kernel: frame pointer          = 0x28:0xf64bd8b0
Mar 27 22:11:18 eskarina kernel: code segment           = base 0x0, limit 0xfffff, type 0x1b
Mar 27 22:11:18 eskarina kernel: = DPL 0, pres 1, def32 1, gran 1
Mar 27 22:11:18 eskarina kernel: processor eflags       = interrupt enabled, resume, IOPL = 0
Mar 27 22:11:18 eskarina kernel: current process                = 8083 (gvfsd-trash)
Mar 27 22:11:18 eskarina kernel: trap number            = 12
Mar 27 22:11:18 eskarina kernel: panic: page fault
Mar 27 22:11:18 eskarina kernel: cpuid = 1
Mar 27 22:11:18 eskarina kernel: Uptime: 22m3s
Mar 27 22:11:18 eskarina kernel: Physical memory: 2013 MB
Mar 27 22:11:18 eskarina kernel: Dumping 215 MB: (CTRL-C to abort)  200 (CTRL-C to abort)  184 168 (CTRL-C to abort)  152 (CTRL-C to abort)  (CTRL-C to abort)  136 (CTRL-C to abort)  120 104 88 72 56 40 24 8
Mar 27 22:11:18 eskarina kernel: Dump complete
Mar 27 22:11:18 eskarina kernel: Automatic reboot in 15 seconds - press a key on the console to abort
Mar 27 22:11:18 eskarina kernel: Rebooting...
Mar 27 22:11:18 eskarina kernel: cpu_reset: Stopping other CPUs

=== here is the syslog during the insertion of the disc:

Mar 27 22:42:25 eskarina hald[28848]: 22:42:25.451 [I] hald.c:108: Added device to GDL; udi=/org/freedesktop/Hal/devices/volume_label_EARTH_2
Mar 27 22:42:25 eskarina console-kit-daemon[1409]: GLib-CRITICAL: g_hash_table_lookup: assertion `hash_table != NULL' failed
Mar 27 22:42:25 eskarina kernel: Mar 27 22:42:25 eskarina console-kit-daemon[1409]: GLib-CRITICAL: g_hash_table_lookup: assertion `hash_table != NULL' failed
Mar 27 22:42:25 eskarina console-kit-daemon[1409]: GLib-CRITICAL: g_hash_table_destroy: assertion `hash_table != NULL' failed
Mar 27 22:42:25 eskarina kernel: Mar 27 22:42:25 eskarina console-kit-daemon[1409]: GLib-CRITICAL: g_hash_table_destroy: assertion `hash_table != NULL' failed
Mar 27 22:42:25 eskarina hald[28848]: 22:42:25.710 [W] ci-tracker.c:366: Error doing GetSessionForUnixProcess on ConsoleKit: org.freedesktop.ConsoleKit.Manager.GeneralError: Unable to lookup session information for process '29079'
Mar 27 22:42:25 eskarina hald[28848]: 22:42:25.710 [I] hald_dbus.c:5127: OK for method 'Mount' with signature 'ssas' on interface 'org.freedesktop.Hal.Device.Volume' for UDI '/org/freedesktop/Hal/devices/volume_label_EARTH_2' and execpath 'hal-storage-mount'
Mar 27 22:42:25 eskarina hald[28848]: 22:42:25.710 [I] hald_dbus.c:4018: no need to enqueue
Mar 27 22:42:25 eskarina console-kit-daemon[1409]: GLib-CRITICAL: g_hash_table_lookup: assertion `hash_table != NULL' failed
Mar 27 22:42:25 eskarina kernel: Mar 27 22:42:25 eskarina console-kit-daemon[1409]: GLib-CRITICAL: g_hash_table_lookup: assertion `hash_table != NULL' failed
Mar 27 22:42:25 eskarina console-kit-daemon[1409]: GLib-CRITICAL: g_hash_table_destroy: assertion `hash_table != NULL' failed
Mar 27 22:42:25 eskarina kernel: Mar 27 22:42:25 eskarina console-kit-daemon[1409]: GLib-CRITICAL: g_hash_table_destroy: assertion `hash_table != NULL' failed
Mar 27 22:42:25 eskarina hald[28848]: 22:42:25.712 [W] ci-tracker.c:366: Error doing GetSessionForUnixProcess on ConsoleKit: org.freedesktop.ConsoleKit.Manager.GeneralError: Unable to lookup session information for process '29075'
Mar 27 22:42:25 eskarina hald[28848]: 22:42:25.712 [I] hald_dbus.c:5127: OK for method 'Mount' with signature 'ssas' on interface 'org.freedesktop.Hal.Device.Volume' for UDI '/org/freedesktop/Hal/devices/volume_label_EARTH_2' and execpath 'hal-storage-mount'
Mar 27 22:42:25 eskarina hald[28848]: 22:42:25.712 [I] hald_dbus.c:4014: enqueue
Mar 27 22:42:26 eskarina hald: mounted /dev/cd0 on behalf of uid 1001
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.116 [I] device.c:1894: Removing locks from ':1.25'
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.116 [I] hald_dbus.c:4069: Execing next method in queue
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.123 [I] ci-tracker.c:212: Removing CICallerInfo object for :1.24
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.123 [I] device.c:1894: Removing locks from ':1.24'
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.220 [I] device.c:1894: Removing locks from ':1.26'
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.220 [I] hald_dbus.c:4042: No more methods in queue
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.220 [I] hald_dbus.c:4105: failed with 'org.freedesktop.Hal.Device.Volume.MountPointNotAvailable' 'The mount point '/media/EARTH_2' is already occupied'
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.220 [I] hald_dbus.c:5127: OK for method 'Mount' with signature 'ssas' on interface 'org.freedesktop.Hal.Device.Volume' for UDI '/org/freedesktop/Hal/devices/volume_label_EARTH_2' and execpath 'hal-storage-mount'
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.220 [I] hald_dbus.c:4018: no need to enqueue
Mar 27 22:42:26 eskarina hald: mounted /dev/cd0 on behalf of uid 1001
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.403 [I] hald_dbus.c:4042: No more methods in queue
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.403 [I] device.c:1894: Removing locks from ':1.27'
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.406 [I] ci-tracker.c:212: Removing CICallerInfo object for :1.23
Mar 27 22:42:26 eskarina hald[28848]: 22:42:26.406 [I] device.c:1894: Removing locks from ':1.23'
Mar 27 22:42:27 eskarina gnome-keyring-daemon[1464]: adding removable location: volume_label_EARTH_2 at /media/EARTH_2
Mar 27 22:42:27 eskarina kernel: Mar 27 22:42:27 eskarina gnome-keyring-daemon[1464]: adding removable location: volume_label_EARTH_2 at /media/EARTH_2
>How-To-Repeat:
Insert a dvd into the optical drive with hald running
>Fix:

>Release-Note:
>Audit-Trail:
>Unformatted: