[linux-dvb] USB disconnects v4l-dvb for Nova T-500, worse now

Alain Brossard linux-dvb at alain.homeunix.org
Sun Sep 2 19:24:05 CEST 2007


Hi,

- Linux Ubuntu 07-04, kept up to date
- CPU0: AMD Athlon(tm) 64 X2 Dual Core Processor 4600+
- 2 Hauppage cards
     Hauppauge Nova-T 500 Dual DVB-T
     cx88[0]: subsystem: 0070:9402, board: Hauppauge WinTV-HVR1100 
DVB-T/Hybrid [card=40,autodetected]
     cx88[0]: hauppauge eeprom: model=94009
     input: cx88 IR (Hauppauge WinTV-HVR110 as /class/input/input3

  This issue is worse in the code I compiled yesterday vs the one I 
grabbed at the end of June. I haven't figured out where the version 
numbers are kept so...
     

In both versions of v4l-dvb, I eventually get in messages:

Sep  1 23:36:15 mytv kernel: [ 4856.480000] usb 3-1: *USB disconnect*, 
address 2
Sep  1 23:36:19 mytv kernel: [ 4860.024000] mt2060 I2C write failed

   At this point, MythTV's backend simply fails silently to record anything.
   Every time I get that USB disconnect, I need to restart the Mythtv 
back-end which seems to reload the T-500 drivers. I wrote a script which 
does this check every 5 seconds.
  Detailed output in messages from older v4l-dvb with my script 
auto-restarting MythTV back-end:

Aug 31 07:48:44 mytv kernel: [47205.284000] usb 5-1: USB disconnect, 
address 12
Aug 31 07:48:44 mytv kernel: [47205.288000] mt2060 I2C write failed
*aoû 31 07:48:45 mytv /etc/init.d/check_usb_failures: restarting backend*
Aug 31 07:48:46 mytv kernel: [47207.132000] mt2060 I2C write failed
Aug 31 07:48:46 mytv kernel: [47207.132000] dvb-usb: Hauppauge Nova-T 
500 Dual DVB-T successfully deinitialized and disconnected.
Aug 31 07:48:46 mytv kernel: [47207.372000] usb 5-1: new high speed USB 
device using ehci_hcd and address 13
Aug 31 07:48:46 mytv kernel: [47207.504000] usb 5-1: configuration #1 
chosen from 1 choice
Aug 31 07:48:46 mytv kernel: [47207.504000] dvb-usb: found a 'Hauppauge 
Nova-T 500 Dual DVB-T' in warm state.
Aug 31 07:48:46 mytv kernel: [47207.504000] dvb-usb: will pass the 
complete MPEG2 transport stream to the software demuxer.
Aug 31 07:48:46 mytv kernel: [47207.504000] DVB: registering new adapter 
(Hauppauge Nova-T 500 Dual DVB-T)
Aug 31 07:48:46 mytv kernel: [47207.596000] DVB: registering frontend 1 
(DiBcom 3000MC/P)...
Aug 31 07:48:46 mytv kernel: [47207.600000] MT2060: successfully 
identified (IF1 = 1220)
Aug 31 07:48:47 mytv kernel: [47208.068000] dvb-usb: will pass the 
complete MPEG2 transport stream to the software demuxer.
Aug 31 07:48:47 mytv kernel: [47208.068000] DVB: registering new adapter 
(Hauppauge Nova-T 500 Dual DVB-T)
Aug 31 07:48:47 mytv kernel: [47208.072000] DVB: registering frontend 2 
(DiBcom 3000MC/P)...
Aug 31 07:48:47 mytv kernel: [47208.076000] MT2060: successfully 
identified (IF1 = 1220)
Aug 31 07:48:47 mytv kernel: [47208.544000] dvb-usb: Hauppauge Nova-T 
500 Dual DVB-T successfully initialized and connected.


  In syslog:

Aug 31 07:48:44 mytv kernel: [47205.136000] dvb-usb: error while 
enabling fifo.
Aug 31 07:48:44 mytv kernel: [47205.284000] usb 5-1: USB disconnect, 
address 12
Aug 31 07:48:44 mytv kernel: [47205.284000] ehci_hcd 0000:04:09.2: qh 
dd8d0200 (#82) state 4(has tds)
Aug 31 07:48:44 mytv kernel: [47205.288000] mt2060 I2C write failed
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.045330] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_0').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.049714] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb').
Aug 31 07:48:46 mytv kernel: [47207.132000] mt2060 I2C write failed
Aug 31 07:48:46 mytv kernel: [47207.132000] dvb-usb: error while 
stopping stream.
Aug 31 07:48:46 mytv kernel: [47207.132000] dvb-usb: Hauppauge Nova-T 
500 Dual DVB-T successfully deinitialized and disconnected.
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.354513] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_6').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.355716] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_ffffffff_ffffffff_noserial').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.356417] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_2').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.359647] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_5').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.362601] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_4').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.363174] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_1').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.363592] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_3').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.363920] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.371960] 
nm_hal_device_removed (): Device removed (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_usbraw').
Aug 31 07:48:46 mytv kernel: [47207.372000] usb 5-1: new high speed USB 
device using ehci_hcd and address 13
Aug 31 07:48:46 mytv kernel: [47207.504000] usb 5-1: configuration #1 
chosen from 1 choice
Aug 31 07:48:46 mytv kernel: [47207.504000] dvb-usb: found a 'Hauppauge 
Nova-T 500 Dual DVB-T' in warm state.
Aug 31 07:48:46 mytv kernel: [47207.504000] dvb-usb: will pass the 
complete MPEG2 transport stream to the software demuxer.
Aug 31 07:48:46 mytv kernel: [47207.504000] DVB: registering new adapter 
(Hauppauge Nova-T 500 Dual DVB-T)
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.710481] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191').
Aug 31 07:48:46 mytv kernel: [47207.596000] DVB: registering frontend 1 
(DiBcom 3000MC/P)...
Aug 31 07:48:46 mytv kernel: [47207.600000] MT2060: successfully 
identified (IF1 = 1220)
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.950773] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_ffffffff_ffffffff_noserial').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.961102] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.963136] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_0').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.963775] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_1').
Aug 31 07:48:46 mytv NetworkManager: <debug info>^I[1188539326.964325] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_2').
Aug 31 07:48:47 mytv kernel: [47208.068000] dvb-usb: will pass the 
complete MPEG2 transport stream to the software demuxer.
Aug 31 07:48:47 mytv kernel: [47208.068000] DVB: registering new adapter 
(Hauppauge Nova-T 500 Dual DVB-T)
Aug 31 07:48:47 mytv kernel: [47208.072000] DVB: registering frontend 2 
(DiBcom 3000MC/P)...
Aug 31 07:48:47 mytv kernel: [47208.076000] MT2060: successfully 
identified (IF1 = 1220)
Aug 31 07:48:47 mytv NetworkManager: <debug info>^I[1188539327.288453] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_3').
Aug 31 07:48:47 mytv NetworkManager: <debug info>^I[1188539327.292504] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_4').
Aug 31 07:48:47 mytv NetworkManager: <debug info>^I[1188539327.294377] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_5').
Aug 31 07:48:47 mytv NetworkManager: <debug info>^I[1188539327.294988] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_dvb_6').
Aug 31 07:48:47 mytv kernel: [47208.544000] dvb-usb: Hauppauge Nova-T 
500 Dual DVB-T successfully initialized and connected.
Aug 31 07:48:47 mytv NetworkManager: <debug info>^I[1188539327.794307] 
nm_hal_device_added (): New device added (hal udi is 
'/org/freedesktop/Hal/devices/usb_device_2040_9950_4027349191_usbraw').

   Then everything works for a while. To give an idea of the scope of 
this problem:

Aug 30 20:17:26 mytv kernel: [ 5726.256000] usb 5-1: USB disconnect, 
address 2
Aug 30 21:31:17 mytv kernel: [10157.768000] usb 5-1: USB disconnect, 
address 3
Aug 30 22:48:28 mytv kernel: [14789.120000] usb 5-1: USB disconnect, 
address 4
Aug 30 23:15:21 mytv kernel: [16401.688000] usb 5-1: USB disconnect, 
address 5
Aug 31 00:27:19 mytv kernel: [20719.752000] usb 5-1: USB disconnect, 
address 6
Aug 31 02:15:30 mytv kernel: [27210.876000] usb 5-1: USB disconnect, 
address 7
Aug 31 03:15:59 mytv kernel: [30839.968000] usb 5-1: USB disconnect, 
address 8
Aug 31 04:22:56 mytv kernel: [34857.388000] usb 5-1: USB disconnect, 
address 9
Aug 31 04:39:51 mytv kernel: [35872.460000] usb 5-1: USB disconnect, 
address 10
Aug 31 07:26:51 mytv kernel: [45892.344000] usb 5-1: USB disconnect, 
address 11
Aug 31 07:48:44 mytv kernel: [47205.284000] usb 5-1: USB disconnect, 
address 12
Aug 31 10:45:52 mytv kernel: [57833.028000] usb 5-1: USB disconnect, 
address 13
Aug 31 11:03:52 mytv kernel: [58913.624000] usb 5-1: USB disconnect, 
address 14
Aug 31 12:40:53 mytv kernel: [64734.396000] usb 5-1: USB disconnect, 
address 15
Aug 31 12:57:49 mytv kernel: [65750.224000] usb 5-1: USB disconnect, 
address 16
Aug 31 14:08:49 mytv kernel: [70010.596000] usb 5-1: USB disconnect, 
address 17
Aug 31 15:25:10 mytv kernel: [74592.268000] usb 5-1: USB disconnect, 
address 18
Aug 31 16:12:07 mytv kernel: [77408.660000] usb 5-1: USB disconnect, 
address 19
Aug 31 16:35:22 mytv kernel: [78804.264000] usb 5-1: USB disconnect, 
address 20
Aug 31 18:57:25 mytv kernel: [87326.800000] usb 5-1: USB disconnect, 
address 21
Aug 31 20:42:40 mytv kernel: [ 4902.380000] usb 3-1: USB disconnect, 
address 2
Sep  1 11:06:47 mytv kernel: [  465.344000] usb 3-1: USB disconnect, 
address 2
Sep  1 12:01:57 mytv kernel: [ 3775.696000] usb 3-1: USB disconnect, 
address 3
Sep  1 12:29:30 mytv kernel: [ 5428.588000] usb 3-1: USB disconnect, 
address 4
Sep  1 14:03:09 mytv kernel: [11048.044000] usb 3-1: USB disconnect, 
address 5
Sep  1 15:06:18 mytv kernel: [14836.952000] usb 3-1: USB disconnect, 
address 6
Sep  1 17:10:45 mytv kernel: [ 2569.932000] usb 2-1: USB disconnect, 
address 2
Sep  1 20:14:11 mytv kernel: [ 9065.808000] usb 3-1: USB disconnect, 
address 2
Sep  1 20:26:41 mytv kernel: [    7.308000] usb 2-1: USB disconnect, 
address 2
Sep  1 21:21:23 mytv kernel: [ 3304.696000] usb 5-1: USB disconnect, 
address 2
Sep  1 21:33:38 mytv kernel: [ 4039.288000] usb 5-1: USB disconnect, 
address 3
Sep  1 22:11:34 mytv kernel: [ 1670.984000] usb 3-1: USB disconnect, 
address 2
Sep  1 22:14:46 mytv kernel: [ 1863.016000] usb 3-1: USB disconnect, 
address 3
Sep  1 23:36:15 mytv kernel: [ 4856.480000] usb 3-1: USB disconnect, 
address 2


   Well that was true until yesterday when I installed the latest 
v4l-dvb drivers. Now restarting the back end doesn't reload the drivers, 
instead I get an infinite number of  error msgs in syslog:

Sep  1 23:36:15 mytv kernel: [ 4856.480000] usb 3-1: USB disconnect, 
address 2
Sep  1 23:36:19 mytv kernel: [ 4859.900000] dvb-usb: error while 
stopping stream.
Sep  1 23:36:19 mytv kernel: [ 4860.024000] mt2060 I2C write failed
Sep  1 23:36:19 mytv kernel: [ 4860.304000] mt2060 I2C write failed
Sep  1 23:36:22 mytv kernel: [ 4863.832000] mt2060 I2C write failed
Sep  1 23:36:22 mytv kernel: [ 4863.844000] mt2060 I2C write failed (len=2)
Sep  1 23:36:22 mytv kernel: [ 4863.844000] mt2060 I2C write failed (len=6)
Sep  1 23:36:22 mytv kernel: [ 4863.844000] mt2060 I2C read failed
Sep  1 23:36:22 mytv kernel: [ 4863.852000] mt2060 I2C read failed
Sep  1 23:36:22 mytv kernel: [ 4863.860000] mt2060 I2C read failed
...


 Hence I'm going back to the old version, but I would prefer a fix or 
information on how I can help debugging this.

latest  linux/drivers/media/dvb/dvb-usb/dib0700_devices.c is copyright 2007
the one from June was copyright 2006. No human readable version number.

   After reverting, (keeping the new firmware however), restarting the 
MythTV backend reloads once more the T-500 drivers.

Alain
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://www.linuxtv.org/pipermail/linux-dvb/attachments/20070902/6679f29b/attachment-0001.htm 


More information about the linux-dvb mailing list