Ticket #8193: MythLog-Cobert-Failure.txt

File MythLog-Cobert-Failure.txt, 51.2 KB (added by Derek Atkins <warlord@…>, 11 years ago)

The backend log during the recordings of TDS/Cobert/Letterman

Line 
12010-03-15 22:58:00.412 Reschedule requested for id 0.
22010-03-15 22:58:02.104 Scheduled 298 items in 1.7 = 0.00 match + 1.67 place
32010-03-15 22:58:29.119 TVRec(1): RecordPending on inputid 1
42010-03-15 22:58:29.975 TVRec(1): ASK_RECORDING 1 29 0 0
52010-03-15 22:59:01.134 TVRec(1): StartRecording(The Daily Show With Jon Stewart)
62010-03-15 22:59:01.150 TVRec(1): StartedRecording(0x1500e20) fn(/home/myth-frontend0/mythtv/video/2034_20100315225900.mpg)
72010-03-15 22:59:01.169 TVRec(1): ClearFlags(CancelNextRecording,) -> RunMainLoop,
82010-03-15 22:59:01.171 TVRec(1): Changing from None to RecordingOnly
92010-03-15 22:59:01.174 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
102010-03-15 22:59:01.176 TVRec(1): Request: Program(yes) channel() input() flags(Recording,)
112010-03-15 22:59:01.180 TVRec(1): HW Tuner: 1->1
122010-03-15 22:59:01.182 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,
132010-03-15 22:59:01.185 TVRec(1): No recorder yet, calling TuningFrequency
142010-03-15 22:59:01.188 ProgramInfo(): Updated pathname '':'' -> '2034_20100315225900.mpg'
152010-03-15 22:59:01.188 HDHRChan(192.168.248.4-0): Opening HDHR channel
162010-03-15 22:59:01.208 HDHRChan(192.168.248.4-0): SetChannelByString(68)
172010-03-15 22:59:01.215 HDHRChan(192.168.248.4-0): Opening HDHR channel
182010-03-15 22:59:01.227 HDHRChan(192.168.248.4-0): Tuning to qam_256:669000000
192010-03-15 22:59:01.235 HDHRSH(192.168.248.4-0): Tuning channel qam_256:669000000 (was none)
202010-03-15 22:59:01.243 HDHRSH::TunerSet() Failed. Trying qam:669000000
212010-03-15 22:59:01.255 TVRec(1): Starting Signal Monitor
222010-03-15 22:59:01.260 TVRec(1): SetupSignalMonitor(1, 0)
232010-03-15 22:59:01.269 HDHRChan(192.168.248.4-0): Opening HDHR channel
242010-03-15 22:59:01.278 HDHRSM(192.168.248.4-0): ctor
252010-03-15 22:59:01.287 SM(192.168.248.4-0)::AddFlags: Seen() Match() Wait(Sig,)
262010-03-15 22:59:01.296 HDHRSH: Using existing stream handler 192.168.248.4-0 for 192.168.248.4-0 (2 in use)
272010-03-15 22:59:01.305 TVRec(1): Signal monitor successfully created
282010-03-15 22:59:01.314 TVRec(1): Setting up table monitoring.
292010-03-15 22:59:01.326 Using profile 'Live TV' to record
302010-03-15 22:59:01.333 TVRec(1): MPEG program number: 103
312010-03-15 22:59:01.341 DTVSM(192.168.248.4-0)::SetProgramNumber(103):
322010-03-15 22:59:01.350 SM(192.168.248.4-0)::RemoveFlags: Seen(PMT,Crypt,) Match(PMT,Crypt,) Wait()
332010-03-15 22:59:01.359 SM(192.168.248.4-0)::AddFlags: Seen() Match() Wait(PMT,)
342010-03-15 22:59:01.368 SM(192.168.248.4-0)::AddFlags: Seen() Match() Wait(PAT,PMT,Pos,)
352010-03-15 22:59:01.377 TVRec(1): Successfully set up MPEG table monitoring.
362010-03-15 22:59:01.387 SM(192.168.248.4-0)::Start: begin
372010-03-15 22:59:01.396 SM(192.168.248.4-0)::Start: end
382010-03-15 22:59:01.405 TVRec(1): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning,
392010-03-15 22:59:01.414 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,
402010-03-15 22:59:01.423 TVRec(1): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,
412010-03-15 22:59:01.432 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,
422010-03-15 22:59:01.441 TVRec(1): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
432010-03-15 22:59:01.450 HDHRSH(192.168.248.4-0): AddListener(0x7fd38c00b780) -- begin
442010-03-15 22:59:01.469 HDHRSH(192.168.248.4-0): AddListener(0x7fd38c00b780) -- locked
452010-03-15 22:59:01.455 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
462010-03-15 22:59:01.473 HDHRSH(192.168.248.4-0): AddListener(0x7fd38c00b780) -- end
472010-03-15 22:59:01.475 Started recording: The Daily Show With Jon Stewart: channel 2034 on cardid 1, sourceid 2
482010-03-15 22:59:01.538 HDHRSH(192.168.248.4-0): RunTS(): begin
492010-03-15 22:59:01.597 SM(192.168.248.4-0)::AddFlags: Seen(PAT,) Match() Wait()
502010-03-15 22:59:01.599 SM(192.168.248.4-0)::AddFlags: Seen() Match(PAT,) Wait()
512010-03-15 22:59:01.600 CreatePATSingleProgram()
522010-03-15 22:59:01.602 PAT in input stream
532010-03-15 22:59:01.603 Program Association Table
54 PSIP tableID(0x0) length(57) extension(0x8075)
55      version(17) current(1) section(0) last_section(0)
56         tsid: 32885
57 programCount: 12
58  program number   112 has PID 0x  31   data  0x 0 0x70 0xe0 0x31
59  program number   106 has PID 0x  34   data  0x 0 0x6a 0xe0 0x34
60  program number   105 has PID 0x  35   data  0x 0 0x69 0xe0 0x35
61  program number   102 has PID 0x  37   data  0x 0 0x66 0xe0 0x37
62  program number   110 has PID 0x  3a   data  0x 0 0x6e 0xe0 0x3a
63  program number   109 has PID 0x  33   data  0x 0 0x6d 0xe0 0x33
64  program number   104 has PID 0x  3b   data  0x 0 0x68 0xe0 0x3b
65  program number   111 has PID 0x  30   data  0x 0 0x6f 0xe0 0x30
66  program number   108 has PID 0x  38   data  0x 0 0x6c 0xe0 0x38
67  program number   103 has PID 0x  32   data  0x 0 0x67 0xe0 0x32
68  program number   101 has PID 0x  36   data  0x 0 0x65 0xe0 0x36
69  program number   107 has PID 0x  39   data  0x 0 0x6b 0xe0 0x39
70
712010-03-15 22:59:01.605 desired_program(103) pid(0x32)
722010-03-15 22:59:01.606 pmt_pid(0x32)
732010-03-15 22:59:01.615 PAT for output stream
742010-03-15 22:59:01.624 Program Association Table
75 PSIP tableID(0x0) length(13) extension(0x8075)
76      version(17) current(1) section(0) last_section(0)
77         tsid: 32885
78 programCount: 1
79  program number     1 has PID 0x  32   data  0x 0 0x 1 0xe0 0x32
80
812010-03-15 22:59:01.755 SM(192.168.248.4-0)::AddFlags: Seen(PMT,) Match() Wait()
822010-03-15 22:59:01.757 SM(192.168.248.4-0)::AddFlags: Seen() Match(PMT,) Wait()
832010-03-15 22:59:01.766 CreatePMTSingleProgram()
842010-03-15 22:59:01.768 PMT in input stream
852010-03-15 22:59:01.777 Program Map Table ver(18) pid(0x32) pnum(103) len(60)
86
87 Stream #0 pid(0x840) type(video-mpeg2  0x2)
88 Stream #1 pid(0x841) type(audio-ac3  0x81)
89  ISO-639 Language: code(eng) canonical(eng) eng(English)
90 Stream #2 pid(0x842) type(caption service  0x86)
91 Stream #3 pid(0x843) type(unknown  0xc0)
92  Registration Descriptor: 'ETV1' CableLabs ETV info is present
93  ATSC Time-shifted Service Descriptor (0xa2) length(0)
94 Stream #4 pid(0x844) type(unknown  0xc0)
95  Registration Descriptor: 'ETV1' CableLabs ETV info is present
96  Service Location Descriptor (0xa1) length(0)
97
982010-03-15 22:59:01.780 TVRec(1): Got good signal
992010-03-15 22:59:01.797 TVRec(1): TeardownSignalMonitor() -- begin
1002010-03-15 22:59:01.805 HDHRSM(192.168.248.4-0): dtor
1012010-03-15 22:59:01.815 HDHRSM(192.168.248.4-0): Stop() -- begin
1022010-03-15 22:59:01.823 SM(192.168.248.4-0)::Stop: begin
1032010-03-15 22:59:01.788 Created PMT
104Program Map Table ver(18) pid(0x32) pnum(1) len(60)
105
106 Stream #0 pid(0x840) type(video-mpeg2  0x2)
107 Stream #1 pid(0x841) type(audio-ac3  0x81)
108  ISO-639 Language: code(eng) canonical(eng) eng(English)
109 Stream #2 pid(0x842) type(caption service  0x86)
110 Stream #3 pid(0x843) type(unknown  0xc0)
111  Registration Descriptor: 'ETV1' CableLabs ETV info is present
112  ATSC Time-shifted Service Descriptor (0xa2) length(0)
113 Stream #4 pid(0x844) type(unknown  0xc0)
114  Registration Descriptor: 'ETV1' CableLabs ETV info is present
115  Service Location Descriptor (0xa1) length(0)
116
1172010-03-15 22:59:01.841 PMT for output stream
1182010-03-15 22:59:01.850 Program Map Table ver(18) pid(0x32) pnum(1) len(60)
119
120 Stream #0 pid(0x840) type(video-mpeg2  0x2)
121 Stream #1 pid(0x841) type(audio-ac3  0x81)
122  ISO-639 Language: code(eng) canonical(eng) eng(English)
123 Stream #2 pid(0x842) type(caption service  0x86)
124 Stream #3 pid(0x843) type(unknown  0xc0)
125  Registration Descriptor: 'ETV1' CableLabs ETV info is present
126  ATSC Time-shifted Service Descriptor (0xa2) length(0)
127 Stream #4 pid(0x844) type(unknown  0xc0)
128  Registration Descriptor: 'ETV1' CableLabs ETV info is present
129  Service Location Descriptor (0xa1) length(0)
130
1312010-03-15 22:59:01.880 SM(192.168.248.4-0)::Stop: end
1322010-03-15 22:59:01.883 HDHRSH(192.168.248.4-0): RemoveListener(0x7fd38c00b780) -- begin
1332010-03-15 22:59:01.885 HDHRSH(192.168.248.4-0): RemoveListener(0x7fd38c00b780) -- locked
1342010-03-15 22:59:01.895 HDHRSH(192.168.248.4-0): RunTS(): shutdown
1352010-03-15 22:59:01.904 HDHRSH(192.168.248.4-0): RunTS(): end
1362010-03-15 22:59:01.912 HDHRSH(192.168.248.4-0): RemoveListener(0x7fd38c00b780) -- end
1372010-03-15 22:59:01.920 HDHRSM(192.168.248.4-0): Stop() -- end
1382010-03-15 22:59:01.929 SM(192.168.248.4-0)::Stop: begin
1392010-03-15 22:59:01.938 SM(192.168.248.4-0)::Stop: end
1402010-03-15 22:59:01.947 TVRec(1): TeardownSignalMonitor() -- end
1412010-03-15 22:59:01.956 TVRec(1): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,
1422010-03-15 22:59:01.965 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,NeedToStartRecorder,
1432010-03-15 22:59:01.975 TVRec(1): Starting Recorder
1442010-03-15 22:59:01.985 Using profile 'Default' to record
1452010-03-15 22:59:01.992 TVRec(1): rec->GetFileName(): '/home/myth-frontend0/mythtv/video/2034_20100315225900.mpg'
1462010-03-15 22:59:02.008 RecBase(1:1): SetRingBuffer(0x7fd38c026240) '/home/myth-frontend0/mythtv/video/2034_20100315225900.mpg'
1472010-03-15 22:59:02.011 HDHRRec(1): SetPAT(103 on 0x32)
1482010-03-15 22:59:02.019 CreatePATSingleProgram()
1492010-03-15 22:59:02.028 PAT in input stream
1502010-03-15 22:59:02.037 Program Association Table
151 PSIP tableID(0x0) length(57) extension(0x8075)
152      version(17) current(1) section(0) last_section(0)
153         tsid: 32885
154 programCount: 12
155  program number   112 has PID 0x  31   data  0x 0 0x70 0xe0 0x31
156  program number   106 has PID 0x  34   data  0x 0 0x6a 0xe0 0x34
157  program number   105 has PID 0x  35   data  0x 0 0x69 0xe0 0x35
158  program number   102 has PID 0x  37   data  0x 0 0x66 0xe0 0x37
159  program number   110 has PID 0x  3a   data  0x 0 0x6e 0xe0 0x3a
160  program number   109 has PID 0x  33   data  0x 0 0x6d 0xe0 0x33
161  program number   104 has PID 0x  3b   data  0x 0 0x68 0xe0 0x3b
162  program number   111 has PID 0x  30   data  0x 0 0x6f 0xe0 0x30
163  program number   108 has PID 0x  38   data  0x 0 0x6c 0xe0 0x38
164  program number   103 has PID 0x  32   data  0x 0 0x67 0xe0 0x32
165  program number   101 has PID 0x  36   data  0x 0 0x65 0xe0 0x36
166  program number   107 has PID 0x  39   data  0x 0 0x6b 0xe0 0x39
167
1682010-03-15 22:59:02.046 desired_program(103) pid(0x32)
1692010-03-15 22:59:02.055 pmt_pid(0x32)
1702010-03-15 22:59:02.064 PAT for output stream
1712010-03-15 22:59:02.073 Program Association Table
172 PSIP tableID(0x0) length(13) extension(0x8075)
173      version(17) current(1) section(0) last_section(0)
174         tsid: 32885
175 programCount: 1
176  program number     1 has PID 0x  32   data  0x 0 0x 1 0xe0 0x32
177
1782010-03-15 22:59:02.082 HDHRRec(1): SetPMT(103)
1792010-03-15 22:59:02.091 CreatePMTSingleProgram()
1802010-03-15 22:59:02.100 PMT in input stream
1812010-03-15 22:59:02.109 Program Map Table ver(18) pid(0x32) pnum(103) len(60)
182
183 Stream #0 pid(0x840) type(video-mpeg2  0x2)
184 Stream #1 pid(0x841) type(audio-ac3  0x81)
185  ISO-639 Language: code(eng) canonical(eng) eng(English)
186 Stream #2 pid(0x842) type(caption service  0x86)
187 Stream #3 pid(0x843) type(unknown  0xc0)
188  Registration Descriptor: 'ETV1' CableLabs ETV info is present
189  ATSC Time-shifted Service Descriptor (0xa2) length(0)
190 Stream #4 pid(0x844) type(unknown  0xc0)
191  Registration Descriptor: 'ETV1' CableLabs ETV info is present
192  Service Location Descriptor (0xa1) length(0)
193
1942010-03-15 22:59:02.118 Created PMT
195Program Map Table ver(18) pid(0x32) pnum(1) len(60)
196
197 Stream #0 pid(0x840) type(video-mpeg2  0x2)
198 Stream #1 pid(0x841) type(audio-ac3  0x81)
199  ISO-639 Language: code(eng) canonical(eng) eng(English)
200 Stream #2 pid(0x842) type(caption service  0x86)
201 Stream #3 pid(0x843) type(unknown  0xc0)
202  Registration Descriptor: 'ETV1' CableLabs ETV info is present
203  ATSC Time-shifted Service Descriptor (0xa2) length(0)
204 Stream #4 pid(0x844) type(unknown  0xc0)
205  Registration Descriptor: 'ETV1' CableLabs ETV info is present
206  Service Location Descriptor (0xa1) length(0)
207
2082010-03-15 22:59:02.127 PMT for output stream
2092010-03-15 22:59:02.136 Program Map Table ver(18) pid(0x32) pnum(1) len(60)
210
211 Stream #0 pid(0x840) type(video-mpeg2  0x2)
212 Stream #1 pid(0x841) type(audio-ac3  0x81)
213  ISO-639 Language: code(eng) canonical(eng) eng(English)
214 Stream #2 pid(0x842) type(caption service  0x86)
215 Stream #3 pid(0x843) type(unknown  0xc0)
216  Registration Descriptor: 'ETV1' CableLabs ETV info is present
217  ATSC Time-shifted Service Descriptor (0xa2) length(0)
218 Stream #4 pid(0x844) type(unknown  0xc0)
219  Registration Descriptor: 'ETV1' CableLabs ETV info is present
220  Service Location Descriptor (0xa1) length(0)
221
2222010-03-15 22:59:02.145 RecBase(1:1): SetRecording(0x1500e20) title(The Daily Show With Jon Stewart)
2232010-03-15 22:59:02.155 HDHRRec(1): StartRecording -- begin
2242010-03-15 22:59:02.163 HDHRSH: Using existing stream handler 192.168.248.4-0 for 192.168.248.4-0 (2 in use)
2252010-03-15 22:59:02.172 HDHRRec(1): HDHR opened successfully
2262010-03-15 22:59:02.181 HDHRSH(192.168.248.4-0): AddListener(0x7fd38c00b780) -- begin
2272010-03-15 22:59:02.185 TVRec(1): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,NeedToStartRecorder,RecorderRunning,RingBufferReady,
2282010-03-15 22:59:02.190 HDHRSH(192.168.248.4-0): AddListener(0x7fd38c00b780) -- locked
2292010-03-15 22:59:02.199 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,RecorderRunning,RingBufferReady,
2302010-03-15 22:59:02.210 HDHRSH(192.168.248.4-0): AddListener(0x7fd38c00b780) -- end
2312010-03-15 22:59:02.274 HDHRSH(192.168.248.4-0): RunTS(): begin
2322010-03-15 22:59:02.306 PID 0x840 Found Payload Start
2332010-03-15 22:59:02.349 PID 0x841 Found Payload Start
2342010-03-15 23:09:20.498 UPnpMedia: BuildMediaMap VIDEO scan starting in :/share/Movies/dvd:
2352010-03-15 23:09:20.504 UPnpMedia: BuildMediaMap Done. Found 0 objects
2362010-03-15 23:10:22.620 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
2372010-03-15 23:24:22.660 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
2382010-03-15 23:28:00.600 Reschedule requested for id 0.
2392010-03-15 23:28:02.387 Scheduled 298 items in 1.8 = 0.01 match + 1.77 place
2402010-03-15 23:28:29.399 TVRec(2): RecordPending on inputid 2
2412010-03-15 23:28:30.175 TVRec(2): ASK_RECORDING 2 29 0 0
2422010-03-15 23:29:01.418 TVRec(2): StartRecording(The Colbert Report)
2432010-03-15 23:29:01.427 TVRec(2): StartedRecording(0x1809200) fn(/home/myth-frontend0/mythtv/video/2034_20100315232900.mpg)
2442010-03-15 23:29:01.444 TVRec(2): ClearFlags(CancelNextRecording,) -> RunMainLoop,
2452010-03-15 23:29:01.446 TVRec(2): Changing from None to RecordingOnly
2462010-03-15 23:29:01.448 TVRec(2): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
2472010-03-15 23:29:01.450 TVRec(2): Request: Program(yes) channel() input() flags(Recording,)
2482010-03-15 23:29:01.453 TVRec(2): HW Tuner: 2->2
2492010-03-15 23:29:01.455 TVRec(2): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,
2502010-03-15 23:29:01.457 TVRec(2): No recorder yet, calling TuningFrequency
2512010-03-15 23:29:01.459 HDHRChan(192.168.248.4-1): Opening HDHR channel
2522010-03-15 23:29:01.464 HDHRChan(192.168.248.4-1): SetChannelByString(68)
2532010-03-15 23:29:01.465 HDHRChan(192.168.248.4-1): Opening HDHR channel
2542010-03-15 23:29:01.471 HDHRChan(192.168.248.4-1): Tuning to qam_256:669000000
2552010-03-15 23:29:01.474 ProgramInfo(): Updated pathname '':'' -> '2034_20100315232900.mpg'
2562010-03-15 23:29:01.475 HDHRSH(192.168.248.4-1): Tuning channel qam_256:669000000 (was qam:669000000)
2572010-03-15 23:29:01.490 HDHRSH::TunerSet() Failed. Trying qam:669000000
2582010-03-15 23:29:01.502 TVRec(2): Starting Signal Monitor
2592010-03-15 23:29:01.510 TVRec(2): SetupSignalMonitor(1, 0)
2602010-03-15 23:29:01.520 HDHRChan(192.168.248.4-1): Opening HDHR channel
2612010-03-15 23:29:01.529 HDHRSM(192.168.248.4-1): ctor
2622010-03-15 23:29:01.539 SM(192.168.248.4-1)::AddFlags: Seen() Match() Wait(Sig,)
2632010-03-15 23:29:01.548 HDHRSH: Using existing stream handler 192.168.248.4-1 for 192.168.248.4-1 (2 in use)
2642010-03-15 23:29:01.557 TVRec(2): Signal monitor successfully created
2652010-03-15 23:29:01.566 TVRec(2): Setting up table monitoring.
2662010-03-15 23:29:01.577 Using profile 'Live TV' to record
2672010-03-15 23:29:01.584 TVRec(2): MPEG program number: 103
2682010-03-15 23:29:01.593 DTVSM(192.168.248.4-1)::SetProgramNumber(103):
2692010-03-15 23:29:01.602 SM(192.168.248.4-1)::RemoveFlags: Seen(PMT,Crypt,) Match(PMT,Crypt,) Wait()
2702010-03-15 23:29:01.611 SM(192.168.248.4-1)::AddFlags: Seen() Match() Wait(PMT,)
2712010-03-15 23:29:01.620 SM(192.168.248.4-1)::AddFlags: Seen() Match() Wait(PAT,PMT,Pos,)
2722010-03-15 23:29:01.629 TVRec(2): Successfully set up MPEG table monitoring.
2732010-03-15 23:29:01.638 SM(192.168.248.4-1)::Start: begin
2742010-03-15 23:29:01.647 SM(192.168.248.4-1)::Start: end
2752010-03-15 23:29:01.656 TVRec(2): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning,
2762010-03-15 23:29:01.665 TVRec(2): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,
2772010-03-15 23:29:01.674 TVRec(2): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,
2782010-03-15 23:29:01.683 TVRec(2): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,
2792010-03-15 23:29:01.692 TVRec(2): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
2802010-03-15 23:29:01.700 HDHRSH(192.168.248.4-1): AddListener(0x14b70e0) -- begin
2812010-03-15 23:29:01.709 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 7 min
2822010-03-15 23:29:01.716 HDHRSH(192.168.248.4-1): AddListener(0x14b70e0) -- locked
2832010-03-15 23:29:01.723 Started recording: The Colbert Report: channel 2034 on cardid 2, sourceid 2
2842010-03-15 23:29:01.727 HDHRSH(192.168.248.4-1): AddListener(0x14b70e0) -- end
2852010-03-15 23:29:01.792 HDHRSH(192.168.248.4-1): RunTS(): begin
2862010-03-15 23:29:01.905 SM(192.168.248.4-1)::AddFlags: Seen(PAT,) Match() Wait()
2872010-03-15 23:29:01.907 SM(192.168.248.4-1)::AddFlags: Seen() Match(PAT,) Wait()
2882010-03-15 23:29:01.908 CreatePATSingleProgram()
2892010-03-15 23:29:01.910 PAT in input stream
2902010-03-15 23:29:01.911 Program Association Table
291 PSIP tableID(0x0) length(57) extension(0x8075)
292      version(17) current(1) section(0) last_section(0)
293         tsid: 32885
294 programCount: 12
295  program number   112 has PID 0x  31   data  0x 0 0x70 0xe0 0x31
296  program number   106 has PID 0x  34   data  0x 0 0x6a 0xe0 0x34
297  program number   105 has PID 0x  35   data  0x 0 0x69 0xe0 0x35
298  program number   102 has PID 0x  37   data  0x 0 0x66 0xe0 0x37
299  program number   110 has PID 0x  3a   data  0x 0 0x6e 0xe0 0x3a
300  program number   109 has PID 0x  33   data  0x 0 0x6d 0xe0 0x33
301  program number   104 has PID 0x  3b   data  0x 0 0x68 0xe0 0x3b
302  program number   111 has PID 0x  30   data  0x 0 0x6f 0xe0 0x30
303  program number   108 has PID 0x  38   data  0x 0 0x6c 0xe0 0x38
304  program number   103 has PID 0x  32   data  0x 0 0x67 0xe0 0x32
305  program number   101 has PID 0x  36   data  0x 0 0x65 0xe0 0x36
306  program number   107 has PID 0x  39   data  0x 0 0x6b 0xe0 0x39
307
3082010-03-15 23:29:01.913 desired_program(103) pid(0x32)
3092010-03-15 23:29:01.914 pmt_pid(0x32)
3102010-03-15 23:29:01.917 PAT for output stream
3112010-03-15 23:29:01.927 Program Association Table
312 PSIP tableID(0x0) length(13) extension(0x8075)
313      version(17) current(1) section(0) last_section(0)
314         tsid: 32885
315 programCount: 1
316  program number     1 has PID 0x  32   data  0x 0 0x 1 0xe0 0x32
317
3182010-03-15 23:29:02.063 SM(192.168.248.4-1)::AddFlags: Seen(PMT,) Match() Wait()
3192010-03-15 23:29:02.064 SM(192.168.248.4-1)::AddFlags: Seen() Match(PMT,) Wait()
3202010-03-15 23:29:02.075 CreatePMTSingleProgram()
3212010-03-15 23:29:02.083 TVRec(2): Got good signal
3222010-03-15 23:29:02.094 TVRec(2): TeardownSignalMonitor() -- begin
3232010-03-15 23:29:02.103 HDHRSM(192.168.248.4-1): dtor
3242010-03-15 23:29:02.114 HDHRSM(192.168.248.4-1): Stop() -- begin
3252010-03-15 23:29:02.122 SM(192.168.248.4-1)::Stop: begin
3262010-03-15 23:29:02.085 PMT in input stream
3272010-03-15 23:29:02.133 SM(192.168.248.4-1)::Stop: end
3282010-03-15 23:29:02.149 HDHRSH(192.168.248.4-1): RemoveListener(0x14b70e0) -- begin
3292010-03-15 23:29:02.140 Program Map Table ver(18) pid(0x32) pnum(103) len(60)
330
331 Stream #0 pid(0x840) type(video-mpeg2  0x2)
332 Stream #1 pid(0x841) type(audio-ac3  0x81)
333  ISO-639 Language: code(eng) canonical(eng) eng(English)
334 Stream #2 pid(0x842) type(caption service  0x86)
335 Stream #3 pid(0x843) type(unknown  0xc0)
336  Registration Descriptor: 'ETV1' CableLabs ETV info is present
337  ATSC Time-shifted Service Descriptor (0xa2) length(0)
338 Stream #4 pid(0x844) type(unknown  0xc0)
339  Registration Descriptor: 'ETV1' CableLabs ETV info is present
340  Service Location Descriptor (0xa1) length(0)
341
3422010-03-15 23:29:02.167 Created PMT
343Program Map Table ver(18) pid(0x32) pnum(1) len(60)
344
345 Stream #0 pid(0x840) type(video-mpeg2  0x2)
346 Stream #1 pid(0x841) type(audio-ac3  0x81)
347  ISO-639 Language: code(eng) canonical(eng) eng(English)
348 Stream #2 pid(0x842) type(caption service  0x86)
349 Stream #3 pid(0x843) type(unknown  0xc0)
350  Registration Descriptor: 'ETV1' CableLabs ETV info is present
351  ATSC Time-shifted Service Descriptor (0xa2) length(0)
352 Stream #4 pid(0x844) type(unknown  0xc0)
353  Registration Descriptor: 'ETV1' CableLabs ETV info is present
354  Service Location Descriptor (0xa1) length(0)
355
3562010-03-15 23:29:02.177 PMT for output stream
3572010-03-15 23:29:02.185 Program Map Table ver(18) pid(0x32) pnum(1) len(60)
358
359 Stream #0 pid(0x840) type(video-mpeg2  0x2)
360 Stream #1 pid(0x841) type(audio-ac3  0x81)
361  ISO-639 Language: code(eng) canonical(eng) eng(English)
362 Stream #2 pid(0x842) type(caption service  0x86)
363 Stream #3 pid(0x843) type(unknown  0xc0)
364  Registration Descriptor: 'ETV1' CableLabs ETV info is present
365  ATSC Time-shifted Service Descriptor (0xa2) length(0)
366 Stream #4 pid(0x844) type(unknown  0xc0)
367  Registration Descriptor: 'ETV1' CableLabs ETV info is present
368  Service Location Descriptor (0xa1) length(0)
369
3702010-03-15 23:29:02.194 HDHRSH(192.168.248.4-1): RemoveListener(0x14b70e0) -- locked
3712010-03-15 23:29:02.205 HDHRSH(192.168.248.4-1): RunTS(): shutdown
3722010-03-15 23:29:02.214 HDHRSH(192.168.248.4-1): RunTS(): end
3732010-03-15 23:29:02.221 HDHRSH(192.168.248.4-1): RemoveListener(0x14b70e0) -- end
3742010-03-15 23:29:02.230 HDHRSM(192.168.248.4-1): Stop() -- end
3752010-03-15 23:29:02.239 SM(192.168.248.4-1)::Stop: begin
3762010-03-15 23:29:02.248 SM(192.168.248.4-1)::Stop: end
3772010-03-15 23:29:02.257 TVRec(2): TeardownSignalMonitor() -- end
3782010-03-15 23:29:02.266 TVRec(2): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,
3792010-03-15 23:29:02.275 TVRec(2): ClearFlags(WaitingForSignal,) -> RunMainLoop,NeedToStartRecorder,
3802010-03-15 23:29:02.285 TVRec(2): Starting Recorder
3812010-03-15 23:29:02.296 Using profile 'Default' to record
3822010-03-15 23:29:02.302 TVRec(2): rec->GetFileName(): '/home/myth-frontend0/mythtv/video/2034_20100315232900.mpg'
3832010-03-15 23:29:02.317 RecBase(2:2): SetRingBuffer(0x16032a0) '/home/myth-frontend0/mythtv/video/2034_20100315232900.mpg'
3842010-03-15 23:29:02.320 HDHRRec(2): SetPAT(103 on 0x32)
3852010-03-15 23:29:02.329 CreatePATSingleProgram()
3862010-03-15 23:29:02.338 PAT in input stream
3872010-03-15 23:29:02.347 Program Association Table
388 PSIP tableID(0x0) length(57) extension(0x8075)
389      version(17) current(1) section(0) last_section(0)
390         tsid: 32885
391 programCount: 12
392  program number   112 has PID 0x  31   data  0x 0 0x70 0xe0 0x31
393  program number   106 has PID 0x  34   data  0x 0 0x6a 0xe0 0x34
394  program number   105 has PID 0x  35   data  0x 0 0x69 0xe0 0x35
395  program number   102 has PID 0x  37   data  0x 0 0x66 0xe0 0x37
396  program number   110 has PID 0x  3a   data  0x 0 0x6e 0xe0 0x3a
397  program number   109 has PID 0x  33   data  0x 0 0x6d 0xe0 0x33
398  program number   104 has PID 0x  3b   data  0x 0 0x68 0xe0 0x3b
399  program number   111 has PID 0x  30   data  0x 0 0x6f 0xe0 0x30
400  program number   108 has PID 0x  38   data  0x 0 0x6c 0xe0 0x38
401  program number   103 has PID 0x  32   data  0x 0 0x67 0xe0 0x32
402  program number   101 has PID 0x  36   data  0x 0 0x65 0xe0 0x36
403  program number   107 has PID 0x  39   data  0x 0 0x6b 0xe0 0x39
404
4052010-03-15 23:29:02.356 desired_program(103) pid(0x32)
4062010-03-15 23:29:02.366 pmt_pid(0x32)
4072010-03-15 23:29:02.374 PAT for output stream
4082010-03-15 23:29:02.383 Program Association Table
409 PSIP tableID(0x0) length(13) extension(0x8075)
410      version(17) current(1) section(0) last_section(0)
411         tsid: 32885
412 programCount: 1
413  program number     1 has PID 0x  32   data  0x 0 0x 1 0xe0 0x32
414
4152010-03-15 23:29:02.392 HDHRRec(2): SetPMT(103)
4162010-03-15 23:29:02.401 CreatePMTSingleProgram()
4172010-03-15 23:29:02.410 PMT in input stream
4182010-03-15 23:29:02.419 Program Map Table ver(18) pid(0x32) pnum(103) len(60)
419
420 Stream #0 pid(0x840) type(video-mpeg2  0x2)
421 Stream #1 pid(0x841) type(audio-ac3  0x81)
422  ISO-639 Language: code(eng) canonical(eng) eng(English)
423 Stream #2 pid(0x842) type(caption service  0x86)
424 Stream #3 pid(0x843) type(unknown  0xc0)
425  Registration Descriptor: 'ETV1' CableLabs ETV info is present
426  ATSC Time-shifted Service Descriptor (0xa2) length(0)
427 Stream #4 pid(0x844) type(unknown  0xc0)
428  Registration Descriptor: 'ETV1' CableLabs ETV info is present
429  Service Location Descriptor (0xa1) length(0)
430
4312010-03-15 23:29:02.428 Created PMT
432Program Map Table ver(18) pid(0x32) pnum(1) len(60)
433
434 Stream #0 pid(0x840) type(video-mpeg2  0x2)
435 Stream #1 pid(0x841) type(audio-ac3  0x81)
436  ISO-639 Language: code(eng) canonical(eng) eng(English)
437 Stream #2 pid(0x842) type(caption service  0x86)
438 Stream #3 pid(0x843) type(unknown  0xc0)
439  Registration Descriptor: 'ETV1' CableLabs ETV info is present
440  ATSC Time-shifted Service Descriptor (0xa2) length(0)
441 Stream #4 pid(0x844) type(unknown  0xc0)
442  Registration Descriptor: 'ETV1' CableLabs ETV info is present
443  Service Location Descriptor (0xa1) length(0)
444
4452010-03-15 23:29:02.437 PMT for output stream
4462010-03-15 23:29:02.446 Program Map Table ver(18) pid(0x32) pnum(1) len(60)
447
448 Stream #0 pid(0x840) type(video-mpeg2  0x2)
449 Stream #1 pid(0x841) type(audio-ac3  0x81)
450  ISO-639 Language: code(eng) canonical(eng) eng(English)
451 Stream #2 pid(0x842) type(caption service  0x86)
452 Stream #3 pid(0x843) type(unknown  0xc0)
453  Registration Descriptor: 'ETV1' CableLabs ETV info is present
454  ATSC Time-shifted Service Descriptor (0xa2) length(0)
455 Stream #4 pid(0x844) type(unknown  0xc0)
456  Registration Descriptor: 'ETV1' CableLabs ETV info is present
457  Service Location Descriptor (0xa1) length(0)
458
4592010-03-15 23:29:02.455 RecBase(2:2): SetRecording(0x1809200) title(The Colbert Report)
4602010-03-15 23:29:02.465 HDHRRec(2): StartRecording -- begin
4612010-03-15 23:29:02.473 HDHRSH: Using existing stream handler 192.168.248.4-1 for 192.168.248.4-1 (2 in use)
4622010-03-15 23:29:02.482 HDHRRec(2): HDHR opened successfully
4632010-03-15 23:29:02.491 HDHRSH(192.168.248.4-1): AddListener(0x14b70e0) -- begin
4642010-03-15 23:29:02.495 TVRec(2): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,NeedToStartRecorder,RecorderRunning,RingBufferReady,
4652010-03-15 23:29:02.500 HDHRSH(192.168.248.4-1): AddListener(0x14b70e0) -- locked
4662010-03-15 23:29:02.509 TVRec(2): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,RecorderRunning,RingBufferReady,
4672010-03-15 23:29:02.521 HDHRSH(192.168.248.4-1): AddListener(0x14b70e0) -- end
4682010-03-15 23:29:02.585 HDHRSH(192.168.248.4-1): RunTS(): begin
4692010-03-15 23:29:02.786 PID 0x840 Found Payload Start
4702010-03-15 23:29:02.819 PID 0x841 Found Payload Start
4712010-03-15 23:33:00.761 Reschedule requested for id 0.
4722010-03-15 23:33:02.491 Scheduled 298 items in 1.7 = 0.01 match + 1.71 place
4732010-03-15 23:34:29.505 TVRec(1): RecordPending on inputid 1
4742010-03-15 23:34:29.652 TVRec(1): ASK_RECORDING 1 29 0 0
4752010-03-15 23:34:30.654 TVRec(1): ClearFlags(FinishRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
4762010-03-15 23:34:30.655 TVRec(1): Changing from RecordingOnly to None
4772010-03-15 23:34:30.657 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
4782010-03-15 23:34:30.658 TVRec(1): Request: Program(no) channel() input() flags(CloseRec,KillRingBuffer,)
4792010-03-15 23:34:30.661 ProgramInfo(): Updated pathname '':'' -> '2034_20100315225900.mpg'
4802010-03-15 23:34:30.662 TVRec(1): FinishedRecording(The Daily Show With Jon Stewart) in recgroup: Default
4812010-03-15 23:34:30.666 Finished recording The Daily Show With Jon Stewart: channel 2034
4822010-03-15 23:34:30.675 ProgramInfo(2034_20100315225900.mpg), Error: Unknown type, recording width was 704
4832010-03-15 23:34:30.718 HDHRRec(1): StartRecording -- ending...
4842010-03-15 23:34:30.721 HDHRSH(192.168.248.4-0): RemoveListener(0x7fd38c00b780) -- begin
4852010-03-15 23:34:30.724 HDHRSH(192.168.248.4-0): RemoveListener(0x7fd38c00b780) -- locked
4862010-03-15 23:34:30.725 ProgramInfo(): Updated pathname '':'' -> '2034_20100315225900.mpg'
4872010-03-15 23:34:30.728 HDHRSH(192.168.248.4-0): RunTS(): shutdown
4882010-03-15 23:34:30.734 HDHRSH(192.168.248.4-0): RunTS(): end
4892010-03-15 23:34:30.736 HDHRSH(192.168.248.4-0): RemoveListener(0x7fd38c00b780) -- end
4902010-03-15 23:34:30.740 HDHRRec(1): Close() -- begin
4912010-03-15 23:34:30.741 HDHRRec(1): Close() -- end
4922010-03-15 23:34:30.747 HDHRRec(1): StartRecording -- end
4932010-03-15 23:34:30.750 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
4942010-03-15 23:34:30.752 HDHRRec(1): Close() -- begin
4952010-03-15 23:34:30.754 HDHRRec(1): Close() -- end
4962010-03-15 23:34:30.756 RecBase(1:1): SetRecording(0x0)
4972010-03-15 23:34:30.762 ProgramInfo(): Updated pathname '':'' -> '2034_20100315225900.mpg'
4982010-03-15 23:34:30.766 TVRec(1): FinishedRecording(The Daily Show With Jon Stewart) in recgroup: Default
4992010-03-15 23:34:30.769 Finished recording The Daily Show With Jon Stewart: channel 2034
5002010-03-15 23:34:30.775 HDHRSH(192.168.248.4-0): Tuning channel none (was qam:669000000)
5012010-03-15 23:34:30.781 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
5022010-03-15 23:34:30.783 HDHRChan(192.168.248.4-0): Closing HDHR channel
5032010-03-15 23:34:30.785 HDHRSH: Closing handler for 192.168.248.4-0
5042010-03-15 23:34:30.787 HDHRSH(192.168.248.4-0): Not Re-Tuning channel none
5052010-03-15 23:34:30.798 ProgramInfo(): Updated pathname '':'' -> '2034_20100315225900.mpg'
5062010-03-15 23:34:30.798 mythbackend version: trunk [exported] www.mythtv.org
5072010-03-15 23:34:30.802 Using runtime prefix = /usr/local
5082010-03-15 23:34:30.803 Using configuration directory = /root/.mythtv
5092010-03-15 23:34:30.805 Empty LocalHostName.
5102010-03-15 23:34:30.809 TVRec(1): Tearing down RingBuffer
5112010-03-15 23:34:30.815 Using localhost value of mythtv.ihtfp.org
5122010-03-15 23:34:30.824 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
5132010-03-15 23:34:30.838 New DB connection, total: 1
5142010-03-15 23:34:30.854 Connected to database 'mythconverg' at host: localhost
5152010-03-15 23:34:30.860 Closing DB connection named 'DBManager0'
5162010-03-15 23:34:30.869 Connected to database 'mythconverg' at host: localhost
5172010-03-15 23:34:30.882 Current MythTV Schema Version (DBSchemaVer): 1254
5182010-03-15 23:34:30.888 ProgramInfo(): Updated pathname '':'' -> '2034_20100315225900.mpg'
5192010-03-15 23:34:31.507 TVRec(1): StartRecording(Late Show With David Letterman)
5202010-03-15 23:34:31.516 TVRec(1): StartedRecording(0x1855600) fn(/mythtv0/video/2461_20100315233500.mpg)
5212010-03-15 23:34:31.532 TVRec(1): ClearFlags(CancelNextRecording,) -> RunMainLoop,RingBufferReady,
5222010-03-15 23:34:31.534 TVRec(1): Changing from None to RecordingOnly
5232010-03-15 23:34:31.536 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RingBufferReady,
5242010-03-15 23:34:31.537 TVRec(1): Request: Program(yes) channel() input() flags(Recording,)
5252010-03-15 23:34:31.540 TVRec(1): HW Tuner: 1->1
5262010-03-15 23:34:31.542 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
5272010-03-15 23:34:31.545 TVRec(1): No recorder yet, calling TuningFrequency
5282010-03-15 23:34:31.555 HDHRChan(192.168.248.4-0): Opening HDHR channel
5292010-03-15 23:34:31.563 ProgramInfo(): Updated pathname '':'' -> '2461_20100315233500.mpg'
5302010-03-15 23:34:31.576 HDHRSH(192.168.248.4-0): Successfully connected to device
5312010-03-15 23:34:31.583 HDHRSH: Creating new stream handler 192.168.248.4-0 for 192.168.248.4-0
5322010-03-15 23:34:31.597 ChannelBase(1): Input #1: 'MPEG2TS' schan(68) sourceid(2) ccid(1)
5332010-03-15 23:34:31.600 ChannelBase(1): Current Input #1: 'MPEG2TS'
5342010-03-15 23:34:31.611 HDHRChan(192.168.248.4-0): SetChannelByString(809)
5352010-03-15 23:34:31.618 HDHRChan(192.168.248.4-0): Opening HDHR channel
5362010-03-15 23:34:31.630 HDHRChan(192.168.248.4-0): Tuning to qam_256:519000000
5372010-03-15 23:34:31.637 HDHRSH(192.168.248.4-0): Tuning channel qam_256:519000000 (was none)
5382010-03-15 23:34:31.646 HDHRSH::TunerSet() Failed. Trying qam:519000000
5392010-03-15 23:34:31.658 TVRec(1): Starting Signal Monitor
5402010-03-15 23:34:31.664 TVRec(1): SetupSignalMonitor(1, 0)
5412010-03-15 23:34:31.672 HDHRChan(192.168.248.4-0): Opening HDHR channel
5422010-03-15 23:34:31.681 HDHRSM(192.168.248.4-0): ctor
5432010-03-15 23:34:31.690 SM(192.168.248.4-0)::AddFlags: Seen() Match() Wait(Sig,)
5442010-03-15 23:34:31.699 HDHRSH: Using existing stream handler 192.168.248.4-0 for 192.168.248.4-0 (2 in use)
5452010-03-15 23:34:31.708 TVRec(1): Signal monitor successfully created
5462010-03-15 23:34:31.717 TVRec(1): Setting up table monitoring.
5472010-03-15 23:34:31.728 Using profile 'Live TV' to record
5482010-03-15 23:34:31.735 TVRec(1): ATSC channel: 46_1
5492010-03-15 23:34:31.744 DTVSM(192.168.248.4-0)::SetChannel(46, 1):
5502010-03-15 23:34:31.753 SM(192.168.248.4-0)::RemoveFlags: Seen(PAT,PMT,VCT,Crypt,) Match(PAT,PMT,VCT,Crypt,) Wait()
5512010-03-15 23:34:31.762 SM(192.168.248.4-0)::AddFlags: Seen() Match() Wait(PAT,VCT,)
5522010-03-15 23:34:31.771 SM(192.168.248.4-0)::AddFlags: Seen() Match() Wait(MGT,)
5532010-03-15 23:34:31.780 TVRec(1): Successfully set up ATSC table monitoring.
5542010-03-15 23:34:31.789 SM(192.168.248.4-0)::Start: begin
5552010-03-15 23:34:31.798 SM(192.168.248.4-0)::Start: end
5562010-03-15 23:34:31.807 TVRec(1): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady,
5572010-03-15 23:34:31.816 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady,
5582010-03-15 23:34:31.825 TVRec(1): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady,
5592010-03-15 23:34:31.834 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady,
5602010-03-15 23:34:31.843 TVRec(1): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,RingBufferReady,
5612010-03-15 23:34:31.860 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 7 min
5622010-03-15 23:34:31.868 Started recording: Late Show With David Letterman: channel 2461 on cardid 1, sourceid 2
5632010-03-15 23:34:31.955 HDHRSH(192.168.248.4-0): AddListener(0x1703d48) -- begin
5642010-03-15 23:34:31.956 HDHRSH(192.168.248.4-0): AddListener(0x1703d48) -- locked
5652010-03-15 23:34:31.958 HDHRSH(192.168.248.4-0): AddListener(0x1703d48) -- end
5662010-03-15 23:34:32.023 HDHRSH(192.168.248.4-0): RunTS(): begin
5672010-03-15 23:34:32.051 SM(192.168.248.4-0)::AddFlags: Seen(MGT,) Match() Wait()
5682010-03-15 23:34:32.052 SM(192.168.248.4-0)::AddFlags: Seen() Match(MGT,) Wait()
5692010-03-15 23:34:32.270 SM(192.168.248.4-0)::AddFlags: Seen(PAT,) Match() Wait()
5702010-03-15 23:34:32.271 SM(192.168.248.4-0)::AddFlags: Seen(VCT,CVCT,) Match() Wait()
5712010-03-15 23:34:32.273 DTVSM(192.168.248.4-0)::SetVCT(): cvct->ProgramNumber(idx 0): prog num 10
5722010-03-15 23:34:32.274 DTVSM(192.168.248.4-0)::SetProgramNumber(10):
5732010-03-15 23:34:32.276 SM(192.168.248.4-0)::RemoveFlags: Seen(PMT,Crypt,) Match(PMT,Crypt,) Wait()
5742010-03-15 23:34:32.277 SM(192.168.248.4-0)::AddFlags: Seen(PAT,) Match() Wait()
5752010-03-15 23:34:32.286 SM(192.168.248.4-0)::AddFlags: Seen() Match(PAT,) Wait()
5762010-03-15 23:34:32.295 CreatePATSingleProgram()
5772010-03-15 23:34:32.304 PAT in input stream
5782010-03-15 23:34:32.313 Program Association Table
579 PSIP tableID(0x0) length(25) extension(0x409)
580      version(2) current(1) section(0) last_section(0)
581         tsid: 1033
582 programCount: 4
583  program number    10 has PID 0x  a0   data  0x 0 0x a 0xe0 0xa0
584  program number    30 has PID 0x  30   data  0x 0 0x1e 0xe0 0x30
585  program number   211 has PID 0x  40   data  0x 0 0xd3 0xe0 0x40
586  program number   245 has PID 0x  50   data  0x 0 0xf5 0xe0 0x50
587
5882010-03-15 23:34:32.322 desired_program(10) pid(0xa0)
5892010-03-15 23:34:32.331 pmt_pid(0xa0)
5902010-03-15 23:34:32.340 PAT for output stream
5912010-03-15 23:34:32.349 Program Association Table
592 PSIP tableID(0x0) length(13) extension(0x409)
593      version(2) current(1) section(0) last_section(0)
594         tsid: 1033
595 programCount: 1
596  program number     1 has PID 0x  a0   data  0x 0 0x 1 0xe0 0xa0
597
5982010-03-15 23:34:32.358 SM(192.168.248.4-0)::AddFlags: Seen() Match() Wait(PMT,)
5992010-03-15 23:34:32.367 SM(192.168.248.4-0)::AddFlags: Seen() Match(VCT,CVCT,) Wait()
6002010-03-15 23:34:32.508 SM(192.168.248.4-0)::AddFlags: Seen(PMT,) Match() Wait()
6012010-03-15 23:34:32.510 SM(192.168.248.4-0)::AddFlags: Seen() Match(PMT,) Wait()
6022010-03-15 23:34:32.511 CreatePMTSingleProgram()
6032010-03-15 23:34:32.520 PMT in input stream
6042010-03-15 23:34:32.529 Program Map Table ver(25) pid(0xa0) pnum(10) len(29)
605
606 Stream #0 pid(0xa1) type(video-mpeg2  0x2)
607 Stream #1 pid(0xa4) type(audio-ac3  0x81)
608  ISO-639 Language: code(eng) canonical(eng) eng(English)
609
6102010-03-15 23:34:32.539 Created PMT
611Program Map Table ver(25) pid(0xa0) pnum(1) len(29)
612
613 Stream #0 pid(0xa1) type(video-mpeg2  0x2)
614 Stream #1 pid(0xa4) type(audio-ac3  0x81)
615  ISO-639 Language: code(eng) canonical(eng) eng(English)
616
6172010-03-15 23:34:32.548 PMT for output stream
6182010-03-15 23:34:32.558 Program Map Table ver(25) pid(0xa0) pnum(1) len(29)
619
620 Stream #0 pid(0xa1) type(video-mpeg2  0x2)
621 Stream #1 pid(0xa4) type(audio-ac3  0x81)
622  ISO-639 Language: code(eng) canonical(eng) eng(English)
623
6242010-03-15 23:34:32.560 TVRec(1): Got good signal
6252010-03-15 23:34:32.570 TVRec(1): TeardownSignalMonitor() -- begin
6262010-03-15 23:34:32.578 HDHRSM(192.168.248.4-0): dtor
6272010-03-15 23:34:32.587 HDHRSM(192.168.248.4-0): Stop() -- begin
6282010-03-15 23:34:32.596 SM(192.168.248.4-0)::Stop: begin
6292010-03-15 23:34:32.610 SM(192.168.248.4-0)::Stop: end
6302010-03-15 23:34:32.615 HDHRSH(192.168.248.4-0): RemoveListener(0x1703d48) -- begin
6312010-03-15 23:34:32.623 HDHRSH(192.168.248.4-0): RemoveListener(0x1703d48) -- locked
6322010-03-15 23:34:32.634 HDHRSH(192.168.248.4-0): RunTS(): shutdown
6332010-03-15 23:34:32.643 HDHRSH(192.168.248.4-0): RunTS(): end
6342010-03-15 23:34:32.650 HDHRSH(192.168.248.4-0): RemoveListener(0x1703d48) -- end
6352010-03-15 23:34:32.659 HDHRSM(192.168.248.4-0): Stop() -- end
6362010-03-15 23:34:32.668 SM(192.168.248.4-0)::Stop: begin
6372010-03-15 23:34:32.677 SM(192.168.248.4-0)::Stop: end
6382010-03-15 23:34:32.686 TVRec(1): TeardownSignalMonitor() -- end
6392010-03-15 23:34:32.695 TVRec(1): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,RingBufferReady,
6402010-03-15 23:34:32.704 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,NeedToStartRecorder,RingBufferReady,
6412010-03-15 23:34:32.714 TVRec(1): Starting Recorder
6422010-03-15 23:34:32.724 Using profile 'Default' to record
6432010-03-15 23:34:32.731 TVRec(1): rec->GetFileName(): '/mythtv0/video/2461_20100315233500.mpg'
6442010-03-15 23:34:32.746 RecBase(1:1): SetRingBuffer(0x7fd38c01fd10) '/mythtv0/video/2461_20100315233500.mpg'
6452010-03-15 23:34:32.749 HDHRRec(1): SetPAT(10 on 0xa0)
6462010-03-15 23:34:32.758 CreatePATSingleProgram()
6472010-03-15 23:34:32.767 PAT in input stream
6482010-03-15 23:34:32.776 Program Association Table
649 PSIP tableID(0x0) length(25) extension(0x409)
650      version(2) current(1) section(0) last_section(0)
651         tsid: 1033
652 programCount: 4
653  program number    10 has PID 0x  a0   data  0x 0 0x a 0xe0 0xa0
654  program number    30 has PID 0x  30   data  0x 0 0x1e 0xe0 0x30
655  program number   211 has PID 0x  40   data  0x 0 0xd3 0xe0 0x40
656  program number   245 has PID 0x  50   data  0x 0 0xf5 0xe0 0x50
657
6582010-03-15 23:34:32.785 desired_program(10) pid(0xa0)
6592010-03-15 23:34:32.794 pmt_pid(0xa0)
6602010-03-15 23:34:32.803 PAT for output stream
6612010-03-15 23:34:32.812 Program Association Table
662 PSIP tableID(0x0) length(13) extension(0x409)
663      version(2) current(1) section(0) last_section(0)
664         tsid: 1033
665 programCount: 1
666  program number     1 has PID 0x  a0   data  0x 0 0x 1 0xe0 0xa0
667
6682010-03-15 23:34:32.821 HDHRRec(1): SetPMT(10)
6692010-03-15 23:34:32.830 CreatePMTSingleProgram()
6702010-03-15 23:34:32.839 PMT in input stream
6712010-03-15 23:34:32.848 Program Map Table ver(25) pid(0xa0) pnum(10) len(29)
672
673 Stream #0 pid(0xa1) type(video-mpeg2  0x2)
674 Stream #1 pid(0xa4) type(audio-ac3  0x81)
675  ISO-639 Language: code(eng) canonical(eng) eng(English)
676
6772010-03-15 23:34:32.857 Created PMT
678Program Map Table ver(25) pid(0xa0) pnum(1) len(29)
679
680 Stream #0 pid(0xa1) type(video-mpeg2  0x2)
681 Stream #1 pid(0xa4) type(audio-ac3  0x81)
682  ISO-639 Language: code(eng) canonical(eng) eng(English)
683
6842010-03-15 23:34:32.866 PMT for output stream
6852010-03-15 23:34:32.875 Program Map Table ver(25) pid(0xa0) pnum(1) len(29)
686
687 Stream #0 pid(0xa1) type(video-mpeg2  0x2)
688 Stream #1 pid(0xa4) type(audio-ac3  0x81)
689  ISO-639 Language: code(eng) canonical(eng) eng(English)
690
6912010-03-15 23:34:32.883 Reschedule requested for id 0.
6922010-03-15 23:34:32.885 RecBase(1:1): SetRecording(0x1855600) title(Late Show With David Letterman)
6932010-03-15 23:34:32.910 HDHRRec(1): StartRecording -- begin
6942010-03-15 23:34:32.918 HDHRSH: Using existing stream handler 192.168.248.4-0 for 192.168.248.4-0 (2 in use)
6952010-03-15 23:34:32.920 HDHRRec(1): HDHR opened successfully
6962010-03-15 23:34:32.921 HDHRSH(192.168.248.4-0): AddListener(0x1703d48) -- begin
6972010-03-15 23:34:32.923 HDHRSH(192.168.248.4-0): AddListener(0x1703d48) -- locked
6982010-03-15 23:34:32.925 HDHRSH(192.168.248.4-0): AddListener(0x1703d48) -- end
6992010-03-15 23:34:32.925 TVRec(1): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,NeedToStartRecorder,RecorderRunning,RingBufferReady,
7002010-03-15 23:34:32.930 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,RecorderRunning,RingBufferReady,
7012010-03-15 23:34:32.989 HDHRSH(192.168.248.4-0): RunTS(): begin
7022010-03-15 23:34:33.014 AddTSPacket: Out of sync!!! Need to wait for next payloadStart PID: 0x1ffb, continuity counter: 8 (expected 6).
7032010-03-15 23:34:33.165 PID 0xa1 Found Payload Start
7042010-03-15 23:34:33.188 PID 0xa4 Found Payload Start
7052010-03-15 23:34:33.337 AFD: Opened codec 0x1c01e00, id(MPEG2VIDEO) type(Video)
7062010-03-15 23:34:33.339 AFD: codec AC3 has 2 channels
7072010-03-15 23:34:33.341 AFD: Opened codec 0x1c02240, id(AC3) type(Audio)
7082010-03-15 23:34:33.431 Preview: Grabbed preview '/home/myth-frontend0/mythtv/video/2034_20100315225900.mpg' 704x480@124s
7092010-03-15 23:34:33.530 ~MythContext waiting for threads to exit.
7102010-03-15 23:34:34.633 Scheduled 297 items in 1.7 = 0.01 match + 1.73 place
7112010-03-15 23:38:22.710 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 7 min
7122010-03-15 23:39:24.506 UPnpMedia: BuildMediaMap VIDEO scan starting in :/share/Movies/dvd:
7132010-03-15 23:39:24.509 UPnpMedia: BuildMediaMap Done. Found 0 objects
7142010-03-15 23:45:22.758 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 7 min
7152010-03-15 23:52:22.809 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 7 min
7162010-03-15 23:59:22.853 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 7 min
7172010-03-16 00:03:30.725 TVRec(2): ClearFlags(FinishRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
7182010-03-16 00:03:30.732 TVRec(2): Changing from RecordingOnly to None
7192010-03-16 00:03:30.733 TVRec(2): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
7202010-03-16 00:03:30.735 TVRec(2): Request: Program(no) channel() input() flags(CloseRec,KillRingBuffer,)
7212010-03-16 00:03:30.739 ProgramInfo(): Updated pathname '':'' -> '2034_20100315232900.mpg'
7222010-03-16 00:03:30.740 TVRec(2): FinishedRecording(The Colbert Report) in recgroup: Default
7232010-03-16 00:03:30.742 Finished recording The Colbert Report: channel 2034
7242010-03-16 00:03:30.809 ProgramInfo(2034_20100315232900.mpg), Error: Unknown type, recording width was 704
7252010-03-16 00:03:30.863 ProgramInfo(): Updated pathname '':'' -> '2034_20100315232900.mpg'
7262010-03-16 00:03:30.874 Reschedule requested for id 0.
7272010-03-16 00:03:30.888 HDHRRec(2): StartRecording -- ending...
7282010-03-16 00:03:30.896 HDHRSH(192.168.248.4-1): RemoveListener(0x14b70e0) -- begin
7292010-03-16 00:03:30.897 HDHRSH(192.168.248.4-1): RemoveListener(0x14b70e0) -- locked
7302010-03-16 00:03:30.901 HDHRSH(192.168.248.4-1): RunTS(): shutdown
7312010-03-16 00:03:30.906 HDHRSH(192.168.248.4-1): RunTS(): end
7322010-03-16 00:03:30.909 HDHRSH(192.168.248.4-1): RemoveListener(0x14b70e0) -- end
7332010-03-16 00:03:30.911 HDHRRec(2): Close() -- begin
7342010-03-16 00:03:30.914 HDHRRec(2): Close() -- end
7352010-03-16 00:03:30.982 HDHRRec(2): StartRecording -- end
7362010-03-16 00:03:30.984 TVRec(2): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
7372010-03-16 00:03:30.986 HDHRRec(2): Close() -- begin
7382010-03-16 00:03:30.988 HDHRRec(2): Close() -- end
7392010-03-16 00:03:30.990 RecBase(2:2): SetRecording(0x0)
7402010-03-16 00:03:30.994 ProgramInfo(): Updated pathname '':'' -> '2034_20100315232900.mpg'
7412010-03-16 00:03:30.996 TVRec(2): FinishedRecording(The Colbert Report) in recgroup: Default
7422010-03-16 00:03:30.999 Finished recording The Colbert Report: channel 2034
7432010-03-16 00:03:31.002 HDHRSH(192.168.248.4-1): Tuning channel none (was qam:519000000)
7442010-03-16 00:03:31.079 mythbackend version: trunk [exported] www.mythtv.org
7452010-03-16 00:03:31.033 ProgramInfo(): Updated pathname '':'' -> '2034_20100315232900.mpg'
7462010-03-16 00:03:31.083 Using runtime prefix = /usr/local
7472010-03-16 00:03:31.080 TVRec(2): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
7482010-03-16 00:03:31.088 Using configuration directory = /root/.mythtv
7492010-03-16 00:03:31.091 HDHRChan(192.168.248.4-1): Closing HDHR channel
7502010-03-16 00:03:31.093 Empty LocalHostName.
7512010-03-16 00:03:31.096 HDHRSH: Closing handler for 192.168.248.4-1
7522010-03-16 00:03:31.098 Using localhost value of mythtv.ihtfp.org
7532010-03-16 00:03:31.100 HDHRSH(192.168.248.4-1): Not Re-Tuning channel none
7542010-03-16 00:03:31.107 New DB connection, total: 1
7552010-03-16 00:03:31.112 TVRec(2): Tearing down RingBuffer
7562010-03-16 00:03:31.118 Connected to database 'mythconverg' at host: localhost
7572010-03-16 00:03:31.124 TVRec(2): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
7582010-03-16 00:03:31.133 Closing DB connection named 'DBManager0'
7592010-03-16 00:03:31.151 Connected to database 'mythconverg' at host: localhost
7602010-03-16 00:03:31.163 Current MythTV Schema Version (DBSchemaVer): 1254
7612010-03-16 00:03:31.170 ProgramInfo(): Updated pathname '':'' -> '2034_20100315232900.mpg'
7622010-03-16 00:03:32.601 Scheduled 296 items in 1.7 = 0.00 match + 1.71 place
7632010-03-16 00:03:33.681 AFD: Opened codec 0x7f3d3fd42ba0, id(MPEG2VIDEO) type(Video)
7642010-03-16 00:03:33.684 AFD: codec AC3 has 2 channels
7652010-03-16 00:03:33.686 AFD: Opened codec 0x7f3d3fd5fcf0, id(AC3) type(Audio)
7662010-03-16 00:03:33.769 Preview: Grabbed preview '/home/myth-frontend0/mythtv/video/2034_20100315232900.mpg' 704x480@124s
7672010-03-16 00:03:34.041 ~MythContext waiting for threads to exit.
7682010-03-16 00:06:22.894 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
7692010-03-16 00:09:26.511 UPnpMedia: BuildMediaMap VIDEO scan starting in :/share/Movies/dvd:
7702010-03-16 00:09:26.512 UPnpMedia: BuildMediaMap Done. Found 0 objects
7712010-03-16 00:20:22.942 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
7722010-03-16 00:34:22.981 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
7732010-03-16 00:38:30.743 TVRec(1): ClearFlags(FinishRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
7742010-03-16 00:38:30.744 TVRec(1): Changing from RecordingOnly to None
7752010-03-16 00:38:30.746 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
7762010-03-16 00:38:30.748 TVRec(1): Request: Program(no) channel() input() flags(CloseRec,KillRingBuffer,)
7772010-03-16 00:38:30.750 ProgramInfo(): Updated pathname '':'' -> '2461_20100315233500.mpg'
7782010-03-16 00:38:30.759 TVRec(1): FinishedRecording(Late Show With David Letterman) in recgroup: Default
7792010-03-16 00:38:30.768 Finished recording Late Show With David Letterman: channel 2461
7802010-03-16 00:38:30.793 Reschedule requested for id 0.
7812010-03-16 00:38:30.795 ProgramInfo(2461_20100315233500.mpg): Recording designated 1080i/p because width was 1920
7822010-03-16 00:38:30.845 ProgramInfo(): Updated pathname '':'' -> '2461_20100315233500.mpg'
7832010-03-16 00:38:30.877 HDHRRec(1): StartRecording -- ending...
7842010-03-16 00:38:30.880 HDHRSH(192.168.248.4-0): RemoveListener(0x1703d48) -- begin
7852010-03-16 00:38:30.882 HDHRSH(192.168.248.4-0): RemoveListener(0x1703d48) -- locked
7862010-03-16 00:38:30.884 HDHRSH(192.168.248.4-0): RunTS(): shutdown
7872010-03-16 00:38:30.890 HDHRSH(192.168.248.4-0): RunTS(): end
7882010-03-16 00:38:30.892 HDHRSH(192.168.248.4-0): RemoveListener(0x1703d48) -- end
7892010-03-16 00:38:30.894 HDHRRec(1): Close() -- begin
7902010-03-16 00:38:30.896 HDHRRec(1): Close() -- end
7912010-03-16 00:38:30.900 ProgramInfo(): Updated pathname '':'' -> '2461_20100315233500.mpg'
7922010-03-16 00:38:30.902 HDHRRec(1): StartRecording -- end
7932010-03-16 00:38:30.906 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
7942010-03-16 00:38:30.909 HDHRRec(1): Close() -- begin
7952010-03-16 00:38:30.911 HDHRRec(1): Close() -- end
7962010-03-16 00:38:30.912 RecBase(1:1): SetRecording(0x0)
7972010-03-16 00:38:30.928 ProgramInfo(): Updated pathname '':'' -> '2461_20100315233500.mpg'
7982010-03-16 00:38:30.949 TVRec(1): FinishedRecording(Late Show With David Letterman) in recgroup: Default
7992010-03-16 00:38:30.952 Finished recording Late Show With David Letterman: channel 2461
8002010-03-16 00:38:30.949 mythbackend version: trunk [exported] www.mythtv.org
8012010-03-16 00:38:30.955 HDHRSH(192.168.248.4-0): Not Re-Tuning channel none
8022010-03-16 00:38:30.962 Using runtime prefix = /usr/local
8032010-03-16 00:38:30.964 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
8042010-03-16 00:38:30.967 Using configuration directory = /root/.mythtv
8052010-03-16 00:38:30.971 HDHRChan(192.168.248.4-0): Closing HDHR channel
8062010-03-16 00:38:30.974 Empty LocalHostName.
8072010-03-16 00:38:30.979 HDHRSH: Closing handler for 192.168.248.4-0
8082010-03-16 00:38:30.983 Using localhost value of mythtv.ihtfp.org
8092010-03-16 00:38:30.986 HDHRSH(192.168.248.4-0): Not Re-Tuning channel none
8102010-03-16 00:38:30.994 New DB connection, total: 1
8112010-03-16 00:38:31.002 Connected to database 'mythconverg' at host: localhost
8122010-03-16 00:38:31.004 Closing DB connection named 'DBManager0'
8132010-03-16 00:38:31.005 ProgramInfo(): Updated pathname '':'' -> '2461_20100315233500.mpg'
8142010-03-16 00:38:31.013 Connected to database 'mythconverg' at host: localhost
8152010-03-16 00:38:31.017 TVRec(1): Tearing down RingBuffer
8162010-03-16 00:38:31.034 Current MythTV Schema Version (DBSchemaVer): 1254
8172010-03-16 00:38:31.040 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
8182010-03-16 00:38:31.049 ProgramInfo(): Updated pathname '':'' -> '2461_20100315233500.mpg'
8192010-03-16 00:38:32.547 Scheduled 294 items in 1.7 = 0.01 match + 1.73 place
8202010-03-16 00:38:33.597 AFD: Opened codec 0x20e3cf0, id(MPEG2VIDEO) type(Video)
8212010-03-16 00:38:33.599 AFD: codec AC3 has 6 channels
8222010-03-16 00:38:33.600 AFD: Opened codec 0x2100f40, id(AC3) type(Audio)
8232010-03-16 00:38:33.844 Preview: Grabbed preview '/mythtv0/video/2461_20100315233500.mpg' 1920x1088@124s
8242010-03-16 00:38:34.003 ~MythContext waiting for threads to exit.
8252010-03-16 00:39:28.515 UPnpMedia: BuildMediaMap VIDEO scan starting in :/share/Movies/dvd:
8262010-03-16 00:39:28.516 UPnpMedia: BuildMediaMap Done. Found 0 objects