[mythtv-users] v0.25.2-19-gcf06841: Ceton for QAM can't figure out why I got a 0-byte recording
Steven Adeff
adeffs.mythtv at gmail.com
Sun Sep 23 13:36:24 UTC 2012
Normally things work fine, but once in a while I get a 0-byte
recording. The channel works in live tv and for other recordings, so
I'm not sure why sometimes it doesn't and I get a 0-byte recording.
Here's the log with channel and record logging on. I don't see
anything that stands out as a failure to tune or be able to record the
showing, "MLS Soccer":"Toronto FC at Los Angeles Galaxy". Any help is
appreciated!
Sep 22 19:27:59 MythCenter mythbackend[710]: I Scheduler
tv_rec.cpp:407 (StartRecording) TVRec(4): StartRecording("MLS
Soccer":"Toronto FC at Los Angeles Galaxy")
Sep 22 19:28:00 MythCenter mythbackend[710]: I Scheduler
tv_rec.cpp:782 (StartedRecording) TVRec(4):
StartedRecording(3406_2012-09-22T19:28:00)
fn(/media/mythtv/3/tv/3406_20120922192800.mpg)
Sep 22 19:28:00 MythCenter mythbackend[710]: I Scheduler
tv_rec.cpp:3940 (load_profile) Using profile 'Default' to record
Sep 22 19:28:00 MythCenter mythbackend[710]: I Scheduler
tv_rec.cpp:4186 (ClearFlags) TVRec(4):
ClearFlags(CancelNextRecording,) -> RunMainLoop,
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:1029 (HandleStateChange) TVRec(4): Changing from None to
RecordingOnly
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4186 (ClearFlags) TVRec(4):
ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:3406 (HandleTuning) TVRec(4): HandleTuning Request:
Program(ProgramInfo(3406_20120922192800.mpg): channame(KDOCDT
(KDOC-DT)) startts(Sat Sep 22 19:30:00 2012) endts(Sat Sep 22 22:00:00
2012)#012 recstartts(Sat Sep 22 19:28:00 2012)
recendts(Sat Sep 22 22:00:00 2012)#012 title(MLS Soccer))
channel() input() flags(Recording,)
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:3495 (TuningCheckForHWChange) TVRec(4): HW Tuner: 4->4
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4186 (ClearFlags) TVRec(4): ClearFlags(PENDINGACTIONS,) ->
RunMainLoop,
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:3428 (HandleTuning) TVRec(4): No recorder yet, calling
TuningFrequency
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
cetonchannel.cpp:30 (Open) CetonChan(192.168.200.1-0.3): Opening Ceton
channel
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
dtvchannel.cpp:181 (SetChannelByString) DTVChan(192.168.200.1-0.3):
SetChannelByString(406):
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
cetonchannel.cpp:96 (Tune) CetonChan(192.168.200.1-0.3): Tuning to
543000000 qam_256
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
cetonstreamhandler.cpp:430 (TuneFrequency) CetonSH(192.168.200.1-0.3):
TuneFrequency(543000000, qam_256)
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
dtvchannel.cpp:332 (SetChannelByString) DTVChan(192.168.200.1-0.3):
SetChannelByString(406): success
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
cetonstreamhandler.cpp:472 (TuneProgram) CetonSH(192.168.200.1-0.3):
TuneProgram(628)
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:3730 (TuningFrequency) TVRec(4): Starting Signal Monitor
Sep 22 19:28:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:1951 (SetupSignalMonitor) TVRec(4): SetupSignalMonitor(1,
0)
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
cetonchannel.cpp:30 (Open) CetonChan(192.168.200.1-0.3): Opening Ceton
channel
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
cetonsignalmonitor.cpp:37 (CetonSignalMonitor)
CetonSM(192.168.200.1-0.3): ctor
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
cetonstreamhandler.cpp:65 (Get) CetonSH: Using existing stream handler
192.168.200.1-0.3 for 192.168.200.1-0.3 (2 in use)
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:1973 (SetupSignalMonitor) TVRec(4): Signal monitor
successfully created
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:1771 (SetupDTVSignalMonitor) TVRec(4): Setting up table
monitoring.
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:3940 (load_profile) Using profile 'Live TV' to record
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:1885 (SetupDTVSignalMonitor) TVRec(4): MPEG program number:
628
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
dtvsignalmonitor.cpp:221 (SetProgramNumber)
DTVSM(192.168.200.1-0.3)::SetProgramNumber(628):
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:1906 (SetupDTVSignalMonitor) TVRec(4): Successfully set up
MPEG table monitoring.
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4177 (SetFlags) TVRec(4): SetFlags(SignalMonitorRunning,)
-> RunMainLoop,SignalMonitorRunning,
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4186 (ClearFlags) TVRec(4): ClearFlags(WaitingForSignal,)
-> RunMainLoop,SignalMonitorRunning,
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4177 (SetFlags) TVRec(4): SetFlags(WaitingForSignal,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning,
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4186 (ClearFlags) TVRec(4):
ClearFlags(NeedToStartRecorder,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning,
Sep 22 19:28:01 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4177 (SetFlags) TVRec(4): SetFlags(NeedToStartRecorder,) ->
RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
Sep 22 19:28:01 MythCenter mythbackend[710]: I SignalMonitor
streamhandler.cpp:53 (AddListener) SH(192.168.200.1-0.3):
AddListener(0xffffffffacb594b0) -- begin
Sep 22 19:28:01 MythCenter mythbackend[710]: I SignalMonitor
streamhandler.cpp:65 (AddListener) SH(192.168.200.1-0.3):
AddListener(0xffffffffacb594b0) -- locked
Sep 22 19:28:01 MythCenter mythbackend[710]: I SignalMonitor
streamhandler.cpp:99 (AddListener) SH(192.168.200.1-0.3):
AddListener(0xffffffffacb594b0) -- end
Sep 22 19:28:01 MythCenter mythbackend[710]: I CetonStreamHandler
cetonstreamhandler.cpp:234 (run) CetonSH(192.168.200.1-0.3): RunTS():
begin
Sep 22 19:28:01 MythCenter mythbackend[710]: N Scheduler
autoexpire.cpp:263 (CalcParams) AutoExpire: CalcParams(): Max required
Free Space: 4.0 GB w/freq: 7 min
Sep 22 19:28:01 MythCenter mythbackend[710]: I Scheduler
scheduler.cpp:2513 (HandleRecordingStatusChange) Tuning recording:
"MLS Soccer":"Toronto FC at Los Angeles Galaxy": channel 3406 on
cardid 4, sourceid 3
Sep 22 19:28:01 MythCenter mythbackend[710]: I CetonStreamHandler
mpeg/mpegstreamdata.cpp:402 (CreatePATSingleProgram)
CreatePATSingleProgram()
Sep 22 19:28:01 MythCenter mythbackend[710]: I CetonStreamHandler
mpeg/mpegstreamdata.cpp:403 (CreatePATSingleProgram) PAT in input
stream
Sep 22 19:28:01 MythCenter mythbackend[710]: I CetonStreamHandler
mpeg/mpegstreamdata.cpp:404 (CreatePATSingleProgram) Program
Association Section#012 PSIP tableID(0x0) length(21)
extension(0x8379)#012 version(14) current(1) section(0)
last_section(0)#012 tsid(33657) programCount(3)#012 program
number 627 has PID 0x0030#012 program number 626 has PID
0x0031#012 program number 628 has PID 0x0032
Sep 22 19:28:01 MythCenter mythbackend[710]: I CetonStreamHandler
mpeg/mpegstreamdata.cpp:412 (CreatePATSingleProgram)
desired_program(628) pid(0x32)
Sep 22 19:28:01 MythCenter mythbackend[710]: I CetonStreamHandler
mpeg/mpegstreamdata.cpp:453 (CreatePATSingleProgram) pmt_pid(0x32)
Sep 22 19:28:01 MythCenter mythbackend[710]: I CetonStreamHandler
mpeg/mpegstreamdata.cpp:454 (CreatePATSingleProgram) PAT for output
stream
Sep 22 19:28:01 MythCenter mythbackend[710]: I CetonStreamHandler
mpeg/mpegstreamdata.cpp:455 (CreatePATSingleProgram) Program
Association Section#012 PSIP tableID(0x0) length(13)
extension(0x8379)#012 version(14) current(1) section(0)
last_section(0)#012 tsid(33657) programCount(1)#012 program
number 1 has PID 0x0032
Sep 22 19:28:38 MythCenter mythbackend[710]: N Expire
autoexpire.cpp:263 (CalcParams) AutoExpire: CalcParams(): Max required
Free Space: 4.0 GB w/freq: 7 min
Sep 22 19:30:35 MythCenter mythbackend[710]: I HouseKeeping
housekeeper.cpp:225 (RunHouseKeeping) Running housekeeping thread
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4186 (ClearFlags) TVRec(5): ClearFlags(FinishRecording,) ->
RunMainLoop,RecorderRunning,RingBufferReady,
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:1029 (HandleStateChange) TVRec(5): Changing from
RecordingOnly to None
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4186 (ClearFlags) TVRec(5):
ClearFlags(FrontendReady,CancelNextRecording,) ->
RunMainLoop,RecorderRunning,RingBufferReady,
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:3406 (HandleTuning) TVRec(5): HandleTuning Request:
Program(NULL) channel() input() flags(CloseRec,KillRingBuffer,)
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
mpegrecorder.cpp:1332 (StopEncoding) MPEGRec(/dev/hdpvr1):
StopEncoding
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
mpegrecorder.cpp:1348 (StopEncoding) MPEGRec(/dev/hdpvr1): Encoding
stopped
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
DeviceReadBuffer.cpp:171 (Stop) DevRdB(/dev/hdpvr1): Stop() -- begin
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
DeviceReadBuffer.cpp:180 (Stop) DevRdB(/dev/hdpvr1): Stop() -- end
Sep 22 19:32:00 MythCenter mythbackend[710]: E RecThread
mpegrecorder.cpp:1017 (run) MPEGRec(/dev/hdpvr1): Device EOF detected
Sep 22 19:32:00 MythCenter mythbackend[710]: I RecThread
mpegrecorder.cpp:1113 (run) MPEGRec(/dev/hdpvr1): run finishing up
Sep 22 19:32:00 MythCenter mythbackend[710]: I RecThread
mpegrecorder.cpp:1332 (StopEncoding) MPEGRec(/dev/hdpvr1):
StopEncoding
Sep 22 19:32:00 MythCenter mythbackend[710]: I RecThread
mythdbcon.cpp:395 (PurgeIdleConnections) New DB connection, total: 12
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:4186 (ClearFlags) TVRec(5): ClearFlags(RecorderRunning,) ->
RunMainLoop,RingBufferReady,
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
mpegrecorder.cpp:1332 (StopEncoding) MPEGRec(/dev/hdpvr1):
StopEncoding
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
recorderbase.cpp:89 (SetRecording) RecBase(5:/dev/hdpvr1):
SetRecording(0x0)
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:816 (FinishedRecording) TVRec(5):
FinishedRecording(1469_2012-09-22T16:58:00) good
recq:<RecordingQuality overall_score="1"
key="1469_2012-09-22T16:58:00" countinuity_error_count="4"
packet_count="75582925" />
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
tv_rec.cpp:866 (FinishedRecording) TVRec(5):
FinishedRecording(1469_2012-09-22T16:58:00)#012#011#011#011title: MLS
Soccer#012#011#011#011in recgroup: Default status: Recording:Recorded
not_dummy finished_now
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
programinfo.cpp:3806 (SaveVideoProperties) SaveVideoProperties(0x38,
0x10)
Sep 22 19:32:00 MythCenter mythbackend[710]: I CoreContext
scheduler.cpp:637 (UpdateRecStatus) Updating status for "MLS
Soccer":"Portland Timbers at Real Salt Lake" on cardid 5 (Recording =>
Recorded)
Sep 22 19:32:00 MythCenter mythbackend[710]: I TVRecEvent
recordinginfo.cpp:1113 (FinishedRecording) Finished recording MLS
Soccer "Portland Timbers at Real Salt Lake": channel 1469
--
Steve
http://www.mythtv.org/wiki/User:Steveadeff
Before you ask, read the FAQ!
http://www.mythtv.org/wiki/Frequently_Asked_Questions
then search the Wiki, and this list,
http://www.gossamer-threads.com/lists/mythtv/
Mailinglist etiquette - http://www.mythtv.org/wiki/Mailing_List_etiquette
More information about the mythtv-users
mailing list