Script started on Thu 08 May 2014 10:24:54 EST $ /usr/bin/mythbackend -v record 2014-05-08 10:24:59.128337 C mythbackend version: fixes/0.27 [v0.27-221-ge2acf0d] www.mythtv.org 2014-05-08 10:24:59.128354 C Qt version: compile: 4.8.1, runtime: 4.8.1 2014-05-08 10:24:59.128357 N Enabled verbose msgs: general record 2014-05-08 10:24:59.128365 N Setting Log Level to LOG_INFO 2014-05-08 10:24:59.139883 I Added logging to the console 2014-05-08 10:24:59.140367 I Setup Interrupt handler 2014-05-08 10:24:59.140380 I Setup Terminated handler 2014-05-08 10:24:59.140390 I Setup Segmentation fault handler 2014-05-08 10:24:59.140399 I Setup Aborted handler 2014-05-08 10:24:59.140409 I Setup Bus error handler 2014-05-08 10:24:59.140418 I Setup Floating point exception handler 2014-05-08 10:24:59.140428 I Setup Illegal instruction handler 2014-05-08 10:24:59.140441 I Setup Real-time signal 0 handler 2014-05-08 10:24:59.140493 N Using runtime prefix = /usr 2014-05-08 10:24:59.140508 N Using configuration directory = /home/mythtv/.mythtv 2014-05-08 10:24:59.140592 I Assumed character encoding: en_AU.UTF-8 2014-05-08 10:24:59.140998 N Empty LocalHostName. 2014-05-08 10:24:59.141007 I Using localhost value of mediac 2014-05-08 10:24:59.174343 N Setting QT default locale to en_AU 2014-05-08 10:24:59.174419 I Current locale en_AU 2014-05-08 10:24:59.174481 E No locale defaults file for en_AU, skipping 2014-05-08 10:24:59.180449 I Current MythTV Schema Version (DBSchemaVer): 1317 2014-05-08 10:24:59.181899 I Loading en_us translation for module mythfrontend 2014-05-08 10:24:59.183648 N MythBackend: Starting up as the master server. 2014-05-08 10:24:59.197906 I TVRec[9]: SetRecordingStatus(Unknown->Unknown) on line 156 2014-05-08 10:24:59.198136 I TVRec[9]: GetStartChannel(9, 'DVBInput') 2014-05-08 10:24:59.198835 I DVBChan[9](/dev/dvb/adapter0/frontend0): Using DVB card /dev/dvb/adapter0/frontend0, with frontend 'TurboSight TBS 62x1 DVBT/T2 frontend'. 2014-05-08 10:24:59.245330 I New Client: (#1) 2014-05-08 10:24:59.801409 I TVRec[9]: SetFlags(RunMainLoop,) -> RunMainLoop, 2014-05-08 10:24:59.801458 I TVRec[9]: ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2014-05-08 10:24:59.811010 I TVRec[11]: SetRecordingStatus(Unknown->Unknown) on line 156 2014-05-08 10:24:59.811960 I TVRec[11]: GetStartChannel(11, 'DVBInput') 2014-05-08 10:24:59.813184 I DVBChan[11](/dev/dvb/adapter1/frontend0): Using DVB card /dev/dvb/adapter1/frontend0, with frontend 'TurboSight TBS 62x1 DVBT/T2 frontend'. 2014-05-08 10:25:00.405867 I TVRec[11]: SetFlags(RunMainLoop,) -> RunMainLoop, 2014-05-08 10:25:00.405906 I TVRec[11]: ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2014-05-08 10:25:00.410434 I TVRec[13]: SetRecordingStatus(Unknown->Unknown) on line 156 2014-05-08 10:25:00.411206 I TVRec[13]: GetStartChannel(13, 'DVBInput') 2014-05-08 10:25:00.412249 I DVBChan[13](/dev/dvb/adapter2/frontend0): Using DVB card /dev/dvb/adapter2/frontend0, with frontend 'TurboSight TBS 62x1 DVBT/T2 frontend'. 2014-05-08 10:25:00.431738 I TVRec[13]: SetFlags(RunMainLoop,) -> RunMainLoop, 2014-05-08 10:25:00.431785 I TVRec[13]: ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2014-05-08 10:25:00.438365 I TVRec[15]: SetRecordingStatus(Unknown->Unknown) on line 156 2014-05-08 10:25:00.439348 I TVRec[15]: GetStartChannel(15, 'DVBInput') 2014-05-08 10:25:00.440572 I DVBChan[15](/dev/dvb/adapter3/frontend0): Using DVB card /dev/dvb/adapter3/frontend0, with frontend 'TurboSight TBS 62x1 DVBT/T2 frontend'. 2014-05-08 10:25:00.459574 I TVRec[15]: SetFlags(RunMainLoop,) -> RunMainLoop, 2014-05-08 10:25:00.459613 I TVRec[15]: ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2014-05-08 10:25:00.465196 I TVRec[17]: SetRecordingStatus(Unknown->Unknown) on line 156 2014-05-08 10:25:00.465801 I TVRec[17]: GetStartChannel(17, 'MPEG2TS') 2014-05-08 10:25:00.496555 I Loaded [data][fectype][fec0][fec1] for 1001 2014-05-08 10:25:00.496611 E DTVChan[17](): SetChannelByString(1): Tuning to IPTV URL 2014-05-08 10:25:00.498945 I TVRec[17]: SetFlags(RunMainLoop,) -> RunMainLoop, 2014-05-08 10:25:00.498959 I TVRec[17]: ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2014-05-08 10:25:00.517248 I Found 5 distinct programid authorities 2014-05-08 10:25:00.517556 I Registering HouseKeeperTask 'LogClean'. 2014-05-08 10:25:00.517573 I Registering HouseKeeperTask 'DBCleanup'. 2014-05-08 10:25:00.517586 I Registering HouseKeeperTask 'ThemeUpdateNotifications'. 2014-05-08 10:25:00.517586 I New static DB connectionSchedCon 2014-05-08 10:25:00.517605 I Registering HouseKeeperTask 'RecordedArtworkUpdate'. 2014-05-08 10:25:00.518394 I Registering HouseKeeperTask 'MythFillDB'. 2014-05-08 10:25:00.518412 I Registering HouseKeeperTask 'JobQueueRecover'. 2014-05-08 10:25:00.518421 I Registering HouseKeeperTask 'HardwareProfiler'. 2014-05-08 10:25:00.519056 I Starting HouseKeeper. 2014-05-08 10:25:00.521565 I Listening on TCP 127.0.0.1:6544 2014-05-08 10:25:00.521602 I Listening on TCP 192.168.1.10:6544 2014-05-08 10:25:01.565406 I Main::Registering HttpStatus Extension 2014-05-08 10:25:01.568599 I Listening on TCP 127.0.0.1:6543 2014-05-08 10:25:01.568719 I Listening on TCP 192.168.1.10:6543 2014-05-08 10:25:01.573352 N AutoExpire: CalcParams(): Max required Free Space: 5.0 GB w/freq: 15 min 2014-05-08 10:25:02.403985 I Bonjour: Service registration complete: name 'Mythbackend on mediac' type '_mythbackend._tcp.' domain: 'local.' 2014-05-08 10:25:03.536949 I Reschedule requested for MATCH 0 0 0 - SchedulerInit 2014-05-08 10:25:03.804732 I MainServer::ANN Playback 2014-05-08 10:25:03.804758 I adding: mediac as a client (events: 0) 2014-05-08 10:25:03.809497 I MainServer::ANN Monitor 2014-05-08 10:25:03.809505 I adding: mediac as a client (events: 1) 2014-05-08 10:25:03.952228 I Scheduled 149 items in 0.4 = 0.17 match + 0.05 check + 0.17 place 2014-05-08 10:25:04.078427 I Scheduler: Seem to be woken up by USER 2014-05-08 10:25:07.768413 I Getting next free recorder after : -1 2014-05-08 10:25:07.768464 I Checking card 9. Best card so far -1 2014-05-08 10:25:07.770473 I Checking card 11. Best card so far 9 2014-05-08 10:25:07.772055 I Checking card 13. Best card so far 9 2014-05-08 10:25:07.773857 I Checking card 15. Best card so far 9 2014-05-08 10:25:07.775153 I Checking card 17. Best card so far 9 2014-05-08 10:25:07.776196 I Best card is 9 2014-05-08 10:25:07.783814 I MainServer::ANN Playback 2014-05-08 10:25:07.783836 I adding: mediac as a client (events: 0) 2014-05-08 10:25:07.815438 I TVRec[9]: Found channel (7) on current card(9). 2014-05-08 10:25:07.829698 I TVRec[9]: Changing from None to WatchingLiveTV 2014-05-08 10:25:07.829747 I TVRec[9]: ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2014-05-08 10:25:07.829791 I TVRec[9]: HandleTuning Request: Program(NULL) channel() input() flags(LiveTV,) 2014-05-08 10:25:07.836560 I TVRec[9]: HW Tuner: 9->9 2014-05-08 10:25:07.836621 I TVRec[9]: ClearFlags(PENDINGACTIONS,) -> RunMainLoop, 2014-05-08 10:25:07.836651 I TVRec[9]: No recorder yet, calling TuningFrequency 2014-05-08 10:25:08.497373 I TVRec[9]: CreateLiveTVRingBuffer(7) 2014-05-08 10:25:08.498409 I TVRec[9]: GetProgramRingBufferForLiveTV() 2014-05-08 10:25:08.510385 N AutoExpire: CalcParams(): Max required Free Space: 7.0 GB w/freq: 14 min 2014-05-08 10:25:08.582781 I TVRec[9]: StartedRecording(1007_2014-05-08T00:25:08Z) fn(/tv/1007_20140508002508.mpg) 2014-05-08 10:25:08.588351 I Chain: Appended@0 '1007_20140508002508' 2014-05-08 10:25:08.590831 I TVRec[9]: Starting Signal Monitor 2014-05-08 10:25:08.590864 I TVRec[9]: SetupSignalMonitor(1, 1) 2014-05-08 10:25:08.853101 I TVRec[9]: Signal monitor successfully created 2014-05-08 10:25:08.853135 I TVRec[9]: Setting up table monitoring. 2014-05-08 10:25:08.858965 I Using profile 'Live TV' to record 2014-05-08 10:25:08.859259 I TVRec[9]: DVB service_id 1312 on net_id 4115 tsid 1282 2014-05-08 10:25:08.859529 I TVRec[9]: Successfully set up DVB table monitoring. 2014-05-08 10:25:08.861046 I TVRec[9]: SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning, 2014-05-08 10:25:08.861083 I TVRec[9]: ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning, 2014-05-08 10:25:08.861108 I TVRec[9]: SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning, 2014-05-08 10:25:08.861138 I TVRec[9]: SetFlags(DummyRecorderRunning,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2014-05-08 10:25:08.861151 I DummyDTVRecorder -- started 2014-05-08 10:25:08.861174 I TVRec[9]: SetFlags(RingBufferReady,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:08.861200 I TVRec[9]: ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:08.861227 I TVRec[9]: SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:08.861343 I TVRec[9]: TuningSignalCheck: Still waiting. Will timeout @ 11:30:00.000 2014-05-08 10:25:08.862066 I TVRec[9]: SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:09.149057 I SH(/dev/dvb/adapter0/frontend0): AddListener(0x7eff50027d78) -- begin 2014-05-08 10:25:09.149104 I SH(/dev/dvb/adapter0/frontend0): AddListener(0x7eff50027d78) -- locked 2014-05-08 10:25:09.149450 I DVBSH(/dev/dvb/adapter0/frontend0): run(): begin 2014-05-08 10:25:09.150022 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x0 2014-05-08 10:25:09.259841 I TVRec[9]: SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:09.585079 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x0 2014-05-08 10:25:09.995290 I DVBSH(/dev/dvb/adapter0/frontend0): RunTS(): begin 2014-05-08 10:25:09.995423 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x0 2014-05-08 10:25:10.050318 I SH(/dev/dvb/adapter0/frontend0): AddListener(0x7eff50027d78) -- end 2014-05-08 10:25:10.429163 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x1 2014-05-08 10:25:10.429308 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x10 2014-05-08 10:25:10.429384 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x11 2014-05-08 10:25:10.429459 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x14 2014-05-08 10:25:10.682151 I MPEGStream[9](0x7eff50027d78): CreatePATSingleProgram() 2014-05-08 10:25:10.682198 I MPEGStream[9](0x7eff50027d78): PAT in input stream 2014-05-08 10:25:10.683541 I MPEGStream[9](0x7eff50027d78): Program Association Section PSIP tableID(0x0) length(41) extension(0x502) version(26) current(1) section(0) last_section(0) tsid(1282) programCount(8) program number 0 has PID 0x0010 program number 1312 has PID 0x0200 program number 1313 has PID 0x0210 program number 1314 has PID 0x0220 program number 1315 has PID 0x0230 program number 1316 has PID 0x0240 program number 1319 has PID 0x0270 program number 1320 has PID 0x0280 2014-05-08 10:25:10.683578 I MPEGStream[9](0x7eff50027d78): desired_program(1312) pid(0x200) 2014-05-08 10:25:10.683790 I MPEGStream[9](0x7eff50027d78): pmt_pid(0x200) 2014-05-08 10:25:10.683820 I MPEGStream[9](0x7eff50027d78): PAT for output stream 2014-05-08 10:25:10.683882 I MPEGStream[9](0x7eff50027d78): Program Association Section PSIP tableID(0x0) length(13) extension(0x502) version(26) current(1) section(0) last_section(0) tsid(1282) programCount(1) program number 1 has PID 0x0200 2014-05-08 10:25:10.684113 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x200 2014-05-08 10:25:10.986696 I MPEGStream[9](0x7eff50027d78): CreatePMTSingleProgram() 2014-05-08 10:25:10.986724 I MPEGStream[9](0x7eff50027d78): PMT in input stream 2014-05-08 10:25:10.990447 I MPEGStream[9](0x7eff50027d78): Program Map Section PSIP tableID(0x2) length(69) extension(0x520) version(15) current(1) section(0) last_section(0) pnum(1312) pid(0x200) Stream #0 pid(0x201) type(0x02 video-mpeg2) Video Descriptor (0x02) length(3) Stream #1 pid(0x202) type(0x03 audio-mp1-layer[1,2,3]) ISO-639 Language: code(eng) canonical(eng) eng(English) Stream #2 pid(0x204) type(0x06 private-data) Teletext Descriptor: 1 pages type(2) mag(0) page(01) lang(eng) Stream #3 pid(0x299) type(0x0b dsmcc-b std data) Stream Identifier Descriptor (0x52): ComponentTag=0x1 Data Broadcast ID Descriptor (0x66) length(6) DSM-CC Carousel Identifier Descriptor (0x13) length(5) 2014-05-08 10:25:10.990916 I MPEGStream[9](0x7eff50027d78): PMT for output stream 2014-05-08 10:25:10.991121 I MPEGStream[9](0x7eff50027d78): Program Map Section PSIP tableID(0x2) length(69) extension(0x1) version(15) current(1) section(0) last_section(0) pnum(1) pid(0x200) Stream #0 pid(0x201) type(0x02 video-mpeg2) Video Descriptor (0x02) length(3) Stream #1 pid(0x202) type(0x03 audio-mp1-layer[1,2,3]) ISO-639 Language: code(eng) canonical(eng) eng(English) Stream #2 pid(0x204) type(0x06 private-data) Teletext Descriptor: 1 pages type(2) mag(0) page(01) lang(eng) Stream #3 pid(0x299) type(0x0b dsmcc-b std data) Stream Identifier Descriptor (0x52): ComponentTag=0x1 Data Broadcast ID Descriptor (0x66) length(6) DSM-CC Carousel Identifier Descriptor (0x13) length(5) 2014-05-08 10:25:10.991307 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x201 2014-05-08 10:25:10.991488 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x202 2014-05-08 10:25:10.991583 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x204 2014-05-08 10:25:10.991681 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x299 2014-05-08 10:25:12.118114 I TVRec[9]: TuningSignalCheck: Have a good signal 2014-05-08 10:25:12.118169 I TVRec[9]: SetRecordingStatus(Unknown->Recording) on line 3957 2014-05-08 10:25:12.118317 I TVRec[9]: TeardownSignalMonitor() -- begin 2014-05-08 10:25:12.168998 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff50027d78) -- begin 2014-05-08 10:25:12.169028 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff50027d78) -- locked 2014-05-08 10:25:12.201027 I DVBSH(/dev/dvb/adapter0/frontend0): RunTS(): shutdown 2014-05-08 10:25:12.201100 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x0 2014-05-08 10:25:12.201220 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x1 2014-05-08 10:25:12.201280 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x10 2014-05-08 10:25:12.201333 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x11 2014-05-08 10:25:12.201385 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x14 2014-05-08 10:25:12.201436 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x200 2014-05-08 10:25:12.201488 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x201 2014-05-08 10:25:12.201548 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x202 2014-05-08 10:25:12.201594 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x204 2014-05-08 10:25:12.201636 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x299 2014-05-08 10:25:12.606191 I DVBSH(/dev/dvb/adapter0/frontend0): RunTS(): end 2014-05-08 10:25:12.606218 I DVBSH(/dev/dvb/adapter0/frontend0): run(): end 2014-05-08 10:25:12.606419 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff50027d78) -- end 2014-05-08 10:25:12.606590 I TVRec[9]: TeardownSignalMonitor() -- end 2014-05-08 10:25:12.606624 I TVRec[9]: ClearFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:12.606666 I TVRec[9]: ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:12.611451 I TVRec[9]: Starting Recorder 2014-05-08 10:25:12.612862 I TVRec[9]: FinishedRecording(1007_2014-05-08T00:25:08Z) title: The Morning Show in recgroup: LiveTV status: Recording:Recorded is_dummy finished_now 2014-05-08 10:25:12.614135 I Chain: Updated endtime for '1007_20140508002508' to 20140508002512 2014-05-08 10:25:12.615614 I TVRec[9]: ClearFlags(DummyRecorderRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,NeedToStartRecorder,RingBufferReady, 2014-05-08 10:25:12.620172 I Using profile 'Live TV' to record 2014-05-08 10:25:12.620255 I TVRec[9]: SwitchLiveTVRingBuffer(discont 1, set_next_rec 0) curRec(1007_2014-05-08T00:25:08Z) curRec.size(0) 2014-05-08 10:25:12.620905 I TVRec[9]: GetProgramRingBufferForLiveTV() 2014-05-08 10:25:12.633019 N AutoExpire: CalcParams(): Max required Free Space: 7.0 GB w/freq: 14 min 2014-05-08 10:25:12.672039 I TVRec[9]: StartedRecording(1007_2014-05-08T00:25:12Z) fn(/tv/1007_20140508002512.mpg) 2014-05-08 10:25:12.680118 I Chain: Appended@1 '1007_20140508002512' 2014-05-08 10:25:12.682231 I DTVRec[9]: ResetForNewFile(void) 2014-05-08 10:25:12.684794 I RecBase[9](/dev/dvb/adapter0/frontend0): SetRingBuffer(0x7eff5002fc50) '/tv/1007_20140508002512.mpg' 2014-05-08 10:25:12.685082 I MPEGStream[9](0x7eff50027d78): SetDesiredProgram(1312) 2014-05-08 10:25:12.685118 I DTVRec[9]: SetPAT(1312 on 0x200) 2014-05-08 10:25:12.685182 I MPEGStream[9](0x7eff50027d78): CreatePATSingleProgram() 2014-05-08 10:25:12.685199 I MPEGStream[9](0x7eff50027d78): PAT in input stream 2014-05-08 10:25:12.685311 I MPEGStream[9](0x7eff50027d78): Program Association Section PSIP tableID(0x0) length(41) extension(0x502) version(26) current(1) section(0) last_section(0) tsid(1282) programCount(8) program number 0 has PID 0x0010 program number 1312 has PID 0x0200 program number 1313 has PID 0x0210 program number 1314 has PID 0x0220 program number 1315 has PID 0x0230 program number 1316 has PID 0x0240 program number 1319 has PID 0x0270 program number 1320 has PID 0x0280 2014-05-08 10:25:12.685335 I MPEGStream[9](0x7eff50027d78): desired_program(1312) pid(0x200) 2014-05-08 10:25:12.685384 I MPEGStream[9](0x7eff50027d78): pmt_pid(0x200) 2014-05-08 10:25:12.685402 I MPEGStream[9](0x7eff50027d78): PAT for output stream 2014-05-08 10:25:12.685457 I MPEGStream[9](0x7eff50027d78): Program Association Section PSIP tableID(0x0) length(13) extension(0x502) version(26) current(1) section(0) last_section(0) tsid(1282) programCount(1) program number 1 has PID 0x0200 2014-05-08 10:25:12.685715 I DTVRec[9]: SetPMT(1312) 2014-05-08 10:25:12.685832 I MPEGStream[9](0x7eff50027d78): CreatePMTSingleProgram() 2014-05-08 10:25:12.685851 I MPEGStream[9](0x7eff50027d78): PMT in input stream 2014-05-08 10:25:12.686072 I MPEGStream[9](0x7eff50027d78): Program Map Section PSIP tableID(0x2) length(69) extension(0x520) version(15) current(1) section(0) last_section(0) pnum(1312) pid(0x200) Stream #0 pid(0x201) type(0x02 video-mpeg2) Video Descriptor (0x02) length(3) Stream #1 pid(0x202) type(0x03 audio-mp1-layer[1,2,3]) ISO-639 Language: code(eng) canonical(eng) eng(English) Stream #2 pid(0x204) type(0x06 private-data) Teletext Descriptor: 1 pages type(2) mag(0) page(01) lang(eng) Stream #3 pid(0x299) type(0x0b dsmcc-b std data) Stream Identifier Descriptor (0x52): ComponentTag=0x1 Data Broadcast ID Descriptor (0x66) length(6) DSM-CC Carousel Identifier Descriptor (0x13) length(5) 2014-05-08 10:25:12.686282 I MPEGStream[9](0x7eff50027d78): PMT for output stream 2014-05-08 10:25:12.686473 I MPEGStream[9](0x7eff50027d78): Program Map Section PSIP tableID(0x2) length(69) extension(0x1) version(15) current(1) section(0) last_section(0) pnum(1) pid(0x200) Stream #0 pid(0x201) type(0x02 video-mpeg2) Video Descriptor (0x02) length(3) Stream #1 pid(0x202) type(0x03 audio-mp1-layer[1,2,3]) ISO-639 Language: code(eng) canonical(eng) eng(English) Stream #2 pid(0x204) type(0x06 private-data) Teletext Descriptor: 1 pages type(2) mag(0) page(01) lang(eng) Stream #3 pid(0x299) type(0x0b dsmcc-b std data) Stream Identifier Descriptor (0x52): ComponentTag=0x1 Data Broadcast ID Descriptor (0x66) length(6) DSM-CC Carousel Identifier Descriptor (0x13) length(5) 2014-05-08 10:25:12.686572 I RecBase[9](/dev/dvb/adapter0/frontend0): SetRecording(0x7eff50026190) title(The Morning Show) 2014-05-08 10:25:12.687763 I DTVRec[9]: ResetForNewFile(void) 2014-05-08 10:25:12.687845 I DVBRec[9](/dev/dvb/adapter0/frontend0): Card opened successfully 2014-05-08 10:25:12.688054 I SH(/dev/dvb/adapter0/frontend0): AddListener(0x7eff50027d78) -- begin 2014-05-08 10:25:12.688074 I SH(/dev/dvb/adapter0/frontend0): AddListener(0x7eff50027d78) -- locked 2014-05-08 10:25:12.688299 I DVBSH(/dev/dvb/adapter0/frontend0): run(): begin 2014-05-08 10:25:12.692646 I TVRec[9]: SetFlags(RecorderRunning,RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady, 2014-05-08 10:25:12.692712 I TVRec[9]: ClearFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady, 2014-05-08 10:25:12.778802 I DevRdB(/dev/dvb/adapter0/frontend0): buffer size 96256 KB 2014-05-08 10:25:12.778817 I DevRdB(/dev/dvb/adapter0/frontend0): Start() -- begin 2014-05-08 10:25:12.778877 I DevRdB(/dev/dvb/adapter0/frontend0): Start() -- middle 2014-05-08 10:25:12.778881 I DevRdB(/dev/dvb/adapter0/frontend0): Start() -- end 2014-05-08 10:25:12.778885 I DVBSH(/dev/dvb/adapter0/frontend0): RunTS(): begin 2014-05-08 10:25:12.778953 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x0 2014-05-08 10:25:12.788294 I SH(/dev/dvb/adapter0/frontend0): AddListener(0x7eff50027d78) -- end 2014-05-08 10:25:13.213075 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x1 2014-05-08 10:25:13.213286 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x10 2014-05-08 10:25:13.213360 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x11 2014-05-08 10:25:13.213433 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x12 2014-05-08 10:25:13.213506 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x14 2014-05-08 10:25:13.213581 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x200 2014-05-08 10:25:13.213661 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x201 2014-05-08 10:25:13.213745 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x202 2014-05-08 10:25:13.213831 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x204 2014-05-08 10:25:13.213920 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x210 2014-05-08 10:25:13.214011 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x220 2014-05-08 10:25:13.214112 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x230 2014-05-08 10:25:13.214207 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x240 2014-05-08 10:25:13.214305 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x270 2014-05-08 10:25:13.214406 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x280 2014-05-08 10:25:13.214509 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x299 2014-05-08 10:25:13.214616 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0xf02 2014-05-08 10:25:13.256317 I DTVRec[9]: PID 0x202 Found Payload Start 2014-05-08 10:25:13.256439 I DTVRec[9]: PID 0x201 Found Payload Start 2014-05-08 10:25:14.304327 I DTVRec[9]: FindMPEG2Keyframes: frame rate = 25000 2014-05-08 10:25:22.462804 I TVRec[9]: ClearFlags(RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning, 2014-05-08 10:25:22.464681 I TVRec[9]: HandleTuning Request: Program(NULL) channel(508) input() flags(LiveTV,) 2014-05-08 10:25:22.466130 I TVRec[9]: HW Tuner: 9->9 2014-05-08 10:25:22.499441 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff50027d78) -- begin 2014-05-08 10:25:22.499451 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff50027d78) -- locked 2014-05-08 10:25:22.512627 I TVRec[9]: ClearFlags(PENDINGACTIONS,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning, 2014-05-08 10:25:22.512645 I TVRec[9]: Waiting for recorder pause.. 2014-05-08 10:25:22.512655 I TVRec[9]: SetFlags(WaitingForRecPause,) -> FrontendReady,RunMainLoop,CancelNextRecording,WaitingForRecPause,RecorderRunning, 2014-05-08 10:25:22.520260 I DVBSH(/dev/dvb/adapter0/frontend0): RunTS(): shutdown 2014-05-08 10:25:22.520284 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x0 2014-05-08 10:25:22.520370 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x1 2014-05-08 10:25:22.520393 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x10 2014-05-08 10:25:22.520412 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x11 2014-05-08 10:25:22.520430 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x12 2014-05-08 10:25:22.520447 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x14 2014-05-08 10:25:22.520464 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x200 2014-05-08 10:25:22.520481 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x201 2014-05-08 10:25:22.520497 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x202 2014-05-08 10:25:22.520513 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x204 2014-05-08 10:25:22.520528 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x210 2014-05-08 10:25:22.520543 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x220 2014-05-08 10:25:22.520589 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x230 2014-05-08 10:25:22.520605 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x240 2014-05-08 10:25:22.520619 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x270 2014-05-08 10:25:22.520634 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x280 2014-05-08 10:25:22.520647 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x299 2014-05-08 10:25:22.520660 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0xf02 2014-05-08 10:25:22.921103 I DevRdB(/dev/dvb/adapter0/frontend0): Stop() -- begin 2014-05-08 10:25:22.921266 I DevRdB(/dev/dvb/adapter0/frontend0): Stop() -- end 2014-05-08 10:25:22.921280 I DevRdB(/dev/dvb/adapter0/frontend0): Stop() -- begin 2014-05-08 10:25:22.921293 I DevRdB(/dev/dvb/adapter0/frontend0): Stop() -- end 2014-05-08 10:25:22.937308 I DVBSH(/dev/dvb/adapter0/frontend0): RunTS(): end 2014-05-08 10:25:22.937323 I DVBSH(/dev/dvb/adapter0/frontend0): run(): end 2014-05-08 10:25:22.938360 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff50027d78) -- end 2014-05-08 10:25:22.938422 I TVRec[9]: ClearFlags(WaitingForRecPause,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning, 2014-05-08 10:25:22.938434 I TVRec[9]: Recorder paused, calling TuningFrequency 2014-05-08 10:25:22.939859 E TVRec[9]: Failed to set channel to 508. Reverting to kState_None 2014-05-08 10:25:22.939883 I TVRec[9]: Changing from WatchingLiveTV to None 2014-05-08 10:25:22.940412 I TVRec[9]: ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning, 2014-05-08 10:25:22.940429 I TVRec[9]: HandleTuning Request: Program(NULL) channel() input() flags(KillRec,KillRingBuffer,) 2014-05-08 10:25:22.942015 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff50027d78) -- begin 2014-05-08 10:25:22.942024 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff50027d78) -- locked 2014-05-08 10:25:22.942030 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff50027d78) -- end 2014-05-08 10:25:22.942049 I DVBRec[9](/dev/dvb/adapter0/frontend0): Close() -- begin 2014-05-08 10:25:22.942067 I DVBRec[9](/dev/dvb/adapter0/frontend0): Close() -- end 2014-05-08 10:25:22.944286 I TVRec[9]: ClearFlags(RecorderRunning,) -> RunMainLoop, 2014-05-08 10:25:22.944391 I RecordingQuality() start(2014-05-07T23:00:00Z) end(2014-05-08T01:30:00Z) score(0) 2014-05-08 10:25:22.944620 I RecBase[9](/dev/dvb/adapter0/frontend0): SetRecording(0x0) 2014-05-08 10:25:22.946525 I TVRec[9]: FinishedRecording(1007_2014-05-08T00:25:12Z) damaged recq: 2014-05-08 10:25:22.946566 I TVRec[9]: FinishedRecording(1007_2014-05-08T00:25:12Z) title: The Morning Show in recgroup: LiveTV status: Recorder Failed:Recorder Failed not_dummy finished_now 2014-05-08 10:25:22.947108 I Chain: Updated endtime for '1007_20140508002512' to 20140508002522 2014-05-08 10:25:22.948836 I SaveVideoProperties(0x3a, 0x22) 2014-05-08 10:25:22.950919 I TVRec[9]: ClearFlags(RecorderRunning,) -> RunMainLoop, 2014-05-08 10:25:22.950930 I TVRec[9]: Tearing down RingBuffer 2014-05-08 10:25:22.951418 I TVRec[9]: ClearFlags(PENDINGACTIONS,) -> RunMainLoop, 2014-05-08 10:25:29.622241 I MainServer::ANN Playback 2014-05-08 10:25:29.622261 I adding: mediac as a client (events: 0) 2014-05-08 10:25:29.624258 I TVRec[9]: StopLiveTV(void) curRec: 0x0 pseudoRec: 0x0 2014-05-08 10:25:29.625915 I TVRec[9]: SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop, 2014-05-08 10:25:29.631640 I Getting next free recorder after : -1 2014-05-08 10:25:29.631649 I Checking card 9. Best card so far -1 2014-05-08 10:25:29.632624 I Checking card 11. Best card so far 9 2014-05-08 10:25:29.632880 I Checking card 13. Best card so far 9 2014-05-08 10:25:29.633103 I Checking card 15. Best card so far 9 2014-05-08 10:25:29.633321 I Checking card 17. Best card so far 9 2014-05-08 10:25:29.633540 I Best card is 9 2014-05-08 10:25:29.639542 I MainServer::ANN Playback 2014-05-08 10:25:29.639549 I adding: mediac as a client (events: 0) 2014-05-08 10:25:29.645070 I TVRec[9]: Found channel (7) on current card(9). 2014-05-08 10:25:29.649023 I TVRec[9]: Changing from None to WatchingLiveTV 2014-05-08 10:25:29.649042 I TVRec[9]: ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2014-05-08 10:25:29.649056 I TVRec[9]: HandleTuning Request: Program(NULL) channel() input() flags(LiveTV,) 2014-05-08 10:25:29.650245 I TVRec[9]: HW Tuner: 9->9 2014-05-08 10:25:29.651471 I TVRec[9]: ClearFlags(PENDINGACTIONS,) -> RunMainLoop, 2014-05-08 10:25:29.651483 I TVRec[9]: No recorder yet, calling TuningFrequency 2014-05-08 10:25:29.652687 I TVRec[9]: CreateLiveTVRingBuffer(7) 2014-05-08 10:25:29.652894 I TVRec[9]: GetProgramRingBufferForLiveTV() 2014-05-08 10:25:29.655890 N AutoExpire: CalcParams(): Max required Free Space: 7.0 GB w/freq: 14 min 2014-05-08 10:25:29.667535 I TVRec[9]: StartedRecording(1007_2014-05-08T00:25:29Z) fn(/tv/1007_20140508002529.mpg) 2014-05-08 10:25:29.669852 I Chain: Appended@0 '1007_20140508002529' 2014-05-08 10:25:29.671456 I TVRec[9]: Starting Signal Monitor 2014-05-08 10:25:29.671467 I TVRec[9]: SetupSignalMonitor(1, 1) 2014-05-08 10:25:29.957087 I TVRec[9]: Signal monitor successfully created 2014-05-08 10:25:29.957115 I TVRec[9]: Setting up table monitoring. 2014-05-08 10:25:29.962735 I Using profile 'Live TV' to record 2014-05-08 10:25:29.962844 I TVRec[9]: DVB service_id 1312 on net_id 4115 tsid 1282 2014-05-08 10:25:29.962953 I TVRec[9]: Successfully set up DVB table monitoring. 2014-05-08 10:25:29.963510 I TVRec[9]: SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning, 2014-05-08 10:25:29.963547 I TVRec[9]: ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning, 2014-05-08 10:25:29.963571 I TVRec[9]: SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning, 2014-05-08 10:25:29.963599 I TVRec[9]: SetFlags(DummyRecorderRunning,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2014-05-08 10:25:29.963611 I DummyDTVRecorder -- started 2014-05-08 10:25:29.963635 I TVRec[9]: SetFlags(RingBufferReady,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:29.963663 I TVRec[9]: ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:29.963688 I TVRec[9]: SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:29.963776 I TVRec[9]: TuningSignalCheck: Still waiting. Will timeout @ 11:30:00.000 2014-05-08 10:25:29.963970 I TVRec[9]: SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:29.963970 E SendResponse: Unable to write to client socket, as it's no longer there 2014-05-08 10:25:29.980177 I TVRec[9]: StopLiveTV(void) curRec: 0x7eff500027c0 pseudoRec: 0x0 2014-05-08 10:25:29.991324 I TVRec[9]: Changing from WatchingLiveTV to None 2014-05-08 10:25:29.992753 I TVRec[9]: ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:29.992804 I TVRec[9]: HandleTuning Request: Program(NULL) channel() input() flags(KillRec,KillRingBuffer,) 2014-05-08 10:25:29.997475 I TVRec[9]: TeardownSignalMonitor() -- begin 2014-05-08 10:25:30.201027 I SH(/dev/dvb/adapter0/frontend0): AddListener(0x7eff500a1658) -- begin 2014-05-08 10:25:30.201089 I SH(/dev/dvb/adapter0/frontend0): AddListener(0x7eff500a1658) -- locked 2014-05-08 10:25:30.201430 I DVBSH(/dev/dvb/adapter0/frontend0): run(): begin 2014-05-08 10:25:30.207236 I DVBSH(/dev/dvb/adapter0/frontend0): RunTS(): begin 2014-05-08 10:25:30.207349 I PIDInfo(/dev/dvb/adapter0/frontend0): Opening filter for pid 0x0 2014-05-08 10:25:30.301344 I SH(/dev/dvb/adapter0/frontend0): AddListener(0x7eff500a1658) -- end 2014-05-08 10:25:30.352234 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff500a1658) -- begin 2014-05-08 10:25:30.352265 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff500a1658) -- locked 2014-05-08 10:25:30.691459 I DVBSH(/dev/dvb/adapter0/frontend0): RunTS(): shutdown 2014-05-08 10:25:30.691513 I PIDInfo(/dev/dvb/adapter0/frontend0): Closing filter for pid 0x0 2014-05-08 10:25:31.094139 I DVBSH(/dev/dvb/adapter0/frontend0): RunTS(): end 2014-05-08 10:25:31.094166 I DVBSH(/dev/dvb/adapter0/frontend0): run(): end 2014-05-08 10:25:31.094382 I SH(/dev/dvb/adapter0/frontend0): RemoveListener(0x7eff500a1658) -- end 2014-05-08 10:25:31.094502 I TVRec[9]: TeardownSignalMonitor() -- end 2014-05-08 10:25:31.094533 I TVRec[9]: ClearFlags(SignalMonitorRunning,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:31.094652 I TVRec[9]: ClearFlags(WaitingForSignal,) -> RunMainLoop,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2014-05-08 10:25:31.095734 I TVRec[9]: FinishedRecording(1007_2014-05-08T00:25:29Z) title: The Morning Show in recgroup: LiveTV status: Unknown:Recorder Failed is_dummy finished_now 2014-05-08 10:25:31.096803 I Chain: Updated endtime for '1007_20140508002529' to 20140508002531 2014-05-08 10:25:31.099315 I TVRec[9]: ClearFlags(DummyRecorderRunning,) -> RunMainLoop,NeedToStartRecorder,RingBufferReady, 2014-05-08 10:25:31.100549 I TVRec[9]: ClearFlags(RecorderRunning,) -> RunMainLoop,NeedToStartRecorder,RingBufferReady, 2014-05-08 10:25:31.101717 I TVRec[9]: FinishedRecording(1007_2014-05-08T00:25:29Z) title: The Morning Show in recgroup: LiveTV status: Recorder Failed:Recorder Failed not_dummy already_finished 2014-05-08 10:25:31.102780 I TVRec[9]: ClearFlags(RecorderRunning,) -> RunMainLoop,NeedToStartRecorder,RingBufferReady, 2014-05-08 10:25:31.102809 I TVRec[9]: Tearing down RingBuffer 2014-05-08 10:25:31.103403 I TVRec[9]: ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady, ^C2014-05-08 10:26:17.609086 C Received Interrupt: Code 128, PID 0, UID 0, Value 0x00000000 2014-05-08 10:26:17.612490 N MythBackend exiting 2014-05-08 10:26:17.613701 E MythSocket(279c0d0:53): Programmer error, QEventLoop isn't running and deleting MythSocket(0x279c0d0) 2014-05-08 10:26:17.614421 E MythSocket(27a9d40:56): Programmer error, QEventLoop isn't running and deleting MythSocket(0x27a9d40) 2014-05-08 10:26:17.619008 I Bonjour: De-registering service '_mythbackend._tcp.' on 'Mythbackend on mediac' 2014-05-08 10:26:18.741634 I TVRec[9]: ClearFlags(RunMainLoop,) -> RingBufferReady, 2014-05-08 10:26:18.748845 I TVRec[9]: ClearFlags(RecorderRunning,) -> RingBufferReady, 2014-05-08 10:26:18.749700 I TVRec[11]: ClearFlags(RunMainLoop,) -> 0x0 2014-05-08 10:26:18.754988 I TVRec[11]: ClearFlags(RecorderRunning,) -> 0x0 2014-05-08 10:26:18.755758 I TVRec[13]: ClearFlags(RunMainLoop,) -> 0x0 2014-05-08 10:26:18.761836 I TVRec[13]: ClearFlags(RecorderRunning,) -> 0x0 2014-05-08 10:26:18.762610 I TVRec[15]: ClearFlags(RunMainLoop,) -> 0x0 2014-05-08 10:26:18.768347 I TVRec[15]: ClearFlags(RecorderRunning,) -> 0x0 2014-05-08 10:26:18.769184 I TVRec[17]: ClearFlags(RunMainLoop,) -> 0x0 2014-05-08 10:26:18.769330 I TVRec[17]: ClearFlags(RecorderRunning,) -> 0x0 2014-05-08 10:26:18.769907 I Waiting for threads to exit. $ Script done on Thu 08 May 2014 10:26:23 EST