[mythtv-users] HDHR recordings failing after 0.25 upgrade

Tue Apr 24 12:09:14 UTC 2012

I had what sound like similar HDHR problems on a recent upgrade to 0.24.
I've got the HDHR connected to my backend direct to a dedicated
network card and I need to run an ifup/ifdown on that card after boot
and after mythtv starts to get it to tune and record. Probably a
better fix somewhere but I've just added ipfup and ifdown and a few
seconds wait time to rc.local.

On Tue, Apr 24, 2012 at 12:11 PM, Anthony Giggins
<seven at seven.dorksville.net> wrote:
> HDHR recordings failing after 0.25 upgrade, normally results in very
> undersize recordings from 700KB to 3or4 MB
>
> I did do a rescan on the existing transports after the upgrade and but I
> haven't updated the firmware on the hdhr for some time as I haven't had any
> problems, unrelated I'm also not getting airplay, have followed the
> instructions from the wiki, I'm guessing support was not compiled in the
> packages?
>
> $ mythbackend --version
> Please attach all output as a file in bug reports.
> MythTV Version : 0.25-2.md12 (40f3bae)
> MythTV Branch :
> Network Protocol : 72
> Library API : 0.25.20120408-1
> QT Version : 4.7.2
> Options compiled in:
>  linux release use_hidesyms using_alsa using_jack using_oss using_pulse
> using_pulseoutput using_backend using_bindings_perl using_bindings_python
> using_bindings_php using_dvb using_firewire using_frontend using_hdhomerun
> using_ceton using_hdpvr using_iptv using_ivtv using_joystick_menu
> using_libcrypto using_libfftw3 using_libxml2 using_libudf using_lirc
> using_mheg using_opengl_video using_qtwebkit using_qtscript using_qtdbus
> using_v4l2 using_v4l1 using_x11 using_xrandr using_xv using_bindings_perl
> using_bindings_python using_bindings_php using_mythtranscode using_opengl
> using_vaapi using_vdpau using_ffmpeg_threads using_live using_mheg
> using_libxml2 using_libudf
>
> $ mythfrontend --version
> Please attach all output as a file in bug reports.
> MythTV Version : 0.25-2.md12 (40f3bae)
> MythTV Branch :
> Network Protocol : 72
> Library API : 0.25.20120408-1
> QT Version : 4.7.2
> Options compiled in:
>  linux release use_hidesyms using_alsa using_jack using_oss using_pulse
> using_pulseoutput using_backend using_bindings_perl using_bindings_python
> using_bindings_php using_dvb using_firewire using_frontend using_hdhomerun
> using_ceton using_hdpvr using_iptv using_ivtv using_joystick_menu
> using_libcrypto using_libfftw3 using_libxml2 using_libudf using_lirc
> using_mheg using_opengl_video using_qtwebkit using_qtscript using_qtdbus
> using_v4l2 using_v4l1 using_x11 using_xrandr using_xv using_bindings_perl
> using_bindings_python using_bindings_php using_mythtranscode using_opengl
> using_vaapi using_vdpau using_ffmpeg_threads using_live using_mheg
> using_libxml2 using_libudf
>
> 2012-04-24 10:41:01.761099 I [30162/30191] Scheduler scheduler.cpp:2460
> (HandleRecordingStatusChange) - Tuning recording: "Little Princess":"I Don't
> Want Help": channel 4022 on cardid 7, sourceid 4
> 2012-04-24 10:41:02.537089 I [30162/30162] CoreContext scheduler.cpp:635
> (UpdateRecStatus) - Updating status for "Little Princess":"I Don't Want
> Help" on cardid 7 (Tuning => Recording)
> 2012-04-24 10:41:02.598068 I [30162/30173] TVRecEvent tv_rec.cpp:3950
> (TuningNewRecorder) - TVRec(7): rec->GetPathname():
> '/storage3/recordings/4022_20120424104100.mpg'
> 2012-04-24 10:41:02.598183 E [30162/30173] TVRecEvent recorderbase.cpp:164
> (SetStrOption) - RecBase(7:12108F0E-0): SetStrOption(...recordingtype):
> Option not in profile.
> 2012-04-24 10:41:38.707665 I [30162/6131] Metadata_10607 jobqueue.cpp:2150
> (DoMetadataLookupThread) - JobQueue: Metadata Lookup Starting for "Little
> Princess":"I Don't Want Help" recorded from channel 4022 at
> 2012-04-24T10:41:00
> 2012-04-24 10:41:39.160196 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Monitor
> 2012-04-24 10:41:39.160202 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 0)
> 2012-04-24 10:41:39.160490 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Monitor
> 2012-04-24 10:41:39.160500 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 1)
> 2012-04-24 10:41:41.886040 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Playback
> 2012-04-24 10:41:41.886046 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 0)
> 2012-04-24 10:41:41.886247 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Monitor
> 2012-04-24 10:41:41.886257 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 1)
> 2012-04-24 10:41:41.908172 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Playback
> 2012-04-24 10:41:41.908178 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 0)
> 2012-04-24 10:41:41.908327 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 10:44:30.764057 N [30162/30193] Expire autoexpire.cpp:263
> (CalcParams) - AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
> w/freq: 7 min
> 2012-04-24 10:45:33.940870 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 10:50:36.941972 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 10:51:30.767432 N [30162/30193] Expire autoexpire.cpp:263
> (CalcParams) - AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
> w/freq: 7 min
> 2012-04-24 10:55:39.943269 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 10:55:55.796054 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:55:55.796328 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:55:55.796573 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:55:55.796794 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:55:55.797006 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:55:58.142605 I [30162/7106] ProcessRequest
> recorderbase.cpp:386 (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:55:58.142973 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:55:58.143210 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:55:58.143434 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:55:58.143717 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(9:12108F0E-1):
> GetKeyframePositions(102,9223372036854775807,#0) out of 8
> 2012-04-24 10:56:10.535813 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Monitor
> 2012-04-24 10:56:10.535819 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 0)
> 2012-04-24 10:56:10.536042 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Monitor
> 2012-04-24 10:56:10.536051 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 1)
> 2012-04-24 10:58:30.770721 N [30162/30193] Expire autoexpire.cpp:263
> (CalcParams) - AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
> w/freq: 7 min
> 2012-04-24 11:00:43.944519 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 11:05:30.774245 N [30162/30193] Expire autoexpire.cpp:263
> (CalcParams) - AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
> w/freq: 7 min
> 2012-04-24 11:05:45.945572 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 11:10:46.946999 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 11:11:54.763374 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.763564 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.763729 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.763942 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.764150 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.764329 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.764531 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.764727 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.764935 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.765214 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.765440 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.765663 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:11:54.765884 I [30162] ProcessRequest recorderbase.cpp:386
> (GetKeyframePositions) - RecBase(7:12108F0E-0):
> GetKeyframePositions(13,9223372036854775807,#0) out of 2
> 2012-04-24 11:12:07.405311 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Monitor
> 2012-04-24 11:12:07.405318 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 0)
> 2012-04-24 11:12:07.405541 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Monitor
> 2012-04-24 11:12:07.405547 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 1)
> 2012-04-24 11:12:30.778991 N [30162/30193] Expire autoexpire.cpp:263
> (CalcParams) - AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
> w/freq: 7 min
> 2012-04-24 11:15:47.948110 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 11:16:12.824193 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Monitor
> 2012-04-24 11:16:12.824213 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 0)
> 2012-04-24 11:16:12.824398 I [30162] ProcessRequest mainserver.cpp:1360
> (HandleAnnounce) - MainServer::ANN Monitor
> 2012-04-24 11:16:12.824403 I [30162] ProcessRequest mainserver.cpp:1362
> (HandleAnnounce) - adding: mythtv.seven.lan as a client (events: 1)
> 2012-04-24 11:16:12.824865 I [30162/30191] Scheduler scheduler.cpp:2011
> (HandleReschedule) - Reschedule requested for id -1.
> 2012-04-24 11:16:13.681198 I [30162/30191] Scheduler scheduler.cpp:2069
> (HandleReschedule) - Scheduled 131 items in 0.9 = 0.01 match + 0.84 place
> 2012-04-24 11:19:30.782494 N [30162/30193] Expire autoexpire.cpp:263
> (CalcParams) - AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
> w/freq: 7 min
> 2012-04-24 11:20:49.949176 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 11:25:52.951751 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 11:26:30.787766 N [30162/30193] Expire autoexpire.cpp:263
> (CalcParams) - AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
> w/freq: 7 min
> 2012-04-24 11:30:00.051256 I [30162/30177] TVRecEvent tv_rec.cpp:1014
> (HandleStateChange) - TVRec(9): Changing from RecordingOnly to None
> 2012-04-24 11:30:00.178256 I [30162/30177] TVRecEvent tv_rec.cpp:812
> (FinishedRecording) - TVRec(9): FinishedRecording(4032_2012-04-24T10:35:00)
> damaged recq:
>
> 2012-04-24 11:30:00.179209 I [30162/30162] CoreContext scheduler.cpp:635
> (UpdateRecStatus) - Updating status for "Japanese News" on cardid 9
> (Recording => Recorded)
> 2012-04-24 11:30:00.179317 I [30162/30200] PreviewGeneratorQueue
> mythdbcon.cpp:395 (PurgeIdleConnections) - New DB connection, total: 12
> 2012-04-24 11:30:00.179814 I [30162/30191] Scheduler scheduler.cpp:2011
> (HandleReschedule) - Reschedule requested for id 0.
> 2012-04-24 11:30:00.181334 E [30162/30162] CoreContext mainserver.cpp:871
> (customEvent) - MainServer: PREVIEW_SUCCESS but no receivers.
> 2012-04-24 11:30:00.911590 I [30162/30191] Scheduler scheduler.cpp:2069
> (HandleReschedule) - Scheduled 130 items in 0.7 = 0.00 match + 0.73 place
> 2012-04-24 11:30:53.953133 I [30162/30192] HouseKeeping housekeeper.cpp:225
> (RunHouseKeeping) - Running housekeeping thread
> 2012-04-24 11:32:27.629398 I [30162/30198] SSDP mythdbcon.cpp:395
> (PurgeIdleConnections) - New DB connection, total: 13
> 2012-04-24 11:33:00.077290 I [30162/30173] TVRecEvent tv_rec.cpp:1014
> (HandleStateChange) - TVRec(7): Changing from RecordingOnly to None
> 2012-04-24 11:33:00.101108 I [30162/30173] TVRecEvent tv_rec.cpp:812
> (FinishedRecording) - TVRec(7): FinishedRecording(4022_2012-04-24T10:41:00)
> damaged recq:
>
> 2012-04-24 11:33:00.102047 I [30162/30162] CoreContext scheduler.cpp:635
> (UpdateRecStatus) - Updating status for "Little Princess":"I Don't Want
> Help" on cardid 7 (Recording => Recorded)
> 2012-04-24 11:33:00.102668 I [30162/30191] Scheduler scheduler.cpp:2011
> (HandleReschedule) - Reschedule requested for id 0.
>
>
> Cheers,
>
>
> Anthony
>
>
> _______________________________________________
> mythtv-users mailing list
> mythtv-users at mythtv.org
> http://www.mythtv.org/mailman/listinfo/mythtv-users
>