Ticket #4168: backend4.txt

File backend4.txt, 11.9 KB (added by Mark Buechler <Mark.Buechler@…>, 18 years ago)

Backend log - eit disabled

Line 
12008-02-27 10:10:20.333 Checking card 1. Best card so far -1
22008-02-27 10:10:20.335 Checking card 2. Best card so far 2
32008-02-27 10:10:20.336 Checking card 3. Best card so far 2
42008-02-27 10:10:20.338 Checking card 4. Best card so far 4
52008-02-27 10:10:20.340 Checking card 5. Best card so far 5
62008-02-27 10:10:20.342 Checking card 12. Best card so far 5
72008-02-27 10:10:20.343 Checking card 105. Best card so far 105
82008-02-27 10:10:20.345 Checking card 205. Best card so far 205
92008-02-27 10:10:20.347 Checking card 1000. Best card so far 1000
102008-02-27 10:10:20.348 Checking card 1001. Best card so far 1001
112008-02-27 10:10:20.353 MainServer::HandleAnnounce Playback
122008-02-27 10:10:20.355 adding: pc4 as a client (events: 0)
132008-02-27 10:10:20.359 TVRec(1001): Changing from None to WatchingLiveTV
142008-02-27 10:10:20.362 TVRec(1001): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
152008-02-27 10:10:20.363 TVRec(1001): Request: Program(no) channel() input() flags(LiveTV,)
162008-02-27 10:10:20.366 TVRec(1001): Start channel: 10.
172008-02-27 10:10:20.376 TVRec(1001): HW Tuner: 1001->1001
182008-02-27 10:10:20.378 TVRec(1001): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,
192008-02-27 10:10:20.379 TVRec(1001): No recorder yet, calling TuningFrequency
202008-02-27 10:10:20.384 Channel(/dev/video1): Device name 'WinTV PVR 500 (unit #2)' driver 'ivtv'.
212008-02-27 10:10:21.430 ChannelBase(1001): Input #2: 'S-Video 1' schan(10) sourceid(1) ccid(1001)
222008-02-27 10:10:21.432 ChannelBase(1001): Current Input #2: 'S-Video 1'
232008-02-27 10:10:21.434 Global TVFormat Setting 'NTSC'
242008-02-27 10:10:21.436 Channel(/dev/video1): Input #2: 'S-Video 1' schan(10) tun() v4l1(NTSC) v4l2(NTSC)
252008-02-27 10:10:21.437 Channel(/dev/video1): SetFormat(Default) fmt(NTSC) input(2)
262008-02-27 10:10:21.439 Channel(/dev/video1)::SwitchToInput(in 2, '')
272008-02-27 10:10:21.449 Channel(/dev/video1): SetInputAndFormat(2, NTSC) (v4l v2)
282008-02-27 10:10:21.450 Channel(/dev/video1): SetChannelByString(10)
292008-02-27 10:10:21.461 Channel(/dev/video1): SetFormat(Default) fmt(NTSC) input(2)
302008-02-27 10:10:21.463 External channel change: /usr/local/bin/RCA2.pl 10
312008-02-27 10:10:21.468 Waiting for External Tuning program to exit
32102008-02-27 10:10:22.471 ret_pid(453) child(453) status(0x0)
332008-02-27 10:10:22.476 External Tuning program no longer running
342008-02-27 10:10:22.477 External Tuning program exited with no error
352008-02-27 10:10:22.482 Channel(/dev/video1): InitPictureAttribute(brightness): 128
36 [ 0, 255] dflt( 128, 0.50, 128)
372008-02-27 10:10:22.488 Channel(/dev/video1): InitPictureAttribute( contrast): 63
38 [ 0, 127] dflt( 64, 0.50, 257)
392008-02-27 10:10:22.494 Channel(/dev/video1): InitPictureAttribute( colour): 63
40 [ 0, 127] dflt( 64, 0.50, 257)
412008-02-27 10:10:22.502 Channel(/dev/video1): InitPictureAttribute( hue): 0
42 [ -128, 127] dflt( 0, 0.50, 128)
432008-02-27 10:10:22.505 TVRec(1001): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,
442008-02-27 10:10:22.507 TVRec(1001): SetFlags(NeedToStartRecorder,) -> RunMainLoop,NeedToStartRecorder,
452008-02-27 10:10:22.509 TVRec(1001): Starting Recorder
462008-02-27 10:10:22.580 Using profile 'Live TV' to record
472008-02-27 10:10:22.582 TVRec(1001): CreateLiveTVRingBuffer()
482008-02-27 10:10:22.584 TVRec(1001): GetProgramRingBufferForLiveTV()
492008-02-27 10:10:23.711 TVRec(1001): StartedRecording(0x872e968) fn(/shares/recordings/LiveTV/1010_20080227101022.mpg)
502008-02-27 10:10:23.728 TFW: Using io multiplier 3, min/max = 16384/131072
512008-02-27 10:10:23.737 Chain: Appended@0 '1010_20080227101022'
522008-02-27 10:10:23.743 TVRec(1001): SetFlags(RingBufferReady,) -> RunMainLoop,NeedToStartRecorder,RingBufferReady,
532008-02-27 10:10:23.757 RecBase(1001:/dev/video1): SetRingBuffer(0xae33c838) '/shares/recordings/LiveTV/1010_20080227101022.mpg'
542008-02-27 10:10:23.759 RecBase(1001:/dev/video1): SetRecording(0xae33b6d8) title(Today)
552008-02-27 10:10:23.764 Channel(/dev/video1): InitPictureAttribute(brightness): 128
56 [ 0, 255] dflt( 128, 0.50, 128)
572008-02-27 10:10:23.770 Channel(/dev/video1): InitPictureAttribute( contrast): 63
58 [ 0, 127] dflt( 64, 0.50, 257)
592008-02-27 10:10:23.775 Channel(/dev/video1): InitPictureAttribute( colour): 63
60 [ 0, 127] dflt( 64, 0.50, 257)
612008-02-27 10:10:23.782 Channel(/dev/video1): InitPictureAttribute( hue): 0
62 [ -128, 127] dflt( 0, 0.50, 128)
632008-02-27 10:10:23.785 TVRec(1001): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RingBufferReady,
642008-02-27 10:10:23.786 MPEGRec(/dev/video1): usingv4l2(1) has_v4l2_vbi(1) has_buggy_vbi(1)
652008-02-27 10:10:23.816 MPEGRec(/dev/video1) Warning: Stream type 'MPEG-2 TS'
66 is not supported by ivtv driver, using 'MPEG-2 PS' instead.
672008-02-27 10:10:23.960 MPEGRec(/dev/video1) Warning: VBI recording with broken drivers.
68 Upgrade to ivtv 0.10.0 if you experience problems.
692008-02-27 10:10:24.051 MPEGRec(/dev/video1): VBI service: 4096, io size: 0
702008-02-27 10:10:24.075 TVRec(1001): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady,
712008-02-27 10:10:24.075 AutoExpire: CalcParams(): Max required Free Space: 6.0 GB w/freq: 15 min
722008-02-27 10:10:24.078 TVRec(1001): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady,
732008-02-27 10:10:25.130 Expiring 0 MBytes for 50627 @ Wed Feb 27 10:00:00 2008 => Stargate SG-1 "The Devil You Know"
742008-02-27 10:10:25.141 autoexpire: Expiring Program: Expiring 0 MBytes for 50627 @ Wed Feb 27 10:00:00 2008 => Stargate SG-1 "The Devil You Know"
752008-02-27 10:10:25.144 Expiring 20 MBytes for 50627 @ Wed Feb 27 10:00:00 2008 => Stargate SG-1 "The Devil You Know"
762008-02-27 10:10:25.159 autoexpire: Expiring Program: Expiring 20 MBytes for 50627 @ Wed Feb 27 10:00:00 2008 => Stargate SG-1 "The Devil You Know"
772008-02-27 10:10:26.556 TVRec(1001): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady,
782008-02-27 10:10:37.574 TVRec(1001): StopLiveTV(void) curRec: 0x872e968 pseudoRec: 0
792008-02-27 10:10:37.582 TVRec(1001): Changing from WatchingLiveTV to None
802008-02-27 10:10:37.587 TVRec(1001): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
812008-02-27 10:10:37.590 TVRec(1001): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,)
822008-02-27 10:10:37.718 TVRec(1001): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
832008-02-27 10:10:37.752 TVRec(1001): FinishedRecording(Today) in recgroup: LiveTV
842008-02-27 10:10:37.755 Chain: Updated endtime for '1010_20080227101022' to 20080227101037
852008-02-27 10:10:37.760 Finished recording Today: channel 1010
862008-02-27 10:10:37.769 scheduler: Finished recording: Today: channel 1010
872008-02-27 10:10:37.773 TVRec(1001): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
882008-02-27 10:10:37.775 TVRec(1001): Tearing down RingBuffer
892008-02-27 10:10:37.779 TVRec(1001): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
902008-02-27 10:10:38.002 MainServer::HandleAnnounce Playback
912008-02-27 10:10:38.004 adding: pc4 as a client (events: 0)
922008-02-27 10:10:38.009 TVRec(5): Changing from None to WatchingLiveTV
932008-02-27 10:10:38.011 TVRec(5): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
942008-02-27 10:10:38.013 TVRec(5): Request: Program(no) channel() input() flags(LiveTV,)
952008-02-27 10:10:38.014 ChannelBase(5): Looking for startchannel '110' on input 'DiSEqC v1.3 Input 1'
962008-02-27 10:10:38.038 ChannelBase(5): Found startchannel '110' on input 'DiSEqC v1.3 Input 2'
972008-02-27 10:10:38.041 TVRec(5): HW Tuner: 5->5
982008-02-27 10:10:38.043 TVRec(5): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,
992008-02-27 10:10:38.044 TVRec(5): No recorder yet, calling TuningFrequency
1002008-02-27 10:10:38.047 DVBChan(5:5): Opening DVB channel
1012008-02-27 10:10:38.049 DVBChan(5:5): SetChannelByString(110):
1022008-02-27 10:10:38.064 DVBChan(5:5): 12296900 qpsk a auto auto a a auto a l
1032008-02-27 10:10:38.067 DVBChan(5:5): Old Params: 12326060 qpsk a auto auto a a auto a l
104 DVBChan(5:5): New Params: 12296900 qpsk a auto auto a a auto a l
1052008-02-27 10:10:38.068 DVBChan(5:5): Tune(): Tuning to 1046900kHz
1062008-02-27 10:10:38.084 dvbchannel.cpp:wait_for_backend: Status:
1072008-02-27 10:10:38.087 DVBChan(5:5): Tune(): Frequency tuning successful.
1082008-02-27 10:10:38.088 DVBChan(5:5): SetChannelByString(110): Tuned to frequency.
1092008-02-27 10:10:38.089 TVRec(5): CreateLiveTVRingBuffer()
1102008-02-27 10:10:38.091 TVRec(5): GetProgramRingBufferForLiveTV()
1112008-02-27 10:10:39.154 TVRec(5): StartedRecording(0x872e968) fn(/shares/recordings/LiveTV/3110_20080227101038.mpg)
1122008-02-27 10:10:39.163 TFW: Using io multiplier 3, min/max = 16384/131072
1132008-02-27 10:10:39.172 Chain: Appended@1 '3110_20080227101038'
1142008-02-27 10:10:39.178 TVRec(5): Starting Signal Monitor
1152008-02-27 10:10:39.179 TVRec(5): SetupSignalMonitor(1, 1)
1162008-02-27 10:10:39.181 DVBChan(5:5): Opening DVB channel
1172008-02-27 10:10:39.195 DVBSM(5): Can measure Signal Strength
1182008-02-27 10:10:39.197 DVBSM(5): Can measure S/N
1192008-02-27 10:10:39.198 DVBSM(5): Can measure Bit Error Rate
1202008-02-27 10:10:39.200 DVBSM(5): Can count Uncorrected Blocks
1212008-02-27 10:10:39.201 SM(5)::RemoveFlags: Seen() Match() Wait()
1222008-02-27 10:10:39.203 DVBSM(5): DVBSignalMonitor::ctor initial flags Seen() Match() Wait(Sig,SNR,BER,UB,)
1232008-02-27 10:10:39.204 TVRec(5): Signal monitor successfully created
1242008-02-27 10:10:39.206 TVRec(5): Setting up table monitoring.
1252008-02-27 10:10:39.219 Using profile 'Live TV' to record
1262008-02-27 10:10:39.221 TVRec(5): DVB service_id 110 on net_id 4100 tsid 6
1272008-02-27 10:10:39.223 DTVSM(5)::SetDVBService(transport_id: 6, network_id: 4100, service_id: 110):
1282008-02-27 10:10:39.224 SM(5)::RemoveFlags: Seen(PMT,SDT,Crypt,) Match(PMT,SDT,Crypt,) Wait()
1292008-02-27 10:10:39.226 SM(5)::AddFlags: Seen() Match() Wait(PMT,NIT,)
1302008-02-27 10:10:39.227 SM(5)::AddFlags: Seen() Match() Wait(PMT,NIT,Pos,)
1312008-02-27 10:10:39.228 TVRec(5): Successfully set up DVB table monitoring.
1322008-02-27 10:10:39.230 SM(5)::Start: begin
1332008-02-27 10:10:39.232 DVBSM(5): UpdateValues -- Signal Locked
1342008-02-27 10:10:39.233 SM(5)::Start: end
1352008-02-27 10:10:39.235 DTVSM(5)::GetStatusList: WaitForPMT seen(0) matching(0)
1362008-02-27 10:10:39.236 TVRec(5): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning,
1372008-02-27 10:10:39.240 TVRec(5): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,
1382008-02-27 10:10:39.242 TVRec(5): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,
1392008-02-27 10:10:39.243 TVRec(5): SetFlags(DummyRecorderRunning,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,
1402008-02-27 10:10:39.245 DummyDTVRecorder -- started
1412008-02-27 10:10:39.246 TVRec(5): SetFlags(RingBufferReady,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
1422008-02-27 10:10:39.247 TVRec(5): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
1432008-02-27 10:10:39.249 TVRec(5): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
1442008-02-27 10:10:39.252 TVRec(5): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
1452008-02-27 10:10:39.259 AutoExpire: CalcParams(): Max required Free Space: 7.0 GB w/freq: 15 min