[mythtv-users] hdpvr won't record through myth

Wed Apr 2 11:59:27 UTC 2014

Hoi Dave,

Wednesday, April 2, 2014, 2:07:57 AM, you wrote:

> Have 2 SBEs, each with a hdpvr attached.  One works, the other
> doesn't.  Trying to figure out what's wrong with the 2nd.  I can do
> a cat /dev/video0 > it.mpg and it works fine.  But the SBE
> recordings fail with poll timeout (full logs below).  After myth
> tries to use the device, cat fails until I rmmod/modprobe the driver again to get cat to work.

> Things I've tried/confirmed:

> - Same hdpvr firmware on both working and not working:   1.7.1

> - Disabled usb 3.0 in bios (per another thread)

> - Same kernel versions on both 3.10.7;  have now upgrade the non-working to 3.10.34
>  

> Running on gentoo v0.27-196-g3ca3f6d but I had this issue with .26 as well.

> SBE log:

> 2014-04-01 19:52:51.155450 I [27576/27596] TVRecEvent
> tv_rec.cpp:1050 (HandleStateChange) - TVRec[18]: Changing from None to RecordingOnly
>  2014-04-01 19:52:51.158623 I [27576/27596] TVRecEvent
> tv_rec.cpp:3602 (TuningCheckForHWChange) - TVRec[18]: HW Tuner: 18->18
> 2014-04-01 19:52:51.175295 I [27576/27596] TVRecEvent
> recorders/v4lchannel.cpp:558 (SetInputAndFormat) -
> V4LChannel[18](/dev/video0): SetInputAndFormat(17, NTSC) (v4l v2) input_switch: 0 mode_switch: 0
>  2014-04-01 19:52:51.189373 E [27576/27576] CoreContext
> programinfo.cpp:2358 (GetPlaybackURL) -
> ProgramInfo(2212_20140401235300.mpg): GetPlaybackURL:
> '2212_20140401235300.mpg' should be local, but it can not be found.
>  2014-04-01 19:52:51.291805 E [27576/27616] SignalMonitor
> recorders/analogsignalmonitor.cpp:85 (VerifyHDPVRaudio) -
> AnalogSigMon[18](/dev/video0): Audio desired 4, current 3 min 0 max 4
> 2014-04-01 19:52:51.303692 E [27576/27616] SignalMonitor
> recorders/analogsignalmonitor.cpp:95 (VerifyHDPVRaudio) -
> AnalogSigMon[18](/dev/video0): Changed audio encoding from 3 to 4.
>  2014-04-01 19:52:52.276099 E [27576/27613] ProcessRequest
> programinfo.cpp:2358 (GetPlaybackURL) -
> ProgramInfo(2212_20140401235300.mpg): GetPlaybackURL:
> '2212_20140401235300.mpg' should be local, but it can not be found.
>  2014-04-01 19:52:53.477138 I [27576/27596] TVRecEvent
> tv_rec.cpp:4126 (TuningNewRecorder) - TVRec[18]: rec->GetPathname():
> '/mnt/dawk/single1/media/tv/2212_20140401235300.mpg'
> 2014-04-01 19:52:56.084013 E [27576/27634] DeviceReadBuffer
> recorders/DeviceReadBuffer.cpp:543 (Poll) - DevRdB(/dev/video0): Poll giving up 2
>  2014-04-01 19:52:56.084077 E [27576/27633] RecThread
> recorders/mpegrecorder.cpp:1044 (run) - MPEGRec[18](/dev/video0): Device error detected
> 2014-04-01 19:52:58.979001 E [27576/27648] DeviceReadBuffer
> recorders/DeviceReadBuffer.cpp:543 (Poll) - DevRdB(/dev/video0): Poll giving up 2
>  

> Corresponding dmesg hdpvr output with hdpvr_debug=7:
> Apr  1 19:52:49 dawkins kernel: [ 6269.533503] hdpvr 1-4:1.0:
> config call request for value 0x1700 returned 1
> Apr  1 19:52:49 dawkins kernel: [ 6269.559360] hdpvr 1-4:1.0:
> config call request for value 0x2b00 returned 1
>  Apr  1 19:52:49 dawkins kernel: [ 6269.612746] Loading kernel
> module for a network device with CAP_SYS_MODULE (deprecated).  Use
> CAP_NET_ADMIN and alias netdev- instead.
> Apr  1 19:52:49 dawkins kernel: [ 6269.642159] Loading kernel
> module for a network device with CAP_SYS_MODULE (deprecated).  Use
> CAP_NET_ADMIN and alias netdev- instead.
>  Apr  1 19:52:53 dawkins kernel: [ 6273.396497] hdpvr 1-4:1.0:
> config call request for value 0x1200 returned 1
> Apr  1 19:52:53 dawkins kernel: [ 6273.460328] hdpvr 1-4:1.0: video signal: 1920x1080 at 30hz
> Apr  1 19:52:53 dawkins kernel: [ 6273.464707] hdpvr 1-4:1.0:
> encoder start control request returned 0
>  Apr  1 19:52:53 dawkins kernel: [ 6273.480449] hdpvr 1-4:1.0:
> config call request for value 0x700 returned 1
> Apr  1 19:52:53 dawkins kernel: [ 6273.480466] hdpvr 1-4:1.0: streaming started
> Apr  1 19:52:53 dawkins kernel: [ 6273.480501] hdpvr 1-4:1.0:
> hdpvr_submit_buffers:227 buffer stat: 0 free, 64 proc
>  Apr  1 19:52:56 dawkins kernel: [ 6275.990261] hdpvr 1-4:1.0:
> config call request for value 0x800 returned 1
> Apr  1 19:52:56 dawkins kernel: [ 6275.990273] hdpvr 1-4:1.0: transmit worker exited
> Apr  1 19:52:56 dawkins kernel: [ 6276.316931] usb 1-4: RecThread timed out on ep1in len=0/8192
>  Apr  1 19:52:56 dawkins kernel: [ 6276.316944] hdpvr 1-4:1.0: used 0 urbs to empty device buffers
> Apr  1 19:52:56 dawkins kernel: [ 6276.351945] hdpvr 1-4:1.0: video signal: 1920x1080 at 30hz
> Apr  1 19:52:56 dawkins kernel: [ 6276.356363] hdpvr 1-4:1.0:
> encoder start control request returned 0
>  Apr  1 19:52:56 dawkins kernel: [ 6276.373055] hdpvr 1-4:1.0:
> config call request for value 0x700 returned 1
> Apr  1 19:52:56 dawkins kernel: [ 6276.373072] hdpvr 1-4:1.0: streaming started
> Apr  1 19:52:56 dawkins kernel: [ 6276.373113] hdpvr 1-4:1.0:
> hdpvr_submit_buffers:227 buffer stat: 0 free, 64 proc
>  Apr  1 19:52:58 dawkins kernel: [ 6278.882950] hdpvr 1-4:1.0:
> config call request for value 0x800 returned 1
> Apr  1 19:52:58 dawkins kernel: [ 6278.882961] hdpvr 1-4:1.0: transmit worker exited
> Apr  1 19:52:59 dawkins kernel: [ 6279.211989] usb 1-4: RecThread timed out on ep1in len=0/8192
>  

> I'm totally stumped at this point. Thanks in advance
> Dave

Try switching the HDPVR s between the machines. If the malfunction
follows the HDPVR, you know the problem is in there. If it stays with
the machine...
If the machines are similar you then could try copying your
configuration.
In the log it says it cannot find the recording file, so you could
take a look at your storage groups. Might it be trying to record to
storage on the other machine, you haven't made accessible through nfs?

Tot mails,
  Hika                            mailto:hikavdh at gmail.com

"Zonder hoop kun je niet leven
Zonder leven is er geen hoop
Het eeuwige dilemma
Zeker als je hoop moet vernietigen om te kunnen overleven!"

De lerende Mens
--