Ticket #706: backend.log.failure.txt

File backend.log.failure.txt, 27.9 KB (added by Jon Whitear, 20 years ago)

Backend log (zero byte recording from channel 10)

Line 
12005-11-24 15:06:07.051 TVRec(1): ClearFlags(AskAllowRecording,) -> RunMainLoop,
22005-11-24 15:06:07.107 DB Error (Copy program data on record):
3Query was:
4REPLACE INTO recordedprogram SELECT * from program WHERE chanid = '1010' AND starttime = '2005-11-24T15:00:00';
5Driver error was [2/1136]:
6QMYSQL3: Unable to execute query
7Database error was:
8Column count doesn't match value count at row 1
9
102005-11-24 15:06:07.110 TVRec(1): StartedRecording(0x8139e78) fn(/var/media/video/1010_20051124150600.mpg)
112005-11-24 15:06:07.111 TVRec(1): ClearFlags(CancelNextRecording,) -> RunMainLoop,
122005-11-24 15:06:07.111 TVRec(1): Changing from None to RecordingOnly
132005-11-24 15:06:07.112 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
142005-11-24 15:06:07.112 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,
152005-11-24 15:06:07.113 TVRec(1): Request: Program(yes) channel() input() flags(Recording,)
162005-11-24 15:06:07.113 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,
172005-11-24 15:06:07.115 DVB#0 Opening DVB channel
182005-11-24 15:06:07.116 DVB#0 SetChannelByString(10)
192005-11-24 15:06:07.120 DVB#0 Frequency: 219500000 BW: 7MHz HP: 3/4 LP: 1/2C: QAM-64 TM: 8K H: None GI: 1/16
202005-11-24 15:06:07.120 DVB#0 Old Params: freq(571500000) type(OFDM)
212005-11-24 15:06:07.121 DVB#0 New Params: freq(219500000) type(OFDM)
222005-11-24 15:06:07.148 dvbchannel.cpp:wait_for_backend: Status: Signal,
232005-11-24 15:06:07.148 DVB#0 DVBChannel::Tune: Frequency tuning successful.
242005-11-24 15:06:07.148 DVB#0 Tuned to frequency for channel 10.
252005-11-24 15:06:07.149 TVRec(1): Starting Signal Monitor
262005-11-24 15:06:07.149 TVRec(1): SetupSignalMonitor(1, 0)
272005-11-24 15:06:07.149 DVB#0 Opening DVB channel
282005-11-24 15:06:07.172 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,BER,UB,)
292005-11-24 15:06:07.173 DVBSM(0)::constructor(): initial flags 0x7400000
302005-11-24 15:06:07.173 TVRec(1): Signal monitor successfully created
312005-11-24 15:06:07.173 TVRec(1): Setting up table monitoring.
322005-11-24 15:06:07.173 TVRec(1): MPEG program number: 1573
332005-11-24 15:06:07.175 DTVSM(0)::SetProgramNumber(1573):
342005-11-24 15:06:07.176 SM(0)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait()
352005-11-24 15:06:07.176 SM(0)::AddFlags: Seen() Match() Wait(PMT,)
362005-11-24 15:06:07.176 SM(0)::AddFlags: Seen() Match() Wait(PAT,PMT,)
372005-11-24 15:06:07.177 TVRec(1): Successfully set up MPEG table monitoring.
382005-11-24 15:06:07.177 SM(0)::Start: begin
392005-11-24 15:06:07.200 SM(0)::Start: end
402005-11-24 15:06:07.201 TVRec(1): SetFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning,
412005-11-24 15:06:07.201 TVRec(1): SetFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,
422005-11-24 15:06:07.201 TVRec(1): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
432005-11-24 15:06:07.205 Started recording: Huey's Cooking Adventures: channel 1010 on cardid 1, sourceid 1
442005-11-24 15:06:07.358 DVBSM(0)::UpdateValues: Signal Locked
452005-11-24 15:06:07.368 DVBSM(0)::UpdateValues: Waiting for table monitor to start
462005-11-24 15:06:07.368 DVBSM(0)::UpdateValues: Table monitor started
472005-11-24 15:06:07.375 DVBSM(0): RunTableMonitorTS(): begin (# of pids 2)
482005-11-24 15:06:07.376 DVBSM(0)::AddPIDFilter(0x0):
492005-11-24 15:06:07.381 DVBSM(0)::AddPIDFilter(0x1ffb):
502005-11-24 15:06:07.492 SM(0)::AddFlags: Seen(PAT,) Match() Wait()
512005-11-24 15:06:07.492 SM(0)::AddFlags: Seen() Match(PAT,) Wait()
522005-11-24 15:06:07.493 CreatePATSingleProgram()
532005-11-24 15:06:07.493 PAT in input stream
542005-11-24 15:06:07.493 Program Association Table
55 PSIP prefix(0x0) tableID(0x0) length(45) extension(0x602)
56 version(16) current(1) section(0) last_section(0)
57 tsid: 1538
58 programCount: 9
59 program number 0 has PID 0x 10 data 0x0 0x0 0x224 0x16
60 program number 1569 has PID 0x 101 data 0x6 0x33 0x225 0x1
61 program number 1570 has PID 0x 102 data 0x6 0x34 0x225 0x2
62 program number 1571 has PID 0x 103 data 0x6 0x35 0x225 0x3
63 program number 1572 has PID 0x 104 data 0x6 0x36 0x225 0x4
64 program number 1573 has PID 0x 100 data 0x6 0x37 0x225 0x0
65 program number 1575 has PID 0x 106 data 0x6 0x39 0x225 0x6
66 program number 1576 has PID 0x 107 data 0x6 0x40 0x225 0x7
67 program number 1577 has PID 0x 108 data 0x6 0x41 0x225 0x8
68
692005-11-24 15:06:07.494 desired_program(1573) pid(0x100)
702005-11-24 15:06:07.495 pmt_pid(0x100)
712005-11-24 15:06:07.495 PAT for output stream
722005-11-24 15:06:07.495 Program Association Table
73 PSIP prefix(0x0) tableID(0x0) length(13) extension(0x602)
74 version(16) current(1) section(0) last_section(0)
75 tsid: 1538
76 programCount: 1
77 program number 1 has PID 0x 100 data 0x0 0x1 0x225 0x0
78
792005-11-24 15:06:07.495 DVBSM(0)::AddPIDFilter(0x100):
802005-11-24 15:06:07.604 Parsed PMT(0x0x8181c18) Program Map Table ver(16) pid(0x100) pnum(1573)
81 Unknown Descriptor (0xb) length(2)
82 Unknown Descriptor (0x10) length(6)
83
84 Stream #0 pid(0x200) type(video-mpeg2 0x2)
85 Unknown Descriptor (0x2) length(3)
86 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3] 0x4)
87 Unknown Descriptor (0x3) length(1)
88 ISO-639 Language Descriptor (0xa) length(4)
89 Stream #2 pid(0x28b) type(private-data 0x6)
90 AC-3 Descriptor (0x6a) length(3)
91 ISO-639 Language Descriptor (0xa) length(4)
92 Stream #3 pid(0x240) type(private-data 0x6)
93 Teletext Descriptor (0x56) length(5)
94
952005-11-24 15:06:07.605 SM(0)::AddFlags: Seen(PMT,) Match() Wait()
962005-11-24 15:06:07.605 SM(0)::AddFlags: Seen() Match(PMT,) Wait()
972005-11-24 15:06:07.606 CreatePMTSingleProgram()
982005-11-24 15:06:07.606 PMT in input stream
992005-11-24 15:06:07.606 Program Map Table ver(16) pid(0x100) pnum(1573)
100 Unknown Descriptor (0xb) length(2)
101 Unknown Descriptor (0x10) length(6)
102
103 Stream #0 pid(0x200) type(video-mpeg2 0x2)
104 Unknown Descriptor (0x2) length(3)
105 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3] 0x4)
106 Unknown Descriptor (0x3) length(1)
107 ISO-639 Language Descriptor (0xa) length(4)
108 Stream #2 pid(0x28b) type(private-data 0x6)
109 AC-3 Descriptor (0x6a) length(3)
110 ISO-639 Language Descriptor (0xa) length(4)
111 Stream #3 pid(0x240) type(private-data 0x6)
112 Teletext Descriptor (0x56) length(5)
113
1142005-11-24 15:06:07.607 Parsed PMT(0x0x8181c18) Program Map Table ver(16) pid(0x100) pnum(1573)
115 Unknown Descriptor (0xb) length(2)
116 Unknown Descriptor (0x10) length(6)
117
118 Stream #0 pid(0x200) type(video-mpeg2 0x2)
119 Unknown Descriptor (0x2) length(3)
120 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3] 0x4)
121 Unknown Descriptor (0x3) length(1)
122 ISO-639 Language Descriptor (0xa) length(4)
123 Stream #2 pid(0x28b) type(private-data 0x6)
124 AC-3 Descriptor (0x6a) length(3)
125 ISO-639 Language Descriptor (0xa) length(4)
126 Stream #3 pid(0x240) type(private-data 0x6)
127 Teletext Descriptor (0x56) length(5)
128
1292005-11-24 15:06:07.608 Parsed PMT(0x0x8182140) Program Map Table ver(0) pid(0x0) pnum(0)
130
131
1322005-11-24 15:06:07.609 PMT for output stream
1332005-11-24 15:06:07.609 Program Map Table ver(16) pid(0x100) pnum(1)
134
135 Stream #0 pid(0x200) type(video-mpeg2 0x2)
136 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3] 0x4)
137 Stream #2 pid(0x28b) type(private-data 0x6)
138
1392005-11-24 15:06:07.648 TVRec(1): Got good signal
1402005-11-24 15:06:07.648 TVRec(1): MPEG program num(1573)
1412005-11-24 15:06:07.648 TVRec(1): TeardownSignalMonitor() -- begin
1422005-11-24 15:06:07.649 DVBSM(0)::Stop: begin
1432005-11-24 15:06:07.649 SM(0)::Stop: begin
1442005-11-24 15:06:07.704 SM(0)::Stop: end
1452005-11-24 15:06:07.712 DVBSM(0): RunTableMonitorTS(): shutdown
1462005-11-24 15:06:07.712 DVBSM(0)::RemovePIDFilter(0x0):
1472005-11-24 15:06:07.712 DVBSM(0)::RemovePIDFilter(0x100):
1482005-11-24 15:06:07.713 DVBSM(0)::RemovePIDFilter(0x1ffb):
1492005-11-24 15:06:07.975 DVBSM(0): RunTableMonitorTS(): end
1502005-11-24 15:06:07.976 DVBSM(0)::Stop: end
1512005-11-24 15:06:07.976 DVBSM(0)::Stop: begin
1522005-11-24 15:06:07.976 SM(0)::Stop: begin
1532005-11-24 15:06:07.976 SM(0)::Stop: end
1542005-11-24 15:06:07.976 DVBSM(0)::Stop: end
1552005-11-24 15:06:07.977 DVBSM(0)::Stop: begin
1562005-11-24 15:06:07.977 SM(0)::Stop: begin
1572005-11-24 15:06:07.977 SM(0)::Stop: end
1582005-11-24 15:06:07.977 DVBSM(0)::Stop: end
1592005-11-24 15:06:07.977 TVRec(1): TeardownSignalMonitor() -- end
1602005-11-24 15:06:07.977 TVRec(1): ClearFlags(WaitingForSignal,SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,
1612005-11-24 15:06:07.978 TVRec(1): prog_num(1573) vs. dvbc->srv_id(1573)
1622005-11-24 15:06:07.979 SIParser: About to do a reset
1632005-11-24 15:06:07.979 SIParser: Closing all PIDs
1642005-11-24 15:06:07.979 SIParser: Using DelAllPids from SIParser which does nothing
1652005-11-24 15:06:07.979 SIParser: Resetting all Table Handlers
1662005-11-24 15:06:07.979 SIParser: SIParser Reset due to channel change
1672005-11-24 15:06:07.979 SIParser: Added initial preferred language 'eng' with priority 1
1682005-11-24 15:06:07.980 SIParser: Added initial preferred language 'eng' with priority 2
1692005-11-24 15:06:07.980 DVB#0 DVB SI Table Parser Started
1702005-11-24 15:06:07.981 DVBSM(0)::Stop: begin
1712005-11-24 15:06:07.981 SM(0)::Stop: begin
1722005-11-24 15:06:07.981 SM(0)::Stop: end
1732005-11-24 15:06:07.981 DVBSM(0)::Stop: end
1742005-11-24 15:06:07.981 SM(0)::Stop: begin
1752005-11-24 15:06:07.982 SM(0)::Stop: end
1762005-11-24 15:06:07.982 SIParser: ReinitSIParser(std dvb, service #1573)
1772005-11-24 15:06:07.983 FillPMap(str dvb)
1782005-11-24 15:06:07.983 FillPMap(SIS dvb)
1792005-11-24 15:06:07.983 SIParser: Requesting PAT
1802005-11-24 15:06:07.983 SIParser: Adding the Service with ID 1573 in the SDT to the request list
1812005-11-24 15:06:07.983 TVRec(1): SetFlags(WaitingForSIParser,SIParserRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSIParser,NeedToStartRecorder,SIParserRunning,
1822005-11-24 15:06:07.984 SIParser: Starting DVB Section Reader thread
1832005-11-24 15:06:07.985 SIParser: Table[0]->RequirePIDs() == true
1842005-11-24 15:06:07.985 SIParser: Adding PID 0x 0 Filter 0x 0 Mask 0xff Buffer 40960
1852005-11-24 15:06:07.990 SIParser: Table[2]->RequirePIDs() == true
1862005-11-24 15:06:07.990 SIParser: Adding PID 0x1ffb Filter 0xff Mask 0x 0 Buffer 40960
1872005-11-24 15:06:07.991 SIParser: Table[3]->RequirePIDs() == true
1882005-11-24 15:06:07.991 SIParser: Adding PID 0x1ffb Filter 0xff Mask 0x 0 Buffer 40960
1892005-11-24 15:06:07.992 SIParser: Table[6]->RequirePIDs() == true
1902005-11-24 15:06:07.992 SIParser: Adding PID 0x 10 Filter 0x40 Mask 0xff Buffer 40960
1912005-11-24 15:06:08.173 SIParser: PAT Version = 1
1922005-11-24 15:06:08.173 SIParser: Tuned to TransportID: 1538
1932005-11-24 15:06:08.174 SIParser: NIT Present on this transport on PID 0x10
1942005-11-24 15:06:08.174 SIParser: PMT #1569 on PID 0x257
1952005-11-24 15:06:08.174 SIParser: PMT #1570 on PID 0x258
1962005-11-24 15:06:08.174 SIParser: PMT #1571 on PID 0x259
1972005-11-24 15:06:08.174 SIParser: PMT #1572 on PID 0x260
1982005-11-24 15:06:08.175 SIParser: PMT #1573 on PID 0x256
1992005-11-24 15:06:08.175 SIParser: PMT #1575 on PID 0x262
2002005-11-24 15:06:08.175 SIParser: PMT #1576 on PID 0x263
2012005-11-24 15:06:08.175 SIParser: PMT #1577 on PID 0x264
2022005-11-24 15:06:08.176 SIParser: Services on this Transport: 1569 1570 1571 1572 1573 1575 1576 1577
2032005-11-24 15:06:08.176 SIParser: Table[0]->Complete() == true
2042005-11-24 15:06:08.176 SIParser: Table[1]->RequirePIDs() == true
2052005-11-24 15:06:08.177 SIParser: Adding PID 0x 100 Filter 0x 2 Mask 0xff Buffer 40960
2062005-11-24 15:06:08.298 SIParser: PMT ServiceID: 1573 Version = 1
2072005-11-24 15:06:08.299 SIParser: Unused Descriptor:
208 Unknown Descriptor (0xb) length(2)
2092005-11-24 15:06:08.299 SIParser: Unused Descriptor:
210 Unknown Descriptor (0x10) length(6)
2112005-11-24 15:06:08.299 SIParser: PID: 512
2122005-11-24 15:06:08.299 SIParser: Unused Descriptor:
213 Unknown Descriptor (0x2) length(3)
2142005-11-24 15:06:08.300 SIParser: PID: 650
2152005-11-24 15:06:08.300 SIParser: Unused Descriptor:
216 Unknown Descriptor (0x3) length(1)
2172005-11-24 15:06:08.300 SIParser: PID: 651
2182005-11-24 15:06:08.300 SIParser: AC3 Descriptor
2192005-11-24 15:06:08.300 SIParser: PID: 576
2202005-11-24 15:06:08.301 SIParser: Teletext Descriptor
2212005-11-24 15:06:08.301 SIParser: lang: eng, type: 2, mag: 0, page: 1
2222005-11-24 15:06:08.301 SIParser: Table[1]->EmitRequired() == true
2232005-11-24 15:06:08.301 DVB#0 SetPMT ServiceID=1573, PCRPID=128 (0x80)
2242005-11-24 15:06:08.302 TVRec(1): Got SIParser PMT
2252005-11-24 15:06:08.302 TVRec(1): ClearFlags(WaitingForSIParser,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,
2262005-11-24 15:06:08.302 TVRec(1): Starting Recorder
2272005-11-24 15:06:08.308 TVRec(1): Using profile 'Default' to record
2282005-11-24 15:06:08.367 RecBase(0): SetRingBuffer(0x81a5898) '/var/media/video/1010_20051124150600.mpg'
2292005-11-24 15:06:08.368 RecBase(0): SetRecording(0x8139e78) title(Huey's Cooking Adventures)
2302005-11-24 15:06:08.371 DVBRec(0): Card opened successfully (using TS mode).
2312005-11-24 15:06:08.372 DVBRec(0): SetPMTObject()
2322005-11-24 15:06:08.372 DVBRec(0): AutoPID for MPEG Program Number(1573), PCR PID(0x80)
2332005-11-24 15:06:08.373 DVBRec(0): AutoPID selecting PID 0x200, MPEG-2 Video
2342005-11-24 15:06:08.373 DVBRec(0): AutoPID selecting PID 0x28a, MPEG-2 Audio (eng
2352005-11-24 15:06:08.373 DVBRec(0): AutoPID selecting PID 0x28b, AC3 Audio (eng
2362005-11-24 15:06:08.374 DVBRec(0): AutoPID selecting PID 0x240, Teletext
2372005-11-24 15:06:08.374 DVBRec(0): AutoPID Complete - PAT/PMT Loaded for service
2382005-11-24 15:06:08.374 DVBRec(0): A/V Stream is unencrypted
2392005-11-24 15:06:08.375 DVBRec(0): Resetting Demux Filters
2402005-11-24 15:06:08.375 DVBRec(0): Adding pid 0x200 size(3600384)
2412005-11-24 15:06:08.376 DVBRec(0): Set demux buffer size for pid 0x200 to 3600384,
242 which gives us a 1500 msec buffer.
2432005-11-24 15:06:08.376 DVBRec(0): Adding pid 0x80 size(3600384)
2442005-11-24 15:06:08.377 DVBRec(0): Set demux buffer size for pid 0x80 to 3600384,
245 which gives us a 1500 msec buffer.
2462005-11-24 15:06:08.378 DVBRec(0): Adding pid 0x28a size(94208)
2472005-11-24 15:06:08.378 DVBRec(0): Set demux buffer size for pid 0x28a to 94208,
248 which gives us a 1500 msec buffer.
2492005-11-24 15:06:08.379 DVBRec(0): Adding pid 0x28b size(94208)
2502005-11-24 15:06:08.379 DVBRec(0): Set demux buffer size for pid 0x28b to 94208,
251 which gives us a 1500 msec buffer.
2522005-11-24 15:06:08.380 DVBRec(0): Adding pid 0x240 size(94208)
2532005-11-24 15:06:08.380 TVRec(1): SetFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RecorderRunning,
2542005-11-24 15:06:08.381 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,
2552005-11-24 15:06:08.380 DVBRec(0): Set demux buffer size for pid 0x240 to 94208,
256 which gives us a 1500 msec buffer.
2572005-11-24 15:06:08.384 Parsed PMT(0x0x818baf0) Program Map Table ver(16) pid(0x20) pnum(1)
258 Unknown Descriptor (0xb) length(2)
259 Unknown Descriptor (0x10) length(6)
260
261 Stream #0 pid(0x200) type(video-mpeg2 0x2)
262 Unknown Descriptor (0x2) length(3)
263 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3] 0x4)
264 Unknown Descriptor (0x3) length(1)
265 ISO-639 Language Descriptor (0xa) length(4)
266 Stream #2 pid(0x28b) type(audio-ac3 0x129)
267 AC-3 Descriptor (0x6a) length(3)
268 ISO-639 Language Descriptor (0xa) length(4)
269 Stream #3 pid(0x240) type(private-data 0x6)
270 Teletext Descriptor (0x56) length(5)
271
2722005-11-24 15:06:08.386 DVB#0 Data read from DMX - This is for debugging with transform.c
2732005-11-24 15:06:09.029 SIParser: Private Type channel_numbers = 131 defined for NetworkID 4116
2742005-11-24 15:06:09.029 SIParser: ChannelNumbers Present using Descriptor 131
2752005-11-24 15:06:09.029 SIParser: Unused Descriptor:
276 Private Data Specifier Descriptor (0x5f) length(4)
2772005-11-24 15:06:09.030 SIParser: Unused Descriptor:
278 Service List Descriptor (0x41) length(24)
2792005-11-24 15:06:09.030 SIParser: Table[6]->Complete() == true
2802005-11-24 15:06:09.030 SIParser: Table[5]->RequirePIDs() == true
2812005-11-24 15:06:09.031 SIParser: Adding PID 0x 11 Filter 0x46 Mask 0xfb Buffer 40960
2822005-11-24 15:06:10.319 SIParser: SDT: NetworkID=4116 TransportID=1538
2832005-11-24 15:06:10.320 SIParser: Unused Descriptor:
284 Country Availability Descriptor (0x49) length(4)
2852005-11-24 15:06:10.320 SIParser: Unused Descriptor:
286LinkageDescriptor(stub)
2872005-11-24 15:06:10.320 SIParser: Unused Descriptor:
288 Multilingual Service Name Descriptor (0x5d) length(28)
2892005-11-24 15:06:10.321 SIParser: SDT: sid=1571 type=1 eit_present=0 eit_requested=0 name=TEN Digital 2
2902005-11-24 15:06:10.321 SIParser: Unused Descriptor:
291 Country Availability Descriptor (0x49) length(4)
2922005-11-24 15:06:10.321 SIParser: Unused Descriptor:
293 Multilingual Service Name Descriptor (0x5d) length(26)
2942005-11-24 15:06:10.321 SIParser: SDT: sid=1573 type=1 eit_present=0 eit_requested=0 name=TEN Digital
2952005-11-24 15:06:10.322 SIParser: Unused Descriptor:
296 Country Availability Descriptor (0x49) length(4)
2972005-11-24 15:06:10.322 SIParser: Unused Descriptor:
298 Multilingual Service Name Descriptor (0x5d) length(26)
2992005-11-24 15:06:10.322 SIParser: SDT: sid=1569 type=1 eit_present=0 eit_requested=0 name=TEN Digital
3002005-11-24 15:06:10.322 SIParser: Unused Descriptor:
301 Country Availability Descriptor (0x49) length(4)
3022005-11-24 15:06:10.323 SIParser: Unused Descriptor:
303 Multilingual Service Name Descriptor (0x5d) length(28)
3042005-11-24 15:06:10.323 SIParser: SDT: sid=1570 type=1 eit_present=0 eit_requested=0 name=TEN Digital 1
3052005-11-24 15:06:10.323 SIParser: Unused Descriptor:
306 Country Availability Descriptor (0x49) length(4)
3072005-11-24 15:06:10.323 SIParser: Unused Descriptor:
308 Multilingual Service Name Descriptor (0x5d) length(28)
3092005-11-24 15:06:10.324 SIParser: SDT: sid=1572 type=1 eit_present=0 eit_requested=0 name=TEN Digital 3
3102005-11-24 15:06:10.324 SIParser: Unused Descriptor:
311 Multilingual Service Name Descriptor (0x5d) length(24)
3122005-11-24 15:06:10.324 SIParser: SDT: sid=1575 type=1 eit_present=0 eit_requested=0 name=TEN Guide
3132005-11-24 15:06:10.324 SIParser: Unused Descriptor:
314 Multilingual Service Name Descriptor (0x5d) length(21)
3152005-11-24 15:06:10.325 SIParser: SDT: sid=1576 type=1 eit_present=0 eit_requested=0 name=TEN HD
3162005-11-24 15:06:10.325 SIParser: Unused Descriptor:
317 Multilingual Service Name Descriptor (0x5d) length(24)
3182005-11-24 15:06:10.325 SIParser: SDT: sid=1577 type=1 eit_present=0 eit_requested=0 name=TEN Guide
3192005-11-24 15:06:10.325 SIParser: Table[4]->RequirePIDs() == true
3202005-11-24 15:06:10.326 SIParser: Adding PID 0x 12 Filter 0x 0 Mask 0x 0 Buffer 4096000
3212005-11-24 15:06:56.105 AutoExpire: Adding Programs to 'Do Not Expire' List
3222005-11-24 15:06:56.106 1010 @ Thu Nov 24 15:06:00 2005
3232005-11-24 15:06:56.109 AutoExpire: SendDeleteMessages, cycling through expire list.
3242005-11-24 15:07:56.162 AutoExpire: Adding Programs to 'Do Not Expire' List
3252005-11-24 15:07:56.163 1010 @ Thu Nov 24 15:06:00 2005
3262005-11-24 15:08:56.215 AutoExpire: Adding Programs to 'Do Not Expire' List
3272005-11-24 15:08:56.216 1010 @ Thu Nov 24 15:06:00 2005
3282005-11-24 15:08:56.219 AutoExpire: SendDeleteMessages, cycling through expire list.
3292005-11-24 15:09:56.272 AutoExpire: Adding Programs to 'Do Not Expire' List
3302005-11-24 15:09:56.273 1010 @ Thu Nov 24 15:06:00 2005
3312005-11-24 15:10:56.325 AutoExpire: Adding Programs to 'Do Not Expire' List
3322005-11-24 15:10:56.326 1010 @ Thu Nov 24 15:06:00 2005
3332005-11-24 15:10:56.333 AutoExpire: SendDeleteMessages, cycling through expire list.
3342005-11-24 15:10:56.335 AutoExpire: Checking episode count for each recording profile using max episodes
3352005-11-24 15:11:56.386 AutoExpire: Adding Programs to 'Do Not Expire' List
3362005-11-24 15:11:56.387 1010 @ Thu Nov 24 15:06:00 2005
3372005-11-24 15:12:56.440 AutoExpire: Adding Programs to 'Do Not Expire' List
3382005-11-24 15:12:56.440 1010 @ Thu Nov 24 15:06:00 2005
3392005-11-24 15:12:56.444 AutoExpire: SendDeleteMessages, cycling through expire list.
3402005-11-24 15:13:56.496 AutoExpire: Adding Programs to 'Do Not Expire' List
3412005-11-24 15:13:56.497 1010 @ Thu Nov 24 15:06:00 2005
3422005-11-24 15:14:56.549 AutoExpire: Adding Programs to 'Do Not Expire' List
3432005-11-24 15:14:56.550 1010 @ Thu Nov 24 15:06:00 2005
3442005-11-24 15:14:56.553 AutoExpire: SendDeleteMessages, cycling through expire list.
3452005-11-24 15:15:56.606 AutoExpire: Adding Programs to 'Do Not Expire' List
3462005-11-24 15:15:56.607 1010 @ Thu Nov 24 15:06:00 2005
3472005-11-24 15:15:56.609 AutoExpire: Checking episode count for each recording profile using max episodes
3482005-11-24 15:16:56.663 AutoExpire: Adding Programs to 'Do Not Expire' List
3492005-11-24 15:16:56.664 1010 @ Thu Nov 24 15:06:00 2005
3502005-11-24 15:16:56.668 AutoExpire: SendDeleteMessages, cycling through expire list.
3512005-11-24 15:17:56.720 AutoExpire: Adding Programs to 'Do Not Expire' List
3522005-11-24 15:17:56.721 1010 @ Thu Nov 24 15:06:00 2005
3532005-11-24 15:18:56.774 AutoExpire: Adding Programs to 'Do Not Expire' List
3542005-11-24 15:18:56.774 1010 @ Thu Nov 24 15:06:00 2005
3552005-11-24 15:18:56.778 AutoExpire: SendDeleteMessages, cycling through expire list.
3562005-11-24 15:19:56.831 AutoExpire: Adding Programs to 'Do Not Expire' List
3572005-11-24 15:19:56.831 1010 @ Thu Nov 24 15:06:00 2005
3582005-11-24 15:20:56.884 AutoExpire: Adding Programs to 'Do Not Expire' List
3592005-11-24 15:20:56.884 1010 @ Thu Nov 24 15:06:00 2005
3602005-11-24 15:20:56.887 AutoExpire: SendDeleteMessages, cycling through expire list.
3612005-11-24 15:20:56.890 AutoExpire: Checking episode count for each recording profile using max episodes
3622005-11-24 15:21:56.945 AutoExpire: Adding Programs to 'Do Not Expire' List
3632005-11-24 15:21:56.945 1010 @ Thu Nov 24 15:06:00 2005
3642005-11-24 15:22:56.998 AutoExpire: Adding Programs to 'Do Not Expire' List
3652005-11-24 15:22:56.998 1010 @ Thu Nov 24 15:06:00 2005
3662005-11-24 15:22:57.002 AutoExpire: SendDeleteMessages, cycling through expire list.
3672005-11-24 15:23:57.055 AutoExpire: Adding Programs to 'Do Not Expire' List
3682005-11-24 15:23:57.055 1010 @ Thu Nov 24 15:06:00 2005
3692005-11-24 15:24:57.108 AutoExpire: Adding Programs to 'Do Not Expire' List
3702005-11-24 15:24:57.108 1010 @ Thu Nov 24 15:06:00 2005
3712005-11-24 15:24:57.112 AutoExpire: SendDeleteMessages, cycling through expire list.
3722005-11-24 15:25:57.165 AutoExpire: Adding Programs to 'Do Not Expire' List
3732005-11-24 15:25:57.165 1010 @ Thu Nov 24 15:06:00 2005
3742005-11-24 15:25:57.168 AutoExpire: Checking episode count for each recording profile using max episodes
3752005-11-24 15:26:57.222 AutoExpire: Adding Programs to 'Do Not Expire' List
3762005-11-24 15:26:57.223 1010 @ Thu Nov 24 15:06:00 2005
3772005-11-24 15:26:57.226 AutoExpire: SendDeleteMessages, cycling through expire list.
3782005-11-24 15:27:57.279 AutoExpire: Adding Programs to 'Do Not Expire' List
3792005-11-24 15:27:57.280 1010 @ Thu Nov 24 15:06:00 2005
3802005-11-24 15:28:57.332 AutoExpire: Adding Programs to 'Do Not Expire' List
3812005-11-24 15:28:57.333 1010 @ Thu Nov 24 15:06:00 2005
3822005-11-24 15:28:57.336 AutoExpire: SendDeleteMessages, cycling through expire list.
3832005-11-24 15:29:57.389 AutoExpire: Adding Programs to 'Do Not Expire' List
3842005-11-24 15:29:57.390 1010 @ Thu Nov 24 15:06:00 2005
3852005-11-24 15:30:57.442 AutoExpire: Adding Programs to 'Do Not Expire' List
3862005-11-24 15:30:57.443 1010 @ Thu Nov 24 15:06:00 2005
3872005-11-24 15:30:57.447 AutoExpire: SendDeleteMessages, cycling through expire list.
3882005-11-24 15:30:57.449 AutoExpire: Checking episode count for each recording profile using max episodes
3892005-11-24 15:31:57.503 AutoExpire: Adding Programs to 'Do Not Expire' List
3902005-11-24 15:31:57.504 1010 @ Thu Nov 24 15:06:00 2005
3912005-11-24 15:32:57.556 AutoExpire: Adding Programs to 'Do Not Expire' List
3922005-11-24 15:32:57.557 1010 @ Thu Nov 24 15:06:00 2005
3932005-11-24 15:32:57.560 AutoExpire: SendDeleteMessages, cycling through expire list.
3942005-11-24 15:33:57.613 AutoExpire: Adding Programs to 'Do Not Expire' List
3952005-11-24 15:33:57.614 1010 @ Thu Nov 24 15:06:00 2005
3962005-11-24 15:34:57.666 AutoExpire: Adding Programs to 'Do Not Expire' List
3972005-11-24 15:34:57.667 1010 @ Thu Nov 24 15:06:00 2005
3982005-11-24 15:34:57.670 AutoExpire: SendDeleteMessages, cycling through expire list.
3992005-11-24 15:35:00.437 TVRec(1): ClearFlags(FinishRecording,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,
4002005-11-24 15:35:00.438 TVRec(1): Changing from RecordingOnly to None
4012005-11-24 15:35:00.438 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,
4022005-11-24 15:35:00.438 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,
4032005-11-24 15:35:00.439 TVRec(1): Request: Program(no) channel() input() flags(CloseRec,KillRingBuffer,)
4042005-11-24 15:35:00.439 SIParser: Stopping DVB Section Reader
4052005-11-24 15:35:00.458 SIParser: DVB Section Reader thread stopped
4062005-11-24 15:35:00.460 TVRec(1): ClearFlags(SIParserRunning,) -> RunMainLoop,AskAllowRecording,RecorderRunning,
4072005-11-24 15:35:00.460 DVBRec(0): Close() fd(23) -- begin
4082005-11-24 15:35:00.726 DVBRec(0): Close() fd(-1) -- end
4092005-11-24 15:35:00.730 Reschedule requested for id 0.
4102005-11-24 15:35:00.735 Finished recording Huey's Cooking Adventures: channel 1010
4112005-11-24 15:35:00.793 DVBRec(0): Close() fd(-1) -- begin
4122005-11-24 15:35:00.883 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,
4132005-11-24 15:35:00.913 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,
4142005-11-24 15:35:00.914 TVRec(1): Tearing down RingBuffer
4152005-11-24 15:35:00.916 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,
4162005-11-24 15:35:00.926 Scheduled 19 items in 0.2 = 0.00 match + 0.20 place
4172005-11-24 15:35:00.928 Preview Error: Previewer file '/var/media/video/1010_20051124150600.mpg' is not valid.
4182005-11-24 15:35:46.149 Commercial Flagging Starting for Huey's Cooking Adventures recorded from channel 1010 at Thu Nov 24 15:06:00 2005
4192005-11-24 15:35:46.379 Using runtime prefix = /usr/local
4202005-11-24 15:35:46.410 New DB connection, total: 1
4212005-11-24 15:35:46.415 Enabling Settings Cache.
4222005-11-24 15:35:46.416 Clearing Settings Cache.
4232005-11-24 15:35:46.426 New DB connection, total: 2
4242005-11-24 15:35:46.431 Invalid file handle when opening /var/media/video/1010_20051124150600.mpg. 6 retries remaining.
4252005-11-24 15:35:46.933 Invalid file handle when opening /var/media/video/1010_20051124150600.mpg. 5 retries remaining.
4262005-11-24 15:35:47.437 Invalid file handle when opening /var/media/video/1010_20051124150600.mpg. 4 retries remaining.
4272005-11-24 15:35:47.941 Invalid file handle when opening /var/media/video/1010_20051124150600.mpg. 3 retries remaining.
4282005-11-24 15:35:48.445 Invalid file handle when opening /var/media/video/1010_20051124150600.mpg. 2 retries remaining.
4292005-11-24 15:35:48.949 Invalid file handle when opening /var/media/video/1010_20051124150600.mpg. 1 retries remaining.
4302005-11-24 15:35:49.453 Invalid file handle when opening /var/media/video/1010_20051124150600.mpg. 0 retries remaining.
4312005-11-24 15:35:49.975 Connecting to backend server: 192.168.1.100:6543 (try 1 of 5)
4322005-11-24 15:35:49.986 Using protocol version 22
4332005-11-24 15:35:49.993 MainServer::HandleAnnounce Monitor
4342005-11-24 15:35:49.994 adding: server as a client (events: 0)
4352005-11-24 15:35:50.059 NVP::OpenFile(): Error, file not found: /var/media/video/1010_20051124150600.mpg
4362005-11-24 15:35:50.071 Unknown socket closing
4372005-11-24 15:35:50.082 Commercial Flagging Finished, 0 break(s) found.
4382005-11-24 15:35:50.084 Preview Error: Previewer file '/var/media/video/1010_20051124150600.mpg' is not valid.
4392005-11-24 15:35:57.724 AutoExpire: Checking episode count for each recording profile using max episodes