OK, I enabled debug output in the sound driver in the hopes of finding out a little bit more about what's going on with these insufferable pcm timeouts using the snd_ich driver. The following log info starts shortly before the timeout occurred during the last "successful" run of madplay (i.e., the one that was running when the timeout occurred), and includes a little bit of the next run of madplay as well (which I interrupted with CTRL-C just after it began). Hopefully there's something here (the flags and/or buffer sizes in chn_flush?) that may offer a clue to someone more intimately familiar with the workings of the sound drivers. Perhaps we need to add even more debugging statements? I really want to get this thing debugged, folks! The several-times-a-day reboots just to get sound going again are really getting tiresome. Aug 18 19:02:36 dolphin kernel: chn_setblocksize(0, 0) Aug 18 19:02:36 dolphin kernel: chn_setblocksize: defaulting to(512,256) Aug 18 19:02:36 dolphin kernel: chn_setblocksize: soft bps 2, spd 8000, irqhz == 62 Aug 18 19:02:36 dolphin kernel: chn_setblocksize: hard blksz requested 512 (maxsize 16384), got 512, irqhz == 62 Aug 18 19:02:36 dolphin kernel: setspeed done, r = 0 Aug 18 19:02:36 dolphin kernel: want format 268435472 Aug 18 19:02:36 dolphin kernel: feederflags 0 Aug 18 19:02:36 dolphin kernel: setspeed, channel pcm0:play:0 Aug 18 19:02:36 dolphin kernel: want speed 8000, try speed 8000, got speed 8000 Aug 18 19:02:36 dolphin kernel: feederflags 0 Aug 18 19:02:36 dolphin kernel: r = 0 Aug 18 19:02:36 dolphin kernel: chn_setblocksize(0, 0) Aug 18 19:02:36 dolphin kernel: chn_setblocksize: defaulting to (256,512) Aug 18 19:02:36 dolphin kernel: chn_setblocksize: soft bps 4, spd 8000, irqhz == 62 Aug 18 19:02:36 dolphin kernel: chn_setblocksize: hard blksz requested 512 (maxsize 16384), got 512, irqhz == 62 Aug 18 19:02:36 dolphin kernel: setspeed done, r = 0 Aug 18 19:02:36 dolphin kernel: setspeed, channel pcm0:play:0 Aug 18 19:02:36 dolphin kernel: want speed 44100, try speed 44100, got speed 44100 Aug 18 19:02:36 dolphin kernel: feederflags 0 Aug 18 19:02:36 dolphin kernel: r = 0 Aug 18 19:02:36 dolphin kernel: chn_setblocksize(0, 0) Aug 18 19:02:36 dolphin kernel: chn_setblocksize: defaulting to (32,4096) Aug 18 19:02:36 dolphin kernel: chn_setblocksize: soft bps 4, spd 44100, irqhz == 43 Aug 18 19:02:36 dolphin kernel: chn_setblocksize: hard blksz requested 4096 (maxsize 16384), got 4096, irqhz == 43 Aug 18 19:02:36 dolphin kernel: setspeed done, r = 0 Aug 18 19:02:37 dolphin kernel: pcm0:play:0: play interrupt timeout, channel dead Aug 18 19:02:37 dolphin kernel: chn_flush: c->flags 0x00021030 Aug 18 19:02:38 dolphin kernel: chn_flush: timeout, hw 16384, sw 131072 Aug 18 19:02:38 dolphin kernel: chn_setblocksize(0, 0) Aug 18 19:02:38 dolphin kernel: chn_setblocksize: defaulting to (32, 4096) Aug 18 19:02:38 dolphin kernel: chn_setblocksize: soft bps 4, spd 44100, irqhz == 43 Aug 18 19:02:38 dolphin kernel: chn_setblocksize: hard blksz requested 4096 (maxsize 16384), got 4096, irqhz == 43 -- Conrad J. Sabatier <conrads_at_cox.net> -- "In Unix veritas"Received on Wed Aug 18 2004 - 22:25:22 UTC
This archive was generated by hypermail 2.4.0 : Wed May 19 2021 - 11:38:07 UTC