Attachment 178260 Details for Bug 332057

Debug output of haldaemon

hald_debug.log (text/plain), 32.05 KB, created by Frank Fiene on 2007-10-13 11:07:05 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Frank Fiene

Created: 2007-10-13 11:07:05 UTC

Size: 32.05 KB

patch

obsolete

>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.544 [I] osspec.c:220: SEQNUM=1928, ACTION=add, SUBSYSTEM=usb, DEVPATH=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1, DEVNAME=/dev/bus/usb/005/005, IFINDEX=0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.544 [I] hotplug.c:136: /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1 is a device (subsystem)
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.544 [I] osspec.c:863: hal_util_find_known_parent: '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5'
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.544 [I] device.c:3849: add_dev: subsys=usb sysfs_path=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1 dev=/dev/bus/usb/005/005 parent_dev=0x00712700
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.544 [E] util.c:388: Cannot read from '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/configuration'
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.560 [I] device.c:3709: Add callouts completed udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.560 [I] hald.c:108: Added device to GDL; udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.560 [I] osspec.c:220: SEQNUM=1929, ACTION=add, SUBSYSTEM=usb_endpoint, DEVPATH=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/usb_endpoint/usbdev5.5_ep00, DEVNAME=/dev/usbdev5.5_ep00, IFINDEX=0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.560 [I] hotplug.c:136: /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/usb_endpoint/usbdev5.5_ep00 is a device (subsystem)
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.560 [I] osspec.c:863: hal_util_find_known_parent: '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/usb_endpoint/usbdev5.5_ep00'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1'
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.560 [I] device.c:3849: add_dev: subsys=usb_endpoint sysfs_path=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/usb_endpoint/usbdev5.5_ep00 dev=/dev/usbdev5.5_ep00 parent_dev=0x00717aa0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.575 [I] osspec.c:220: SEQNUM=1930, ACTION=add, SUBSYSTEM=usb, DEVPATH=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0, DEVNAME=, IFINDEX=0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.575 [I] hotplug.c:136: /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0 is a device (subsystem)
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.575 [I] osspec.c:863: hal_util_find_known_parent: '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1'
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.576 [I] device.c:3849: add_dev: subsys=usb sysfs_path=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0 dev= parent_dev=0x00717aa0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.576 [E] util.c:382: Cannot open '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/interface'
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.592 [I] device.c:3709: Add callouts completed udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E_if0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.592 [I] hald.c:108: Added device to GDL; udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E_if0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.592 [I] osspec.c:220: SEQNUM=1931, ACTION=add, SUBSYSTEM=scsi_host, DEVPATH=/sys/class/scsi_host/host8, DEVNAME=, IFINDEX=0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.592 [I] hotplug.c:136: /sys/class/scsi_host/host8 is a device (subsystem)
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.592 [I] osspec.c:863: hal_util_find_known_parent: '/sys/class/scsi_host/host8'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0'
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.593 [I] device.c:3849: add_dev: subsys=scsi_host sysfs_path=/sys/class/scsi_host/host8 dev= parent_dev=0x00717d20
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.593 [I] osspec.c:220: SEQNUM=1932, ACTION=add, SUBSYSTEM=usb_endpoint, DEVPATH=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/usb_endpoint/usbdev5.5_ep81, DEVNAME=/dev/usbdev5.5_ep81, IFINDEX=0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.593 [I] hotplug.c:136: /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/usb_endpoint/usbdev5.5_ep81 is a device (subsystem)
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.593 [I] osspec.c:863: hal_util_find_known_parent: '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/usb_endpoint/usbdev5.5_ep81'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0'
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.593 [I] device.c:3849: add_dev: subsys=usb_endpoint sysfs_path=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/usb_endpoint/usbdev5.5_ep81 dev=/dev/usbdev5.5_ep81 parent_dev=0x00717d20
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.593 [I] osspec.c:220: SEQNUM=1933, ACTION=add, SUBSYSTEM=usb_endpoint, DEVPATH=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/usb_endpoint/usbdev5.5_ep02, DEVNAME=/dev/usbdev5.5_ep02, IFINDEX=0
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.593 [I] hotplug.c:136: /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/usb_endpoint/usbdev5.5_ep02 is a device (subsystem)
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.593 [I] osspec.c:863: hal_util_find_known_parent: '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/usb_endpoint/usbdev5.5_ep02'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0'
>Oct 13 12:56:52 erwin hald[7812]: 12:56:52.593 [I] device.c:3849: add_dev: subsys=usb_endpoint sysfs_path=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/usb_endpoint/usbdev5.5_ep02 dev=/dev/usbdev5.5_ep02 parent_dev=0x00717d20
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.464 [I] hald_dbus.c:5037: OK for method 'GetPower' with signature '' on interface 'org.freedesktop.Hal.Device.KillSwitch' for UDI '/org/freedesktop/Hal/devices/ipw_wlan_switch' and execpath 'hal-system-killswitch-get-power'
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.464 [I] hald_dbus.c:3938: no need to enqueue
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.472 [I] hald_dbus.c:5243: ***************************
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.472 [I] hald_dbus.c:5244: ********* got a connection 7335c0
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.472 [I] hald_dbus.c:5245: ***************************
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.473 [I] hald_dbus.c:5186: ************************
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.473 [I] hald_dbus.c:5187: Client to local_server was disconnected for 7335c0
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.473 [I] hald_dbus.c:5188: ************************
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.474 [I] hald_dbus.c:5229: ***************************
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.474 [I] hald_dbus.c:5230: ********* unregistered 7335c0
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.474 [I] hald_dbus.c:5231: ***************************
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.490 [I] device.c:1845: Removing locks from ':1.143'
>Oct 13 12:56:54 erwin hald[7812]: 12:56:54.491 [I] hald_dbus.c:3962: No more methods in queue
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.075 [I] osspec.c:220: SEQNUM=1934, ACTION=add, SUBSYSTEM=scsi, DEVPATH=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0, DEVNAME=, IFINDEX=0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.075 [I] hotplug.c:136: /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0 is a device (subsystem)
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.075 [I] osspec.c:863: hal_util_find_known_parent: '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.075 [I] device.c:3849: add_dev: subsys=scsi sysfs_path=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0 dev= parent_dev=0x00717d20
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.076 [I] osspec.c:863: hal_util_find_known_parent: '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.076 [I] device.c:3849: add_dev: subsys=scsi_host sysfs_path=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8 dev= parent_dev=0x00717d20
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.083 [I] device.c:3709: Add callouts completed udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E_if0_scsi_host
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.083 [I] hald.c:108: Added device to GDL; udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E_if0_scsi_host
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.083 [I] osspec.c:863: hal_util_find_known_parent: '/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.083 [I] device.c:3849: add_dev: subsys=scsi sysfs_path=/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0 dev= parent_dev=0x00715b40
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.083 [I] device.c:2166: /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0/type -> 0 (-> scsi.type)
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.090 [I] device.c:3709: Add callouts completed udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E_if0_scsi_host_scsi_device_lun0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.091 [I] hald.c:108: Added device to GDL; udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E_if0_scsi_host_scsi_device_lun0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.091 [I] osspec.c:220: SEQNUM=1935, ACTION=add, SUBSYSTEM=scsi_disk, DEVPATH=/sys/class/scsi_disk/8:0:0:0, DEVNAME=, IFINDEX=0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.093 [I] hotplug.c:136: /sys/class/scsi_disk/8:0:0:0 is a device (subsystem)
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.093 [I] osspec.c:863: hal_util_find_known_parent: '/sys/class/scsi_disk/8:0:0:0'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.093 [I] device.c:3849: add_dev: subsys=scsi_disk sysfs_path=/sys/class/scsi_disk/8:0:0:0 dev= parent_dev=0x006b7ae0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.093 [I] osspec.c:220: SEQNUM=1938, ACTION=add, SUBSYSTEM=scsi_device, DEVPATH=/sys/class/scsi_device/8:0:0:0, DEVNAME=, IFINDEX=0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.093 [I] hotplug.c:136: /sys/class/scsi_device/8:0:0:0 is a device (subsystem)
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.094 [I] osspec.c:863: hal_util_find_known_parent: '/sys/class/scsi_device/8:0:0:0'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.094 [I] device.c:3849: add_dev: subsys=scsi_device sysfs_path=/sys/class/scsi_device/8:0:0:0 dev= parent_dev=0x006b7ae0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.094 [I] osspec.c:220: SEQNUM=1939, ACTION=add, SUBSYSTEM=scsi_generic, DEVPATH=/sys/class/scsi_generic/sg2, DEVNAME=/dev/sg2, IFINDEX=0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.094 [I] hotplug.c:136: /sys/class/scsi_generic/sg2 is a device (subsystem)
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.095 [I] osspec.c:863: hal_util_find_known_parent: '/sys/class/scsi_generic/sg2'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.095 [I] device.c:3849: add_dev: subsys=scsi_generic sysfs_path=/sys/class/scsi_generic/sg2 dev=/dev/sg2 parent_dev=0x006b7ae0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.103 [I] device.c:3709: Add callouts completed udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E_if0_scsi_host_scsi_device_lun0_scsi_generic
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.103 [I] hald.c:108: Added device to GDL; udi=/org/freedesktop/Hal/devices/usb_device_59f_611_10000E000D5BE47E_if0_scsi_host_scsi_device_lun0_scsi_generic
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.145 [I] osspec.c:220: SEQNUM=1936, ACTION=add, SUBSYSTEM=block, DEVPATH=/sys/block/sdb, DEVNAME=/dev/sdb, IFINDEX=0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.145 [I] osspec.c:863: hal_util_find_known_parent: '/sys/block/sdb'->'/sys/devices/pci0000:00/0000:00:1d.7/usb5/5-1/5-1:1.0/host8/target8:0:0/8:0:0:0'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.145 [I] blockdev.c:856: block_add: sysfs_path=/sys/block/sdb dev=/dev/sdb is_part=0, parent=0x006b7ae0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.145 [I] blockdev.c:1227: parent_bus is scsi
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.145 [I] blockdev.c:494: Probing storage device /dev/sdb
>Oct 13 12:56:55 erwin hald-probe-storage: [10541]: 12:56:55.148 [D] probe-storage.c:155: Doing probe-storage for /dev/sdb (bus usb) (drive_type disk) (udi=/org/freedesktop/Hal/devices/temp/136) (--only-check-for-fs==0)
>Oct 13 12:56:55 erwin hald-probe-storage: [10541]: 12:56:55.148 [D] probe-storage.c:395: Checking for file system on /dev/sdb
>Oct 13 12:56:55 erwin hald-probe-storage: [10541]: 12:56:55.148 [D] probe-storage.c:401: Doing open ("/dev/sdb", O_RDONLY)
>Oct 13 12:56:55 erwin hald-probe-storage: [10541]: 12:56:55.148 [D] probe-storage.c:409: Returned from open(2)
>Oct 13 12:56:55 erwin hald-probe-storage: [10541]: 12:56:55.148 [D] probe-storage.c:425: look for existing partitions for sdb
>Oct 13 12:56:55 erwin hald-probe-storage: [10541]: 12:56:55.148 [D] probe-storage.c:435: partition sdb1 found, skip probing for filesystem
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.148 [I] hald_dbus.c:5243: ***************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.148 [I] hald_dbus.c:5244: ********* got a connection 67ad60
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.148 [I] hald_dbus.c:5245: ***************************
>Oct 13 12:56:55 erwin hald-probe-storage: [10541]: 12:56:55.151 [I] partutil.c:860: MSDOS partition table detected
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.171 [I] hald_dbus.c:1285: storage.removable.media_available -> True
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.171 [I] hald_dbus.c:1269: storage.removable.media_size -> 160041885696
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.171 [I] hald_dbus.c:1253: storage.partitioning_scheme -> mbr
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.171 [I] hald_dbus.c:5186: ************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.171 [I] hald_dbus.c:5187: Client to local_server was disconnected for 67ad60
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.171 [I] hald_dbus.c:5188: ************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.171 [I] hald_dbus.c:5229: ***************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.171 [I] hald_dbus.c:5230: ********* unregistered 67ad60
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.171 [I] hald_dbus.c:5231: ***************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.172 [I] blockdev.c:379: entering; exit_type=0, return_code=0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.176 [I] blockdev.c:133: Add callouts completed udi=/org/freedesktop/Hal/devices/storage_serial_SAMSUNG_HM160JC_10000E000D5BE47E_0_0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.176 [I] hald.c:108: Added device to GDL; udi=/org/freedesktop/Hal/devices/storage_serial_SAMSUNG_HM160JC_10000E000D5BE47E_0_0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.214 [I] device.c:1845: Removing locks from ':1.144'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.235 [I] device.c:1845: Removing locks from ':1.145'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.240 [I] osspec.c:220: SEQNUM=1937, ACTION=add, SUBSYSTEM=block, DEVPATH=/sys/block/sdb/sdb1, DEVNAME=/dev/sdb1, IFINDEX=0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.240 [E] util.c:190: Cannot open '/sys/block/sdb/sdb1/range'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.240 [I] osspec.c:863: hal_util_find_known_parent: '/sys/block/sdb/sdb1'->'/sys/block/sdb'
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.240 [I] blockdev.c:856: block_add: sysfs_path=/sys/block/sdb/sdb1 dev=/dev/sdb1 is_part=1, parent=0x006a22a0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.243 [I] hald_dbus.c:5243: ***************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.243 [I] hald_dbus.c:5244: ********* got a connection 7176c0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.243 [I] hald_dbus.c:5245: ***************************
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.243 [D] probe-volume.c:372: Doing probe-volume for /dev/sdb1
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.244 [D] probe-volume.c:383: volume.block_size = 512
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.244 [D] probe-volume.c:387: volume.size = 160039272448
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.244 [I] probe-volume.c:616: invoking volume_id_probe_all, offset=0, size=1125482496
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.245: volume_id.c:351 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.245: linux_raid.c:70 probing at offset 0x2543140000, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.245: util.c:342 get buffer off 0x2543140000(160039174144), len 0x800
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.245: util.c:391 read seekbuf off:0x2543140000 len:0x800
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.248: linux_raid.c:124 probing at offset 0x2543140000, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.248: util.c:342 get buffer off 0x2543140000(160039174144), len 0x800
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.248: linux_raid.c:124 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.248: util.c:342 get buffer off 0x0(0), len 0x800
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.248: util.c:355 read sbbuf len:0x800
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.252: linux_raid.c:124 probing at offset 0x1000, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.252: util.c:342 get buffer off 0x1000(4096), len 0x800
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.252: util.c:355 read sbbuf len:0x1800
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.254: ddf_raid.c:49 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.254: util.c:342 get buffer off 0x2543157e00(160039271936), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.254: util.c:391 read seekbuf off:0x2543157e00 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: isw_raid.c:47 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:342 get buffer off 0x2543157c00(160039271424), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:391 read seekbuf off:0x2543157c00 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: lsi_raid.c:42 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:342 get buffer off 0x2543157e00(160039271936), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:391 read seekbuf off:0x2543157e00 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:342 get buffer off 0x2543157e00(160039271936), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: silicon_raid.c:57 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:342 get buffer off 0x2543157e00(160039271936), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: nvidia_raid.c:45 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:342 get buffer off 0x2543157c00(160039271424), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:391 read seekbuf off:0x2543157c00 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: promise_raid.c:46 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:342 get buffer off 0x2543150200(160039240192), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.256: util.c:391 read seekbuf off:0x2543150200 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.259: util.c:342 get buffer off 0x2543138200(160039141888), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.260: util.c:391 read seekbuf off:0x2543138200 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.263: util.c:342 get buffer off 0x2543138000(160039141376), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.264: util.c:391 read seekbuf off:0x2543138000 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.264: util.c:342 get buffer off 0x2543156000(160039264256), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.264: util.c:391 read seekbuf off:0x2543156000 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.264: util.c:342 get buffer off 0x2543126200(160039068160), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.264: util.c:391 read seekbuf off:0x2543126200 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: util.c:342 get buffer off 0x2543156a00(160039266816), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: util.c:391 read seekbuf off:0x2543156a00 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: adaptec_raid.c:90 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: util.c:342 get buffer off 0x2543157e00(160039271936), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: util.c:391 read seekbuf off:0x2543157e00 len:0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: jmicron_raid.c:43 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: util.c:342 get buffer off 0x2543157e00(160039271936), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: lvm.c:49 probing at offset 0x0
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: util.c:342 get buffer off 0x400(1024), len 0x800
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: util.c:342 get buffer off 0x0(0), len 0x800
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: highpoint.c:52 probing at offset 0x0
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: util.c:342 get buffer off 0x1200(4608), len 0x200
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: volume_id.c:382 probing at offset 0x0, size 0x2543158000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: fat.c:273 probing at offset 0x0
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: util.c:342 get buffer off 0x0(0), len 0x400
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.268: linux_swap.c:46 probing at offset 0x0
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.269: util.c:342 get buffer off 0xff6(4086), len 0xa
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.269: util.c:342 get buffer off 0x1ff6(8182), len 0xa
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.269: util.c:355 read sbbuf len:0x2000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.269: util.c:342 get buffer off 0x3ff6(16374), len 0xa
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.269: util.c:355 read sbbuf len:0x4000
>Oct 13 12:56:55 erwin hald-probe-volume: 10545: 12:56:55.269: util.c:342 get buffer off 0x0(0), len 0x2
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.269 [I] probe-volume.c:618: volume_id_probe_all returned 0
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.269 [D] probe-volume.c:107: volume.fsusage = 'crypto'
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.269 [D] probe-volume.c:113: volume.fstype = 'crypto_LUKS'
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.269 [D] probe-volume.c:118: volume.fsversion = ''
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.269 [D] probe-volume.c:123: volume.uuid = '80c0aab2-5de6-4884-a4c3-338ad34a4afc'
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.269 [I] probe-volume.c:690: Loading part table
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.271 [I] partutil.c:860: MSDOS partition table detected
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.272 [I] probe-volume.c:696: Looking at part table
>Oct 13 12:56:55 erwin hald-probe-volume: [10545]: 12:56:55.272 [I] probe-volume.c:769: Done looking at part table
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1261: volume.block_size -> 512
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1269: volume.size -> 160039272448
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1253: volume.fsusage -> crypto
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1253: volume.fstype -> crypto_LUKS
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1253: volume.fsversion ->
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1253: volume.uuid -> 80c0aab2-5de6-4884-a4c3-338ad34a4afc
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1253: info.product -> Volume (crypto_LUKS)
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1253: volume.partition.scheme -> mbr
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1253: volume.partition.type -> 0x83
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1253: volume.partition.label ->
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.272 [I] hald_dbus.c:1253: volume.partition.uuid ->
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.273 [I] hald_dbus.c:5186: ************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.273 [I] hald_dbus.c:5187: Client to local_server was disconnected for 7176c0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.273 [I] hald_dbus.c:5188: ************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.273 [I] hald_dbus.c:5229: ***************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.273 [I] hald_dbus.c:5230: ********* unregistered 7176c0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.273 [I] hald_dbus.c:5231: ***************************
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.273 [I] blockdev.c:379: entering; exit_type=0, return_code=0
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.276 [I] blockdev.c:133: Add callouts completed udi=/org/freedesktop/Hal/devices/volume_uuid_80c0aab2_5de6_4884_a4c3_338ad34a4afc
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.276 [I] hald.c:108: Added device to GDL; udi=/org/freedesktop/Hal/devices/volume_uuid_80c0aab2_5de6_4884_a4c3_338ad34a4afc
>Oct 13 12:56:55 erwin hald[7812]: 12:56:55.299 [I] device.c:1845: Removing locks from ':1.146'
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.728 [I] hald_dbus.c:5037: OK for method 'GetPower' with signature '' on interface 'org.freedesktop.Hal.Device.KillSwitch' for UDI '/org/freedesktop/Hal/devices/ipw_wlan_switch' and execpath 'hal-system-killswitch-get-power'
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.728 [I] hald_dbus.c:3938: no need to enqueue
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.737 [I] hald_dbus.c:5243: ***************************
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.737 [I] hald_dbus.c:5244: ********* got a connection 717460
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.737 [I] hald_dbus.c:5245: ***************************
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.738 [I] hald_dbus.c:5186: ************************
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.738 [I] hald_dbus.c:5187: Client to local_server was disconnected for 717460
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.738 [I] hald_dbus.c:5188: ************************
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.738 [I] hald_dbus.c:5229: ***************************
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.738 [I] hald_dbus.c:5230: ********* unregistered 717460
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.738 [I] hald_dbus.c:5231: ***************************
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.751 [I] device.c:1845: Removing locks from ':1.148'
>Oct 13 12:56:56 erwin hald[7812]: 12:56:56.753 [I] hald_dbus.c:3962: No more methods in queue
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.492 [I] hald_dbus.c:5037: OK for method 'GetPower' with signature '' on interface 'org.freedesktop.Hal.Device.KillSwitch' for UDI '/org/freedesktop/Hal/devices/ipw_wlan_switch' and execpath 'hal-system-killswitch-get-power'
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.492 [I] hald_dbus.c:3938: no need to enqueue
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.501 [I] hald_dbus.c:5243: ***************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.501 [I] hald_dbus.c:5244: ********* got a connection 717460
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.501 [I] hald_dbus.c:5245: ***************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.502 [I] hald_dbus.c:5186: ************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.502 [I] hald_dbus.c:5187: Client to local_server was disconnected for 717460
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.502 [I] hald_dbus.c:5188: ************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.502 [I] hald_dbus.c:5229: ***************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.502 [I] hald_dbus.c:5230: ********* unregistered 717460
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.503 [I] hald_dbus.c:5231: ***************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.515 [I] device.c:1845: Removing locks from ':1.149'
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.516 [I] hald_dbus.c:3962: No more methods in queue
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.549 [W] ci-tracker.c:366: Error doing GetSessionForUnixProcess on ConsoleKit: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.ConsoleKit was not provided by any .service files
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.549 [I] hald_dbus.c:5037: OK for method 'Setup' with signature 's' on interface 'org.freedesktop.Hal.Device.Volume.Crypto' for UDI '/org/freedesktop/Hal/devices/volume_uuid_80c0aab2_5de6_4884_a4c3_338ad34a4afc' and execpath 'hal-luks-setup'
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.549 [I] hald_dbus.c:3938: no need to enqueue
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.562 [W] ci-tracker.c:366: Error doing GetSessionForUnixProcess on ConsoleKit: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.ConsoleKit was not provided by any .service files
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.562 [I] access-check.c:72: uid for caller is 0
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.563 [I] ci-tracker.c:212: Removing CICallerInfo object for :1.150
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.563 [I] device.c:1845: Removing locks from ':1.150'
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.568 [W] ci-tracker.c:366: Error doing GetSessionForUnixProcess on ConsoleKit: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.ConsoleKit was not provided by any .service files
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.568 [I] access-check.c:72: uid for caller is 0
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.569 [I] ci-tracker.c:212: Removing CICallerInfo object for :1.151
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.569 [I] device.c:1845: Removing locks from ':1.151'
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.575 [I] device.c:1845: Removing locks from ':1.152'
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.577 [I] hald_dbus.c:5243: ***************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.577 [I] hald_dbus.c:5244: ********* got a connection 677030
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.578 [I] hald_dbus.c:5245: ***************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.579 [I] hald_dbus.c:5186: ************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.579 [I] hald_dbus.c:5187: Client to local_server was disconnected for 677030
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.579 [I] hald_dbus.c:5188: ************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.579 [I] hald_dbus.c:5229: ***************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.579 [I] hald_dbus.c:5230: ********* unregistered 677030
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.579 [I] hald_dbus.c:5231: ***************************
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.580 [I] hald_dbus.c:3962: No more methods in queue
>Oct 13 12:57:00 erwin hald[7812]: 12:57:00.580 [I] hald_dbus.c:4025: failed with 'org.freedesktop.Hal.Device.PermissionDeniedByPolicy' 'hal-storage-crypto-setup-removable no <-- (action, result)'

Actions: View

Attachments on bug 332057: 176929 | 177062 | 178260 | 178407