2.4.17-pre2 (and 6) The failed "Read CD" packet command was

[Alex Riesen]

Just seen the attached messages while playing a VCD
with xine(0.9.5). I dont know, maybe it's not good to 
play vcd, or not good to have a such cd-drive.
Could someone explain?
With linux kernel 2.4.17-pre6 it didn't produce the error
(but the stops while playing are still there). Maybe it's
just xine's problem? After all it has 8-9 threads...
xine output is attached.

vmstat reports unusual high number of context switches
(thread stop - start?)
(>1000 whereas usually 500-600) sometimes. And playback
pauses for ~1 sec. Not especially good.

first vmstat:
 0  0  0      0 342976   6460  54204   0   0     0     0  154   498   0   0 100
 0  0  0      0 342956   6460  54204   0   0     0     0  363   960  12   6  82
 1  0  0      0 342956   6460  54204   0   0     0     0  248   776   2   1  97
 0  0  0      0 342940   6460  54204   0   0     0     0  250   642   1   0  99
second one:
 1  0  0      0 342948   6460  54204   0   0     0     0  176   548   0   1  99
 1  0  0      0 342932   6460  54204   0   0     0     0  347   903  12   4  84
 0  0  0      0 342932   6460  54204   0   0     0     0  256   779   4   0  96
 0  0  0      0 342932   6460  54204   0   0     0     0  255   765   3   0  97
 0  0  0      0 342932   6460  54204   0   0     0     0  256   775   4   0  96

Dec  8 16:30:15 steel kernel:   The failed "Read CD" packet command was: 
Dec  8 16:30:15 steel kernel:   "be 00 00 05 69 f9 00 00 01 f8 00 00 " 
Dec  8 16:30:15 steel kernel: hdd: packet command error: status=0x51 { DriveReady SeekComplete Error } 
Dec  8 16:30:15 steel kernel: hdd: packet command error: error=0x54 
Dec  8 16:30:15 steel kernel: ATAPI device hdd: 
Dec  8 16:30:15 steel kernel:   Error: Illegal request -- (Sense key=0x05) 
Dec  8 16:30:15 steel kernel:   Invalid command operation code -- (asc=0x20, ascq=0x00) 
Dec  8 16:30:15 steel kernel:   The failed "<NULL>" packet command was: 
Dec  8 16:30:15 steel kernel:   "15 10 00 00 0c 00 00 00 00 00 00 00 " 
Dec  8 16:30:15 steel kernel:   Error in command packet byte 0 bit 0 

Linux steel 2.4.17-pre2 #12 Tue Dec 4 19:58:08 CET 2001 i686 unknown
PIII, compiled with PIII
ide-cdrom version 4.59
Model: CD-540E
/proc/ide/ide1/hdd/settings
name			value		min		max		mode
----			-----		---		---		----
breada_readahead        4               0               127             rw
current_speed           66              0               69              rw
dsc_overlap             0               0               1               rw
file_readahead          0               0               2097151         rw
ide_scsi                0               0               1               rw
init_speed              12              0               69              rw
io_32bit                1               0               3               rw
keepsettings            0               0               1               rw
max_kb_per_request      127             1               127             rw
nice1                   1               0               1               rw
number                  3               0               3               rw
pio_mode                write-only      0               255             w
slow                    0               0               1               rw
unmaskirq               1               0               1               rw
using_dma               1               0               1               rw

/proc/ide/via
----------VIA BusMastering IDE Configuration----------------
Driver Version:                     3.29
South Bridge:                       VIA vt82c686a
Revision:                           ISA 0x22 IDE 0x10
Highest DMA rate:                   UDMA66
BM-DMA base:                        0xd800
PCI clock:                          33MHz
Master Read  Cycle IRDY:            0ws
Master Write Cycle IRDY:            0ws
BM IDE Status Register Read Retry:  yes
Max DRDY Pulse Width:               No limit
-----------------------Primary IDE-------Secondary IDE------
Read DMA FIFO flush:          yes                 yes
End Sector FIFO flush:         no                  no
Prefetch Buffer:              yes                  no
Post Write Buffer:            yes                  no
Enabled:                      yes                 yes
Simplex only:                  no                  no
Cable Type:                   80w                 40w
-------------------drive0----drive1----drive2----drive3-----
Transfer Mode:       UDMA       PIO       PIO      UDMA
Address Setup:       30ns     120ns     120ns      30ns
Cmd Active:          90ns      90ns      90ns      90ns
Cmd Recovery:        30ns      30ns      30ns      30ns
Data Active:         90ns     330ns     330ns      90ns
Data Recovery:       30ns     270ns     270ns      30ns
Cycle Time:          30ns     600ns     600ns      60ns
Transfer Rate:   66.0MB/s   3.3MB/s   3.3MB/s  33.0MB/s

With 2.5.1-pre7 xine cannot play that cd - unexplainable error in 
"input_vcd : error in ioctl CDROMREADTOCHDR".

xine console:

audio_oss_out: audio rate : 44100 requested, 44100 provided by device/sec
audio_oss_out : 2 channels output
audio_out: output sample rate 44100
audio_out: thread created
metronom: audio pts discontinuity/start, pts is 92282282, last_pts is 92288143, wrap_offset = 64463
metronom: forcing video_wrap (58583) and audio wrap (64463) to 64463
200 frames delivered, 17 frames skipped, 9 frames discarded
200 frames delivered, 0 frames skipped, 0 frames discarded
...
200 frames delivered, 0 frames skipped, 0 frames discarded
audio_decoder: discontinuity ahead
audio_out: stopping thread...
audio_out: thread stopped, closing driver
video_decoder: discontinuity ahead
libmpeg2: blasting out backward reference frame on flush
metronom: video discontinuity
metronom: audio discontinuity
metronom: audio discontinuity => last_audio_pts=96485906, wrap_offset=64463, audio_vpts=96550369
metronom: video vpts adjusted to 96550369
metronom: video discontinuity => last_video_pts=96485906, wrap_offset=64463, video_vpts=96550369
metronom: video pts discontinuity, pts is 96500160, last_pts is 96485906, wrap_offset = 68209
200 frames delivered, 9 frames skipped, 4 frames discarded
audio_loop: using decoder >mad< 
libmad: audio sample rate 44100 mode 00000008
audio_oss_out: ao_open rate=44100, mode=8
audio_oss_out: audio rate : 44100 requested, 44100 provided by device/sec
audio_oss_out : 2 channels output
audio_out: output sample rate 44100
audio_out: thread created
metronom: audio pts discontinuity/start, pts is 96485906, last_pts is 96485906, wrap_offset = 64465
metronom: forcing video_wrap (68209) and audio wrap (64465)to 68209
200 frames delivered, 0 frames skipped, 0 frames discarded
200 frames delivered, 0 frames skipped, 0 frames discarded