[mythtv-users] 0.26-fixes: HDHR no longer recording?

Steven Adeff adeffs.mythtv at gmail.com
Tue Mar 5 17:20:30 UTC 2013


It looks as though for some reason our HDHR device has decided to stop
recording, or all the recordings are almost immediately deteleted. It
was working fine, but lately we noticed a lot of missed recordings, or
recordings that are being deleted extremely quickly (possibly because
they are 0-byte?).

Anyway, looking through the log for one such recording there are some
things I don't understand, but could be tied to what's happening,

so what stands out to me is:
this occurs a bunch,
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: E
ProcessRequest programinfo.cpp:2284 (GetPlaybackURL)
ProgramInfo(2402_20130304025800.mpg): GetPlaybackURL:
'2402_20130304025800.mpg' should be local, but it can not be found.
why is this file not local and not found? does this mean Myth was not
receiving data to create the file, or that for some reason this
recording it was unable to but other recordings it is?

it then goes through a bunch of stuff that looks like things are ok?
but at the end it shows this:
Mar  3 18:58:30 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:1519 (HandlePendingRecordings) TVRec(8):
Deleting stale pending recording 11 '60 Minutes'
which makes me think something failed along the way, but I can't tell what?

anyone have any idea what's going on?
thanks!

Full log paste below (with -v general,channel,record):
Mar  3 18:57:59 MythCenter mythlogserver: mythbackend[18827]: I RecThread mpeg/m
pegstreamdata.cpp:401 (CreatePATSingleProgram) PAT in input stream
Mar  3 18:57:59 MythCenter mythlogserver: mythbackend[18827]: I RecThread mpeg/m
pegstreamdata.cpp:402 (CreatePATSingleProgram) Program Association Section#012 P
SIP tableID(0x0) length(17) extension(0x0)#012      version(3) current(1) sectio
n(0) last_section(0)#012      tsid(0) programCount(2)#012  program number     0
has PID 0x001f#012  program number     1 has PID 0x0100
Mar  3 18:57:59 MythCenter mythlogserver: mythbackend[18827]: I RecThread mpeg/m
pegstreamdata.cpp:410 (CreatePATSingleProgram) desired_program(1) pid(0x100)
Mar  3 18:57:59 MythCenter mythlogserver: mythbackend[18827]: I RecThread mpeg/m
pegstreamdata.cpp:451 (CreatePATSingleProgram) pmt_pid(0x100)
Mar  3 18:57:59 MythCenter mythlogserver: mythbackend[18827]: I RecThread mpeg/m
pegstreamdata.cpp:452 (CreatePATSingleProgram) PAT for output stream
Mar  3 18:57:59 MythCenter mythlogserver: mythbackend[18827]: I RecThread mpeg/m
pegstreamdata.cpp:453 (CreatePATSingleProgram) Program Association Section#012 P
SIP tableID(0x0) length(13) extension(0x0)#012      version(3) current(1) sectio
n(0) last_section(0)#012      tsid(0) programCount(1)#012  program number     1
has PID 0x0100
Mar  3 18:58:19 MythCenter mythlogserver: mythbackend[18827]: I Scheduler cardut
il.cpp:1673 (GetConflictingCards) CardUtil:   Group ID 2
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I Scheduler cardut
il.cpp:1693 (GetConflictingCards) CardUtil:   Card ID 8
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
Scheduler tv_rec.cpp:413 (StartRecording) TVRec(11):
StartRecording("60 Minutes")
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
Scheduler tv_rec.cpp:482 (StartRecording) TVRec(11): Checking input
group recorders - begin
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
Scheduler tv_rec.cpp:559 (StartRecording) TVRec(11): Checking input
group recorders - done
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
Scheduler tv_rec.cpp:796 (StartedRecording) TVRec(11):
StartedRecording(2402_2013-03-04T02:58:00Z)
fn(/media/mythtv/2/tv/2402_20130304025800.mpg)
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
Scheduler tv_rec.cpp:4007 (load_profile) Using profile 'Default' to
record
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
Scheduler tv_rec.cpp:4254 (ClearFlags) TVRec(11):
ClearFlags(CancelNextRecording,) ->
FrontendReady,RunMainLoop,RingBufferReady,
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:1043 (HandleStateChange) TVRec(11): Changing
from None to RecordingOnly
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4254 (ClearFlags) TVRec(11):
ClearFlags(FrontendReady,CancelNextRecording,) ->
RunMainLoop,RingBufferReady,
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:3473 (HandleTuning) TVRec(11): HandleTuning
Request: Program(ProgramInfo(2402_20130304025800.mpg): channame(KCBSDT
(KCBS-DT)) startts(Mon Mar 4 03:00:00 2013) endts(Mon Mar 4 04:00:00
2013)#012             recstartts(Mon Mar 4 02:58:00 2013) recendts(Mon
Mar 4 04:01:00 2013)#012             title(60 Minutes)) channel()
input() flags(Recording,)
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mythdbcon.cpp:409 (PurgeIdleConnections) New DB connection,
total: 21
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:3562 (TuningCheckForHWChange) TVRec(11): HW
Tuner: 11->11
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4254 (ClearFlags) TVRec(11):
ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:3495 (HandleTuning) TVRec(11): No recorder yet,
calling TuningFrequency
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent hdhrchannel.cpp:57 (Open) HDHRChan(192.168.1.117-1):
Opening HDHR channel
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent dtvchannel.cpp:181 (SetChannelByString)
DTVChan(192.168.1.117-1): SetChannelByString(402):
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent hdhrchannel.cpp:170 (Tune) HDHRChan(192.168.1.117-1):
Tuning to qam256:609000000
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent hdhrstreamhandler.cpp:466 (TuneChannel)
HDHRSH(192.168.1.117-1): Tuning channel qam256:609000000 (was none)
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent dtvchannel.cpp:332 (SetChannelByString)
DTVChan(192.168.1.117-1): SetChannelByString(402): success
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:3797 (TuningFrequency) TVRec(11): Starting
Signal Monitor
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:1972 (SetupSignalMonitor) TVRec(11):
SetupSignalMonitor(1, 0)
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent hdhrchannel.cpp:57 (Open) HDHRChan(192.168.1.117-1):
Opening HDHR channel
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent hdhrsignalmonitor.cpp:45 (HDHRSignalMonitor)
HDHRSM(192.168.1.117-1): ctor
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent hdhrstreamhandler.cpp:52 (Get) HDHRSH: Using existing
stream handler 192.168.1.117-1 for 192.168.1.117-1 (3 in use)
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:1994 (SetupSignalMonitor) TVRec(11): Signal
monitor successfully created
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:1792 (SetupDTVSignalMonitor) TVRec(11): Setting
up table monitoring.
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: E
ProcessRequest programinfo.cpp:2284 (GetPlaybackURL)
ProgramInfo(2402_20130304025800.mpg): GetPlaybackURL:
'2402_20130304025800.mpg' should be local, but it can not be found.
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4007 (load_profile) Using profile 'Live TV' to
record
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:1825 (SetupDTVSignalMonitor) TVRec(11): ATSC
channel: 2_1
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: E
ProcessRequest programinfo.cpp:2284 (GetPlaybackURL)
ProgramInfo(2402_20130304025800.mpg): GetPlaybackURL:
'2402_20130304025800.mpg' should be local, but it can not be found.
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent dtvsignalmonitor.cpp:204 (SetChannel)
DTVSM(192.168.1.117-1)::SetChannel(2, 1):
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:1847 (SetupDTVSignalMonitor) TVRec(11):
Successfully set up ATSC table monitoring.
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4245 (SetFlags) TVRec(11):
SetFlags(SignalMonitorRunning,) ->
RunMainLoop,SignalMonitorRunning,RingBufferReady,
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4254 (ClearFlags) TVRec(11):
ClearFlags(WaitingForSignal,) ->
RunMainLoop,SignalMonitorRunning,RingBufferReady,
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4245 (SetFlags) TVRec(11):
SetFlags(WaitingForSignal,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady,
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4254 (ClearFlags) TVRec(11):
ClearFlags(NeedToStartRecorder,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady,
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4245 (SetFlags) TVRec(11):
SetFlags(NeedToStartRecorder,) ->
RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,RingBufferReady,
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: N
Scheduler autoexpire.cpp:264 (CalcParams) AutoExpire: CalcParams():
Max required Free Space: 4.0 GB w/freq: 5 min
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
SignalMonitor streamhandler.cpp:53 (AddListener) SH(192.168.1.117-1):
AddListener(0xffffffff93e146c8) -- begin
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
SignalMonitor streamhandler.cpp:65 (AddListener) SH(192.168.1.117-1):
AddListener(0xffffffff93e146c8) -- locked
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
Scheduler scheduler.cpp:2651 (HandleRecordingStatusChange) Tuning
recording: "60 Minutes": channel 2402 on cardid 11, sourceid 2
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: E
ProcessRequest programinfo.cpp:2284 (GetPlaybackURL)
ProgramInfo(2402_20130304025800.mpg): GetPlaybackURL:
'2402_20130304025800.mpg' should be local, but it can not be found.
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler hdhrstreamhandler.cpp:129 (run)
HDHRSH(192.168.1.117-1): RunTS(): begin
Mar  3 18:58:20 MythCenter mythlogserver: mythbackend[18827]: I
SignalMonitor streamhandler.cpp:99 (AddListener) SH(192.168.1.117-1):
AddListener(0xffffffff93e146c8) -- end
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler dtvsignalmonitor.cpp:460 (HandleCVCT)
DTVSM(192.168.1.117-1)::SetVCT(): cvct->ProgramNumber(idx 0): prog num
305Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler dtvsignalmonitor.cpp:221 (SetProgramNumber)
DTVSM(192.168.1.117-1)::SetProgramNumber(305):
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:400 (CreatePATSingleProgram)
CreatePATSingleProgram()
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:401 (CreatePATSingleProgram)
PAT in input stream
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:402 (CreatePATSingleProgram)
Program Association Section#012 PSIP tableID(0x0) length(21)
extension(0x0)#012      version(15) current(1) section(0)
last_section(0)#012      tsid(0) programCount(3)#012  program number
305 has PID 0x0059#012  program number   306 has PID 0x005a#012
program number   307 has PID 0x005b
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:410 (CreatePATSingleProgram)
desired_program(305) pid(0x59)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:451 (CreatePATSingleProgram)
pmt_pid(0x59)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:452 (CreatePATSingleProgram)
PAT for output stream
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:453 (CreatePATSingleProgram)
Program Association Section#012 PSIP tableID(0x0) length(13)
extension(0x0)#012      version(15) current(1) section(0)
last_section(0)#012      tsid(0) programCount(1)#012  program number
  1 has PID 0x0059
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:507 (CreatePMTSingleProgram)
CreatePMTSingleProgram()
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:508 (CreatePMTSingleProgram)
PMT in input stream
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:509 (CreatePMTSingleProgram)
Program Map Section#012 PSIP tableID(0x2) length(153)
extension(0x131)#012      version(27) current(1) section(0)
last_section(0)#012      pnum(305) pid(0x59)#012  Content Advisory,
Possibly Dishnet Rights Descriptor (0x87) length(19)#012  Stream #0
pid(0xefb) type(0xc0 unknown)#012    Registration Descriptor: 'ETV1'
CableLabs ETV info is present#012  Stream #1 pid(0xefc) type(0xc0
unknown)#012    Registration Descriptor: 'ETV1' CableLabs ETV info is
present#012    ATSC Time-shifted Service Descriptor (0xa2)
length(9)#012  Stream #2 pid(0xefd) type(0x02 video-mpeg2)#012    STD
Descriptor (0x11) length(1)#012    Smooting Buffer Descriptor (0x10)
length(6)#012    Data Stream Alignment Descriptor (0x06) length(1)#012
   Caption Service Descriptor  services(1)#012     lang(eng) type(1)
easy_reader(0) wide(0) service_num(1)#012  Stream #3 pid(0xefe)
type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3' ATSC audio
stream A/52#012    Audio Stream Descriptor  full_srv(1)
sample_rate(48kbps) bit_rate(=384kbps, 14)#012      bsid(8) bs_mode(0)
channels(2/0) Dolby(Not indicated)#012      mainID(0) #012    ISO-639
Language: code(eng) canonical(eng) eng(English)#012  Stream #4
pid(0xeff) type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3'
ATSC audio stream A/52#012    Audio Stream Descriptor  full_srv(1)
sample_rate(48kbps) bit_rate(=384kbps, 14)#012      bsid(8) bs_mode(0)
channels(2/0) Dolby(Not indicated)#012      mainID(0) #012    ISO-639
Language: code(spa) canonical(spa) eng(Spanish; Castilian)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:678 (CreatePMTSingleProgram)
PMT for output stream
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler mpeg/mpegstreamdata.cpp:679 (CreatePMTSingleProgram)
Program Map Section#012 PSIP tableID(0x2) length(153)
extension(0x1)#012      version(27) current(1) section(0)
last_section(0)#012      pnum(1) pid(0x59)#012  Content Advisory,
Possibly Dishnet Rights Descriptor (0x87) length(19)#012  Stream #0
pid(0xefb) type(0xc0 unknown)#012    Registration Descriptor: 'ETV1'
CableLabs ETV info is present#012  Stream #1 pid(0xefc) type(0xc0
unknown)#012    Registration Descriptor: 'ETV1' CableLabs ETV info is
present#012    ATSC Time-shifted Service Descriptor (0xa2)
length(9)#012  Stream #2 pid(0xefd) type(0x02 video-mpeg2)#012    STD
Descriptor (0x11) length(1)#012    Smooting Buffer Descriptor (0x10)
length(6)#012    Data Stream Alignment Descriptor (0x06) length(1)#012
   Caption Service Descriptor  services(1)#012     lang(eng) type(1)
easy_reader(0) wide(0) service_num(1)#012  Stream #3 pid(0xefe)
type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3' ATSC audio
stream A/52#012    Audio Stream Descriptor  full_srv(1)
sample_rate(48kbps) bit_rate(=384kbps, 14)#012      bsid(8) bs_mode(0)
channels(2/0) Dolby(Not indicated)#012      mainID(0) #012    ISO-639
Language: code(eng) canonical(eng) eng(English)#012  Stream #4
pid(0xeff) type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3'
ATSC audio stream A/52#012    Audio Stream Descriptor  full_srv(1)
sample_rate(48kbps) bit_rate(=384kbps, 14)#012      bsid(8) bs_mode(0)
channels(2/0) Dolby(Not indicated)#012      mainID(0) #012    ISO-639
Language: code(spa) canonical(spa) eng(Spanish; Castilian)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:3867 (TuningSignalCheck) TVRec(11): Got good
signal
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:2027 (TeardownSignalMonitor) TVRec(11):
TeardownSignalMonitor() -- begin
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
CoreContext scheduler.cpp:655 (UpdateRecStatus) Updating status for
"60 Minutes" on cardid 11 (Tuning => Recording)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent hdhrsignalmonitor.cpp:59 (~HDHRSignalMonitor)
HDHRSM(192.168.1.117-1): dtor
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent hdhrsignalmonitor.cpp:69 (Stop) HDHRSM(192.168.1.117-1):
Stop() -- begin
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent streamhandler.cpp:107 (RemoveListener) SH(192.168.1.117-1):
RemoveListener(0xffffffff93e146c8) -- begin
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent streamhandler.cpp:119 (RemoveListener) SH(192.168.1.117-1):
RemoveListener(0xffffffff93e146c8) -- locked
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler hdhrstreamhandler.cpp:181 (run)
HDHRSH(192.168.1.117-1): RunTS(): shutdown
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler hdhrstreamhandler.cpp:186 (run)
HDHRSH(192.168.1.117-1): RunTS(): end
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent streamhandler.cpp:141 (RemoveListener) SH(192.168.1.117-1):
RemoveListener(0xffffffff93e146c8) -- end
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent hdhrsignalmonitor.cpp:75 (Stop) HDHRSM(192.168.1.117-1):
Stop() -- end
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:2046 (TeardownSignalMonitor) TVRec(11):
TeardownSignalMonitor() -- end
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4254 (ClearFlags) TVRec(11):
ClearFlags(SignalMonitorRunning,) ->
RunMainLoop,WaitingForSignal,NeedToStartRecorder,RingBufferReady,
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4254 (ClearFlags) TVRec(11):
ClearFlags(WaitingForSignal,) ->
RunMainLoop,NeedToStartRecorder,RingBufferReady,
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4017 (TuningNewRecorder) TVRec(11): Starting
Recorder
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4007 (load_profile) Using profile 'Default' to
record
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4056 (TuningNewRecorder) TVRec(11):
rec->GetPathname(): '/media/mythtv/2/tv/2402_20130304025800.mpg'
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent dtvrecorder.cpp:167 (ResetForNewFile) DTVRec(11):
ResetForNewFile(void)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: E
TVRecEvent recorderbase.cpp:166 (SetStrOption)
RecBase(11:192.168.1.117-1): SetStrOption(...recordingtype): Option
not in profile.
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent recorderbase.cpp:79 (SetRingBuffer)
RecBase(11:192.168.1.117-1): SetRingBuffer(0xffffffff93e8cc00)
'/media/mythtv/2/tv/2402_20130304025800.mpg'
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent dtvrecorder.cpp:1151 (HandlePAT) DTVRec(11): SetPAT(305 on
0x59)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:400 (CreatePATSingleProgram)
CreatePATSingleProgram()
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:401 (CreatePATSingleProgram) PAT in
input stream
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:402 (CreatePATSingleProgram)
Program Association Section#012 PSIP tableID(0x0) length(21)
extension(0x0)#012      version(15) current(1) section(0)
last_section(0)#012      tsid(0) programCount(3)#012  program number
305 has PID 0x0059#012  program number   306 has PID 0x005a#012
program number   307 has PID 0x005b
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:410 (CreatePATSingleProgram)
desired_program(305) pid(0x59)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:451 (CreatePATSingleProgram)
pmt_pid(0x59)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:452 (CreatePATSingleProgram) PAT
for output stream
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:453 (CreatePATSingleProgram)
Program Association Section#012 PSIP tableID(0x0) length(13)
extension(0x0)#012      version(15) current(1) section(0)
last_section(0)#012      tsid(0) programCount(1)#012  program number
  1 has PID 0x0059
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent dtvrecorder.cpp:1172 (HandlePMT) DTVRec(11): SetPMT(305)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:507 (CreatePMTSingleProgram)
CreatePMTSingleProgram()
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:508 (CreatePMTSingleProgram) PMT in
input stream
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:509 (CreatePMTSingleProgram)
Program Map Section#012 PSIP tableID(0x2) length(153)
extension(0x131)#012      version(27) current(1) section(0)
last_section(0)#012      pnum(305) pid(0x59)#012  Content Advisory,
Possibly Dishnet Rights Descriptor (0x87) length(19)#012  Stream #0
pid(0xefb) type(0xc0 unknown)#012    Registration Descriptor: 'ETV1'
CableLabs ETV info is present#012  Stream #1 pid(0xefc) type(0xc0
unknown)#012    Registration Descriptor: 'ETV1' CableLabs ETV info is
present#012    ATSC Time-shifted Service Descriptor (0xa2)
length(9)#012  Stream #2 pid(0xefd) type(0x02 video-mpeg2)#012    STD
Descriptor (0x11) length(1)#012    Smooting Buffer Descriptor (0x10)
length(6)#012    Data Stream Alignment Descriptor (0x06) length(1)#012
   Caption Service Descriptor  services(1)#012     lang(eng) type(1)
easy_reader(0) wide(0) service_num(1)#012  Stream #3 pid(0xefe)
type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3' ATSC audio
stream A/52#012    Audio Stream Descriptor  full_srv(1)
sample_rate(48kbps) bit_rate(=384kbps, 14)#012      bsid(8) bs_mode(0)
channels(2/0) Dolby(Not indicated)#012      mainID(0) #012    ISO-639
Language: code(eng) canonical(eng) eng(English)#012  Stream #4
pid(0xeff) type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3'
ATSC audio stream A/52#012    Audio Stream Descriptor  full_srv(1)
sample_rate(48kbps) bit_rate(=384kbps, 14)#012      bsid(8) bs_mode(0)
channels(2/0) Dolby(Not indicated)#012      mainID(0) #012    ISO-639
Language: code(spa) canonical(spa) eng(Spanish; Castilian)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:678 (CreatePMTSingleProgram) PMT
for output stream
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent mpeg/mpegstreamdata.cpp:679 (CreatePMTSingleProgram)
Program Map Section#012 PSIP tableID(0x2) length(153)
extension(0x1)#012      version(27) current(1) section(0)
last_section(0)#012      pnum(1) pid(0x59)#012  Content Advisory,
Possibly Dishnet Rights Descriptor (0x87) length(19)#012  Stream #0
pid(0xefb) type(0xc0 unknown)#012    Registration Descriptor: 'ETV1'
CableLabs ETV info is present#012  Stream #1 pid(0xefc) type(0xc0
unknown)#012    Registration Descriptor: 'ETV1' CableLabs ETV info is
present#012    ATSC Time-shifted Service Descriptor (0xa2)
length(9)#012  Stream #2 pid(0xefd) type(0x02 video-mpeg2)#012    STD
Descriptor (0x11) length(1)#012    Smooting Buffer Descriptor (0x10)
length(6)#012    Data Stream Alignment Descriptor (0x06) length(1)#012
   Caption Service Descriptor  services(1)#012     lang(eng) type(1)
easy_reader(0) wide(0) service_num(1)#012  Stream #3 pid(0xefe)
type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3' ATSC audio
stream A/52#012    Audio Stream Descriptor  full_srv(1)
sample_rate(48kbps) bit_rate(=384kbps, 14)#012      bsid(8) bs_mode(0)
channels(2/0) Dolby(Not indicated)#012      mainID(0) #012    ISO-639
Language: code(eng) canonical(eng) eng(English)#012  Stream #4
pid(0xeff) type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3'
ATSC audio stream A/52#012    Audio Stream Descriptor  full_srv(1)
sample_rate(48kbps) bit_rate(=384kbps, 14)#012      bsid(8) bs_mode(0)
channels(2/0) Dolby(Not indicated)#012      mainID(0) #012    ISO-639
Language: code(spa) canonical(spa) eng(Spanish; Castilian)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent recorderbase.cpp:89 (SetRecording)
RecBase(11:192.168.1.117-1): SetRecording(0x8d18cb8) title(60 Minutes)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
RecThread hdhrrecorder.cpp:52 (run) HDHRRec(11): run -- begin
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
RecThread dtvrecorder.cpp:167 (ResetForNewFile) DTVRec(11):
ResetForNewFile(void)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
RecThread hdhrstreamhandler.cpp:52 (Get) HDHRSH: Using existing stream
handler 192.168.1.117-1 for 192.168.1.117-1 (3 in use)
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
RecThread hdhrrecorder.cpp:35 (Open) HDHRRec(11): HDHR opened
successfully
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
RecThread streamhandler.cpp:53 (AddListener) SH(192.168.1.117-1):
AddListener(0xffffffff93e146c8) -- begin
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
RecThread streamhandler.cpp:65 (AddListener) SH(192.168.1.117-1):
AddListener(0xffffffff93e146c8) -- locked
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4245 (SetFlags) TVRec(11):
SetFlags(RecorderRunning,RingBufferReady,) ->
RunMainLoop,NeedToStartRecorder,RecorderRunning,RingBufferReady,
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:4254 (ClearFlags) TVRec(11):
ClearFlags(NeedToStartRecorder,) ->
RunMainLoop,RecorderRunning,RingBufferReady,
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
RecThread streamhandler.cpp:99 (AddListener) SH(192.168.1.117-1):
AddListener(0xffffffff93e146c8) -- end
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler hdhrstreamhandler.cpp:129 (run)
HDHRSH(192.168.1.117-1): RunTS(): begin
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler dtvrecorder.cpp:557 (FindMPEG2Keyframes) DTVRec(11):
FindMPEG2Keyframes: frame rate = 29970
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler dtvrecorder.cpp:1336 (ProcessAVTSPacket) DTVRec(11):
PID 0xefd Found Payload Start
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler dtvrecorder.cpp:1336 (ProcessAVTSPacket) DTVRec(11):
PID 0xeff Found Payload Start
Mar  3 18:58:21 MythCenter mythlogserver: mythbackend[18827]: I
HDHRStreamHandler dtvrecorder.cpp:1336 (ProcessAVTSPacket) DTVRec(11):
PID 0xefe Found Payload Start
Mar  3 18:58:26 MythCenter mythlogserver: mythbackend[18827]: I
ProcessRequest mainserver.cpp:1395 (HandleAnnounce) MainServer::ANN
Monitor
Mar  3 18:58:26 MythCenter mythlogserver: mythbackend[18827]: I
ProcessRequest mainserver.cpp:1397 (HandleAnnounce) adding: MythCenter
as a client (events: 0)
Mar  3 18:58:26 MythCenter mythlogserver: mythbackend[18827]: I
ProcessRequest mainserver.cpp:1395 (HandleAnnounce) MainServer::ANN
Monitor
Mar  3 18:58:26 MythCenter mythlogserver: mythbackend[18827]: I
ProcessRequest mainserver.cpp:1397 (HandleAnnounce) adding: MythCenter
as a client (events: 1)
Mar  3 18:58:30 MythCenter mythlogserver: mythbackend[18827]: I
TVRecEvent tv_rec.cpp:1519 (HandlePendingRecordings) TVRec(8):
Deleting stale pending recording 11 '60 Minutes'
Mar  3 19:00:30 MythCenter mythlogserver: mythbackend[18827]: I
Scheduler scheduler.cpp:2130 (HandleReschedule) Reschedule requested
for PLACE PrepareToRecord
Mar  3 19:00:33 MythCenter mythlogserver: mythbackend[18827]: I
RecThread mpeg/mpegstreamdata.cpp:400 (CreatePATSingleProgram)
CreatePATSingleProgram()
Mar  3 19:00:34 MythCenter mythlogserver: mythbackend[18827]: I
RecThread mpeg/mpegstreamdata.cpp:401 (CreatePATSingleProgram) PAT in
input stream

-- 
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