Gentoo Forums
Gentoo Forums
Gentoo Forums
Quick Search: in
hal & scsi audio cd's
View unanswered posts
View posts from last 24 hours

 
Reply to topic    Gentoo Forums Forum Index Kernel & Hardware
View previous topic :: View next topic  
Author Message
SandStar
Tux's lil' helper
Tux's lil' helper


Joined: 24 Jan 2005
Posts: 77

PostPosted: Mon Jul 20, 2009 5:24 pm    Post subject: hal & scsi audio cd's Reply with quote

I'm having a problem with a scsi cdrom tower.
The tower hosts 7 Pioneer scsi cdroms and is connected via scsi cable to a Adeptec AIC-7892A.

When I insert a data cd all is fine. Hal automounts it and KDE asks me what I want with it.
However, when I insert an audio cd hal seems to automount it, then decides it doesn't like and unmounts it after which it tries to automount it again. Creating a loop.

My dmesg logs are filled with this:
Code:

scsi0: Issued Channel A Bus Reset. 4 SCBs aborted
sr0: CDROM not ready.  Make sure there is a disc in the drive.
sr0: CDROM not ready.  Make sure there is a disc in the drive.
sr0: CDROM not ready.  Make sure there is a disc in the drive.
(scsi0:A:3:0): No or incomplete CDB sent to device.
scsi0: Issued Channel A Bus Reset. 1 SCBs aborted
sr3: CDROM not ready.  Make sure there is a disc in the drive.
sr3: CDROM not ready.  Make sure there is a disc in the drive.
(scsi0:A:5:0): No or incomplete CDB sent to device.
scsi0: Issued Channel A Bus Reset. 1 SCBs aborted
sr5: CDROM not ready.  Make sure there is a disc in the drive.
sr5: CDROM not ready.  Make sure there is a disc in the drive.


I've managed to stop hal before it decided to unmount a few cd's and the ones that are currently mounted play absolute fine with any audio software.
So the problem (I think) lies in the way hal responds to audio cd's on scsi. I've got another dvd-drive on sata that is handled perfectly fine by hal.

any suggestions to fix this?

further info:
Code:

05:02.0 SCSI storage controller: Adaptec AIC-7892A U160/m (rev 02)

Code:

ACPI: PCI Interrupt 0000:05:02.0[A] -> GSI 18 (level, low) -> IRQ 18
scsi0 : Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA DRIVER, Rev 7.0
        <Adaptec 29160 Ultra160 SCSI adapter>
        aic7892: Ultra160 Wide Channel A, SCSI Id=7, 32/253 SCBs

scsi 0:0:0:0: CD-ROM            PIONEER  CD-ROM DR-U16S   1.01 PQ: 0 ANSI: 2
 target0:0:0: Beginning Domain Validation
 target0:0:0: FAST-20 SCSI 20.0 MB/s ST (50 ns, offset 16)
 target0:0:0: Domain Validation detected failure, dropping back
 target0:0:0: FAST-10 SCSI 10.0 MB/s ST (100 ns, offset 16)
 target0:0:0: Domain Validation skipping write tests
 target0:0:0: Ending Domain Validation
scsi 0:0:1:0: CD-ROM            PIONEER  CD-ROM DR-U16S   1.01 PQ: 0 ANSI: 2
 target0:0:1: Beginning Domain Validation
 target0:0:1: FAST-20 SCSI 20.0 MB/s ST (50 ns, offset 16)
 target0:0:1: Domain Validation skipping write tests
 target0:0:1: Ending Domain Validation
scsi 0:0:2:0: CD-ROM            PIONEER  CD-ROM DR-U16S   1.01 PQ: 0 ANSI: 2
 target0:0:2: Beginning Domain Validation
 target0:0:2: FAST-20 SCSI 20.0 MB/s ST (50 ns, offset 16)
 target0:0:2: Domain Validation skipping write tests
 target0:0:2: Ending Domain Validation
Back to top
View user's profile Send private message
SandStar
Tux's lil' helper
Tux's lil' helper


Joined: 24 Jan 2005
Posts: 77

PostPosted: Tue Jul 21, 2009 4:55 pm    Post subject: Reply with quote

I've been going trough the working of hal and am very slowly beginning to understand how it works. Still can't figure out where the problem lies exactly but here's a log from hald:

Code:

18:51:38.038 [I] osspec.c:241: SEQNUM=3374, ACTION=change, SUBSYSTEM=scsi, DEVPATH=/sys/devices/pci0000:00/0000:00:1e.0/0000:05:02.0/host0/target0:0:0/0:0:0:0, DEVNAME=, IFINDEX=0
18:51:38.038 [I] hotplug.c:114: /sys/devices/pci0000:00/0000:00:1e.0/0000:05:02.0/host0/target0:0:0/0:0:0:0 is a device (store)
18:51:38.038 [I] device.c:4531: refresh_dev: subsys=scsi
[11611]: 18:51:38.039 [D] addon-storage.c:542: Media insertion detected on /dev/sr0
18:51:38.039 [D] hald_dbus.c:1652: udi=/org/freedesktop/Hal/devices/storage_model_CD_ROM_DR_U16S, key=storage.removable.media_available
18:51:38.039 [I] hald_dbus.c:3052: entering, local_interface=1
18:51:38.039 [D] hald_dbus.c:3061: udi=/org/freedesktop/Hal/devices/storage_model_CD_ROM_DR_U16S
18:51:38.039 [I] blockdev.c:1666: blockdev_rescan_device: udi=/org/freedesktop/Hal/devices/storage_model_CD_ROM_DR_U16S
Run started hald-probe-storage (10000) (0)
!  full path is '/usr/libexec/hald-probe-storage', program_dir is '/usr/libexec'
woohoo
[13740]: 18:51:38.041 [D] probe-storage.c:155: Doing probe-storage for /dev/sr0 (bus scsi) (drive_type cdrom) (udi=/org/freedesktop/Hal/devices/storage_model_CD_ROM_DR_U16S) (--only-check-for-fs==1)
[13740]: 18:51:38.041 [D] probe-storage.c:163: Doing open ("/dev/sr0", O_RDONLY | O_NONBLOCK)
[13740]: 18:51:38.041 [D] probe-storage.c:169: Returned from open(2)
[13740]: 18:51:38.043 [D] probe-storage.c:310: Checking for optical disc on /dev/sr0
[13740]: 18:51:38.043 [D] probe-storage.c:318: Doing open ("/dev/sr0", O_RDONLY | O_NONBLOCK | O_EXCL)
[13740]: 18:51:38.043 [D] probe-storage.c:348: PROBE HAS EXCLUSIVE LOCK ON CDROM
[13740]: 18:51:38.044 [D] probe-storage.c:390: media size = 720285696
[13740]: 18:51:38.044 [D] probe-storage.c:398: PROBE CLOSED LOCK ON CDROM
18:51:38.044 [I] hald_dbus.c:1342: storage.cdrom.read_speed -> 5644
18:51:38.044 [I] hald_dbus.c:1342: storage.cdrom.write_speed -> 0
18:51:38.044 [I] hald_dbus.c:1366: storage.removable.media_available -> True
18:51:38.044 [I] hald_dbus.c:1350: storage.removable.media_size -> 720285696
pid 13740: rc=2 signaled=0: /usr/libexec/hald-probe-storage
18:51:38.045 [I] blockdev.c:1622: hald-probe-storage --only-check-for-media returned 2 (exit_type=0)
18:51:38.045 [I] blockdev.c:1638: Media insertion detected with file system on main block device; synthesizing hotplug add
18:51:38.045 [I] osspec.c:966: hal_util_find_known_parent: '/sys/block/sr0/fakevolume'->'/sys/block/sr0'
18:51:38.045 [I] blockdev.c:874: block_add: sysfs_path=/sys/block/sr0/fakevolume dev=/dev/sr0 is_part=0, parent=0x0066f960
18:51:38.045 [I] blockdev.c:882: Handling /dev/sr0 as fakevolume - sysfs_path_real=(null)
Run started hald-probe-volume (10000) (0)
!  full path is '/usr/libexec/hald-probe-volume', program_dir is '/usr/libexec'
[13741]: 18:51:38.047 [D] probe-volume.c:377: Doing probe-volume for /dev/sr0

[13741]: 18:51:38.060 [D] probe-volume.c:388: volume.block_size = 2048
[13741]: 18:51:38.060 [D] probe-volume.c:392: volume.size = 720285696
[13741]: 18:51:38.075 [D] probe-volume.c:423: Disc in /dev/sr0 has audio
Could not fully determine drive profile 0: Error reading disc information
[13741]: 18:51:38.079 [D] probe-volume.c:469: get_disc_type returned 0xffffffff
[13741]: 18:51:38.083 [D] probe-volume.c:574: volume_session_count = 21
18:51:38.084 [I] hald_dbus.c:1342: volume.block_size -> 2048
18:51:38.084 [I] hald_dbus.c:1350: volume.size -> 720285696
18:51:38.084 [I] hald_dbus.c:1334: volume.disc.type -> unknown
18:51:38.084 [I] hald_dbus.c:1366: volume.disc.has_audio -> False
18:51:38.084 [I] hald_dbus.c:1366: volume.disc.has_data -> False
18:51:38.084 [I] hald_dbus.c:1366: volume.disc.is_blank -> False
18:51:38.084 [I] hald_dbus.c:1366: volume.disc.is_appendable -> False
18:51:38.084 [I] hald_dbus.c:1366: volume.disc.is_rewritable -> False
18:51:38.084 [I] hald_dbus.c:1366: volume.disc.has_audio -> True
pid 13741: rc=0 signaled=0: /usr/libexec/hald-probe-volume
18:51:38.084 [I] blockdev.c:387: entering; exit_type=0, return_code=0
18:51:38.087 [I] blockdev.c:141: Add callouts completed udi=/org/freedesktop/Hal/devices/volume_part_1_size_720285696
18:51:38.087 [D] device_store.c:516: adding 0x6d64a0 to (linux.sysfs_path,/sys/block/sr0/fakevolume)
18:51:38.087 [I] hald.c:108: Added device to GDL; udi=/org/freedesktop/Hal/devices/volume_part_1_size_720285696
18:51:38.798 [I] osspec.c:241: SEQNUM=3375, ACTION=remove, SUBSYSTEM=uids, DEVPATH=/sys/kernel/uids/22, DEVNAME=, IFINDEX=0
18:51:38.798 [I] device.c:4485: remove_dev: subsys=uids sysfs_path=/sys/kernel/uids/22
18:51:38.798 [W] device.c:4489: Error removing device
[11617]: 18:51:39.002 [I] addon-storage.c:355: Checking whether device /dev/sr3 is locked on HAL
[11613]: 18:51:39.003 [I] addon-storage.c:355: Checking whether device /dev/sr1 is locked on HAL
[11615]: 18:51:39.003 [I] addon-storage.c:355: Checking whether device /dev/sr2 is locked on HAL
[11617]: 18:51:39.003 [I] addon-storage.c:363: ... device /dev/sr3 is not locked on HAL
[11615]: 18:51:39.003 [I] addon-storage.c:363: ... device /dev/sr2 is not locked on HAL
[11613]: 18:51:39.003 [I] addon-storage.c:363: ... device /dev/sr1 is not locked on HAL
18:51:39.516 [I] osspec.c:241: SEQNUM=3376, ACTION=add, SUBSYSTEM=uids, DEVPATH=/sys/kernel/uids/22, DEVNAME=, IFINDEX=0
18:51:39.517 [I] device.c:4415: add_dev: subsys=uids sysfs_path=/sys/kernel/uids/22 dev= parent_dev=0x00000000
[11621]: 18:51:40.005 [I] addon-storage.c:355: Checking whether device /dev/sr5 is locked on HAL
[11621]: 18:51:40.005 [I] addon-storage.c:363: ... device /dev/sr5 is not locked on HAL
[11619]: 18:51:40.006 [I] addon-storage.c:355: Checking whether device /dev/sr4 is locked on HAL
[11619]: 18:51:40.006 [I] addon-storage.c:363: ... device /dev/sr4 is not locked on HAL
[11625]: 18:51:40.006 [I] addon-storage.c:355: Checking whether device /dev/sr7 is locked on HAL
[11625]: 18:51:40.006 [I] addon-storage.c:363: ... device /dev/sr7 is not locked on HAL
[11611]: 18:51:40.006 [I] addon-storage.c:355: Checking whether device /dev/sr0 is locked on HAL
[11611]: 18:51:40.006 [I] addon-storage.c:363: ... device /dev/sr0 is not locked on HAL
[11623]: 18:51:40.007 [I] addon-storage.c:355: Checking whether device /dev/sr6 is locked on HAL
[11623]: 18:51:40.007 [I] addon-storage.c:363: ... device /dev/sr6 is not locked on HAL
18:51:41.858 [I] osspec.c:241: SEQNUM=3377, ACTION=remove, SUBSYSTEM=uids, DEVPATH=/sys/kernel/uids/22, DEVNAME=, IFINDEX=0
18:51:41.858 [I] device.c:4485: remove_dev: subsys=uids sysfs_path=/sys/kernel/uids/22
18:51:41.858 [W] device.c:4489: Error removing device


The last 3 lines are repeated every second with "SEQNUM" increasing in value by 1.

This machine is a dual boot with Vista (seperate hd) and it's playing audio cd's in Vista just fine.
Back to top
View user's profile Send private message
SandStar
Tux's lil' helper
Tux's lil' helper


Joined: 24 Jan 2005
Posts: 77

PostPosted: Fri Jul 24, 2009 12:07 pm    Post subject: Reply with quote

small bump.

Problem not yet resolved. I've googled for hours, finding a few people with the same problem and a minority had it fixed after kernel 2.6.17.
I'm running 2.6.25-r7... Updating the kernel is a bit of a bitch since vmware server doesn't like all kernels...
Back to top
View user's profile Send private message
Display posts from previous:   
Reply to topic    Gentoo Forums Forum Index Kernel & Hardware All times are GMT
Page 1 of 1

 
Jump to:  
You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum
You cannot vote in polls in this forum