2009-06-19 17:11:57.762 mythbackend version: trunk [20728M] www.mythtv.org 2009-06-19 17:11:57.763 Using runtime prefix = /usr/local 2009-06-19 17:11:57.764 Empty LocalHostName. 2009-06-19 17:11:57.764 Using localhost value of living.kristjansson.com 2009-06-19 17:11:57.771 New DB connection, total: 1 2009-06-19 17:11:57.778 Connected to database 'mythconverg' at host: localhost 2009-06-19 17:11:57.778 Closing DB connection named 'DBManager0' 2009-06-19 17:11:57.779 Connected to database 'mythconverg' at host: localhost 2009-06-19 17:11:57.786 Current Schema Version: 1235 2009-06-19 17:11:57.790 MythBackend: Starting up as the master server. 2009-06-19 17:11:57.801 New DB connection, total: 2 2009-06-19 17:11:57.801 Connected to database 'mythconverg' at host: localhost 2009-06-19 17:11:57.808 TVRec(1): Start channel: 25_1. 2009-06-19 17:11:57.811 DVBChan(1:/dev/dvb/adapter0/frontend0): Opening DVB channel 2009-06-19 17:11:57.811 DVBChan(1:/dev/dvb/adapter0/frontend0): Using DVB card /dev/dvb/adapter0/frontend0, with frontend 'LG Electronics LGDT3303 VSB/QAM Frontend'. 2009-06-19 17:11:57.811 New DB connection, total: 3 2009-06-19 17:11:57.812 Connected to database 'mythconverg' at host: localhost 2009-06-19 17:11:57.819 ChannelBase(1): Input #1: 'DVBInput' schan(25_1) sourceid(2) ccid(1) 2009-06-19 17:11:57.819 ChannelBase(1): Current Input #1: 'DVBInput' 2009-06-19 17:11:57.820 DVBChan(1:/dev/dvb/adapter0/frontend0): SetChannelByString(25_1): 2009-06-19 17:11:57.826 DVBChan(1:/dev/dvb/adapter0/frontend0): 533000000 8vsb a auto auto a a auto a v 2009-06-19 17:11:57.826 DVBChan(1:/dev/dvb/adapter0/frontend0): Old Params: 0 auto a auto auto a a auto a v DVBChan(1:/dev/dvb/adapter0/frontend0): New Params: 533000000 8vsb a auto auto a a auto a v 2009-06-19 17:11:57.826 DVBChan(1:/dev/dvb/adapter0/frontend0): Tune(): Tuning to 533000000Hz 2009-06-19 17:11:57.830 dvbchannel.cpp:wait_for_backend: Status: 2009-06-19 17:11:57.830 DVBChan(1:/dev/dvb/adapter0/frontend0): Tune(): Frequency tuning successful. 2009-06-19 17:11:57.830 DVBChan(1:/dev/dvb/adapter0/frontend0): SetChannelByString(25_1): Tuned to frequency. 2009-06-19 17:11:57.847 TVRec(1): SetFlags(RunMainLoop,) -> RunMainLoop, 2009-06-19 17:11:57.847 TVRec(1): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2009-06-19 17:11:57.855 TVRec(2): Start channel: 5_1. 2009-06-19 17:11:57.855 DVBChan(2:/dev/dvb/adapter0/frontend0): Opening DVB channel 2009-06-19 17:11:57.855 DVBChan(1:/dev/dvb/adapter0/frontend0): Opening DVB channel 2009-06-19 17:11:57.861 ChannelBase(2): Input #2: 'DVBInput' schan(5_1) sourceid(2) ccid(2) 2009-06-19 17:11:57.861 ChannelBase(2): Current Input #2: 'DVBInput' 2009-06-19 17:11:57.862 DVBChan(2:/dev/dvb/adapter0/frontend0): SetChannelByString(5_1): 2009-06-19 17:11:57.867 DVBChan(2:/dev/dvb/adapter0/frontend0): 653000000 8vsb a auto auto a a auto a v 2009-06-19 17:11:57.867 DVBChan(2:/dev/dvb/adapter0/frontend0): tuning on slave channel 2009-06-19 17:11:57.867 DVBChan(1:/dev/dvb/adapter0/frontend0): Old Params: 533000000 8vsb a auto auto a a auto a v DVBChan(1:/dev/dvb/adapter0/frontend0): New Params: 653000000 8vsb a auto auto a a auto a v 2009-06-19 17:11:57.867 DVBChan(1:/dev/dvb/adapter0/frontend0): Tune(): Tuning to 653000000Hz 2009-06-19 17:11:57.871 dvbchannel.cpp:wait_for_backend: Status: 2009-06-19 17:11:57.871 DVBChan(1:/dev/dvb/adapter0/frontend0): Tune(): Frequency tuning successful. 2009-06-19 17:11:57.871 DVBChan(2:/dev/dvb/adapter0/frontend0): SetChannelByString(5_1): Tuned to frequency. 2009-06-19 17:11:57.873 TVRec(2): SetFlags(RunMainLoop,) -> RunMainLoop, 2009-06-19 17:11:57.873 TVRec(2): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2009-06-19 17:11:57.875 TVRec(4): Start channel: 9422. 2009-06-19 17:11:57.875 Channel(/dev/video1): Device name 'Haupauge HD PVR' driver 'hdpvr'. 2009-06-19 17:11:57.919 ChannelBase(4): Input #4: 'Component' schan(9422) sourceid(1) ccid(4) 2009-06-19 17:11:57.920 ChannelBase(4): Current Input #4: 'Component' 2009-06-19 17:11:57.921 Global TVFormat Setting 'NTSC' 2009-06-19 17:11:57.921 Channel(/dev/video1): Input #4: 'Component' schan(9422) tun() v4l1(NTSC) v4l2(NTSC) 2009-06-19 17:11:57.921 Channel(/dev/video1): SetFormat(Default) fmt(NTSC) input(4) 2009-06-19 17:11:57.921 Channel(/dev/video1): SetInputAndFormat(4, NTSC) (v4l v2) 2009-06-19 17:11:57.955 Channel(/dev/video1): SetFormat(NTSC) fmt(NTSC) input(4) 2009-06-19 17:11:57.956 Channel(/dev/video1)::SwitchToInput(in 4, '') 2009-06-19 17:11:57.957 Channel(/dev/video1): SetInputAndFormat(4, NTSC) (v4l v2) 2009-06-19 17:11:57.995 Channel(/dev/video1): SetChannelByString(9422) 2009-06-19 17:11:57.997 Channel(/dev/video1): SetFormat(Default) fmt(NTSC) input(4) 2009-06-19 17:11:57.998 External channel change: /home/danielk/change-channel-lirc.sh 9422 2009-06-19 17:11:58.000 Waiting for External Tuning program to exit 2009-06-19 17:11:59.000 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:00.000 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:01.001 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:02.001 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:03.001 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:04.001 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:05.001 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:06.002 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:07.002 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:08.002 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:09.002 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:10.002 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:11.003 ret_pid(0) child(7412) status(0x0) 2009-06-19 17:12:11.201 ret_pid(7412) child(7412) status(0x0) 2009-06-19 17:12:11.201 External Tuning program no longer running 2009-06-19 17:12:11.201 External Tuning program exited with no error 2009-06-19 17:12:11.203 Channel(/dev/video1): InitPictureAttribute(brightness): 133 [ 0, 255] dflt( 134, 0.53, 1670) 2009-06-19 17:12:11.223 Channel(/dev/video1): InitPictureAttribute( contrast): 127 [ 0, 255] dflt( 128, 0.50, 128) 2009-06-19 17:12:11.243 Channel(/dev/video1): InitPictureAttribute( colour): 127 [ 0, 255] dflt( 128, 0.50, 128) 2009-06-19 17:12:11.263 Channel(/dev/video1): InitPictureAttribute( hue): 127 [ 0, 255] dflt( 128, 0.50, 128) 2009-06-19 17:12:11.284 TVRec(4): SetFlags(RunMainLoop,) -> RunMainLoop, 2009-06-19 17:12:11.284 TVRec(4): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2009-06-19 17:12:11.285 TVRec(6): Start channel: 108. 2009-06-19 17:12:11.285 Channel(/dev/video0): Device name 'Haupauge HD PVR' driver 'hdpvr'. 2009-06-19 17:12:11.348 ChannelBase(6): Input #5: 'Component' schan(108) sourceid(1) ccid(6) 2009-06-19 17:12:11.348 ChannelBase(6): Current Input #5: 'Component' 2009-06-19 17:12:11.348 Global TVFormat Setting 'NTSC' 2009-06-19 17:12:11.348 Channel(/dev/video0): Input #5: 'Component' schan(108) tun() v4l1(NTSC) v4l2(NTSC) 2009-06-19 17:12:11.349 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(5) 2009-06-19 17:12:11.349 Channel(/dev/video0): SetInputAndFormat(5, NTSC) (v4l v2) 2009-06-19 17:12:11.382 Channel(/dev/video0): SetFormat(NTSC) fmt(NTSC) input(5) 2009-06-19 17:12:11.382 Channel(/dev/video0)::SwitchToInput(in 5, '') 2009-06-19 17:12:11.383 Channel(/dev/video0): SetInputAndFormat(5, NTSC) (v4l v2) 2009-06-19 17:12:11.419 Channel(/dev/video0): SetChannelByString(108) 2009-06-19 17:12:11.421 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(5) 2009-06-19 17:12:11.422 External channel change: /home/danielk/change-channel-lirc-2.sh 108 2009-06-19 17:12:11.424 Waiting for External Tuning program to exit 2009-06-19 17:12:12.424 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:13.424 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:14.424 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:15.425 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:16.425 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:17.425 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:18.425 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:19.426 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:20.426 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:21.426 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:22.426 ret_pid(0) child(7452) status(0x0) 2009-06-19 17:12:22.972 ret_pid(7452) child(7452) status(0x0) 2009-06-19 17:12:22.972 External Tuning program no longer running 2009-06-19 17:12:22.972 External Tuning program exited with no error 2009-06-19 17:12:22.974 Channel(/dev/video0): InitPictureAttribute(brightness): 133 [ 0, 255] dflt( 134, 0.53, 1670) 2009-06-19 17:12:22.991 Channel(/dev/video0): InitPictureAttribute( contrast): 127 [ 0, 255] dflt( 128, 0.50, 128) 2009-06-19 17:12:23.012 Channel(/dev/video0): InitPictureAttribute( colour): 127 [ 0, 255] dflt( 128, 0.50, 128) 2009-06-19 17:12:23.031 Channel(/dev/video0): InitPictureAttribute( hue): 127 [ 0, 255] dflt( 128, 0.50, 128) 2009-06-19 17:12:23.052 TVRec(6): SetFlags(RunMainLoop,) -> RunMainLoop, 2009-06-19 17:12:23.052 TVRec(6): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2009-06-19 17:12:23.053 New DB scheduler connection 2009-06-19 17:12:23.054 Connected to database 'mythconverg' at host: localhost 2009-06-19 17:12:23.056 Scheduler, Warning: Listings source 'EIT - DVB - S' is defined, but is not attached to a card input. 2009-06-19 17:12:23.099 Enabling Upnpmedia rebuild thread. 2009-06-19 17:12:24.244 Main::Registering HttpStatus Extension 2009-06-19 17:12:24.244 Enabled verbose msgs: important general record channel 2009-06-19 17:12:24.249 AutoExpire: CalcParams(): Max required Free Space: 1.0 GB w/freq: 15 min 2009-06-19 17:12:26.062 Reschedule requested for id -1. 2009-06-19 17:12:31.100 Scheduled 860 items in 5.0 = 0.08 match + 4.93 place 2009-06-19 17:12:31.104 Seem to be woken up by USER 2009-06-19 17:12:33.392 UPnpMedia: BuildMediaMap VIDEO scan starting in :/jessdell-video/external: 2009-06-19 17:12:33.402 UPnpMedia: BuildMediaMap Done. Found 0 objects 2009-06-19 17:12:33.402 UPnpMedia: BuildMediaMap VIDEO scan starting in :/video: 2009-06-19 17:12:34.485 UPnpMedia: BuildMediaMap Done. Found 1969 objects 2009-06-19 17:13:19.651 MainServer::ANN Monitor 2009-06-19 17:13:19.651 adding: living.kristjansson.com as a client (events: 0) 2009-06-19 17:13:19.651 MainServer::ANN Monitor 2009-06-19 17:13:19.651 adding: living.kristjansson.com as a client (events: 1) 2009-06-19 17:13:24.672 Getting next free recorder after : -1 2009-06-19 17:13:24.674 Checking card 1. Best card so far 1 2009-06-19 17:13:24.674 Checking card 2. Best card so far 2 2009-06-19 17:13:24.674 Checking card 3. Best card so far 2 2009-06-19 17:13:24.674 Checking card 4. Best card so far 4 2009-06-19 17:13:24.674 Checking card 6. Best card so far 6 2009-06-19 17:13:24.699 MainServer::ANN Playback 2009-06-19 17:13:24.699 adding: living.kristjansson.com as a client (events: 0) 2009-06-19 17:13:24.701 TVRec(6): Changing from None to Watching WatchingLiveTV 2009-06-19 17:13:24.701 TVRec(6): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2009-06-19 17:13:24.701 TVRec(6): Request: Program(no) channel() input() flags(LiveTV,) 2009-06-19 17:13:24.702 TVRec(6): Start channel: 108. 2009-06-19 17:13:24.706 TVRec(6): HW Tuner: 6->6 2009-06-19 17:13:24.706 TVRec(6): ClearFlags(PENDINGACTIONS,) -> RunMainLoop, 2009-06-19 17:13:24.707 TVRec(6): No recorder yet, calling TuningFrequency 2009-06-19 17:13:24.707 Channel(/dev/video0): Device name 'Haupauge HD PVR' driver 'hdpvr'. 2009-06-19 17:13:24.767 ChannelBase(6): Input #5: 'Component' schan(108) sourceid(1) ccid(6) 2009-06-19 17:13:24.767 ChannelBase(6): Current Input #5: 'Component' 2009-06-19 17:13:24.767 Global TVFormat Setting 'NTSC' 2009-06-19 17:13:24.767 Channel(/dev/video0): Input #5: 'Component' schan(108) tun() v4l1(NTSC) v4l2(NTSC) 2009-06-19 17:13:24.767 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(5) 2009-06-19 17:13:24.767 Channel(/dev/video0)::SwitchToInput(in 5, '') 2009-06-19 17:13:24.770 Channel(/dev/video0): SetInputAndFormat(5, NTSC) (v4l v2) 2009-06-19 17:13:24.810 Channel(/dev/video0): SetChannelByString(108) 2009-06-19 17:13:24.814 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(5) 2009-06-19 17:13:24.815 External channel change: /home/danielk/change-channel-lirc-2.sh 108 2009-06-19 17:13:24.817 Waiting for External Tuning program to exit 2009-06-19 17:13:25.817 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:26.817 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:27.818 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:28.818 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:29.818 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:30.818 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:31.819 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:32.819 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:33.819 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:34.819 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:35.819 ret_pid(0) child(7521) status(0x0) 2009-06-19 17:13:36.367 ret_pid(7521) child(7521) status(0x0) 2009-06-19 17:13:36.367 External Tuning program no longer running 2009-06-19 17:13:36.367 External Tuning program exited with no error 2009-06-19 17:13:36.368 Channel(/dev/video0): InitPictureAttribute(brightness): 133 [ 0, 255] dflt( 134, 0.53, 1670) 2009-06-19 17:13:36.387 Channel(/dev/video0): InitPictureAttribute( contrast): 127 [ 0, 255] dflt( 128, 0.50, 128) 2009-06-19 17:13:36.407 Channel(/dev/video0): InitPictureAttribute( colour): 127 [ 0, 255] dflt( 128, 0.50, 128) 2009-06-19 17:13:36.428 Channel(/dev/video0): InitPictureAttribute( hue): 127 [ 0, 255] dflt( 128, 0.50, 128) 2009-06-19 17:13:36.447 TVRec(6): CreateLiveTVRingBuffer() 2009-06-19 17:13:36.447 TVRec(6): GetProgramRingBufferForLiveTV() 2009-06-19 17:13:36.503 TVRec(6): StartedRecording(0x9340830) fn(/video/livetv/10502_20090619171336.mpg) 2009-06-19 17:13:36.510 Chain: Appended@0 '10502_20090619171336' 2009-06-19 17:13:36.511 TVRec(6): Starting Signal Monitor 2009-06-19 17:13:36.511 TVRec(6): SetupSignalMonitor(1, 1) 2009-06-19 17:13:36.512 AnalogSM: /dev/video0 card 'Haupauge HD PVR' driver 'hdpvr' version '512' 2009-06-19 17:13:36.512 TVRec(6): Signal monitor successfully created 2009-06-19 17:13:36.512 SM(/dev/video0)::Start: begin 2009-06-19 17:13:36.512 AnalogSM: /dev/video0 hd-pvr start encoding 2009-06-19 17:13:36.512 SM(/dev/video0)::Start: end 2009-06-19 17:13:36.512 TVRec(6): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning, 2009-06-19 17:13:36.512 TVRec(6): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning, 2009-06-19 17:13:36.512 TVRec(6): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning, 2009-06-19 17:13:36.512 TVRec(6): SetFlags(DummyRecorderRunning,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2009-06-19 17:13:36.512 DummyDTVRecorder -- started 2009-06-19 17:13:36.512 TVRec(6): SetFlags(RingBufferReady,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2009-06-19 17:13:36.513 TVRec(6): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2009-06-19 17:13:36.513 TVRec(6): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2009-06-19 17:13:36.513 TVRec(6): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2009-06-19 17:13:36.515 TVRec(6): StopLiveTV(void) curRec: 0x9340830 pseudoRec: 0x0 2009-06-19 17:13:36.521 TVRec(6): Changing from Watching WatchingLiveTV to None 2009-06-19 17:13:36.521 TVRec(6): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2009-06-19 17:13:36.521 TVRec(6): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,) 2009-06-19 17:13:36.521 TVRec(6): TeardownSignalMonitor() -- begin 2009-06-19 17:13:36.521 SM(/dev/video0)::Stop: begin 2009-06-19 17:13:36.535 AnalogSM: /dev/video0 hd-pvr wait for data 2009-06-19 17:13:36.743 AnalogSM: /dev/video0 hd-pvr data ready. Stop encoding 2009-06-19 17:13:38.758 AnalogSM: /dev/video0 hd-pvr waiting for valid resolution 2009-06-19 17:13:38.809 SM(/dev/video0)::Stop: end 2009-06-19 17:13:38.809 TVRec(6): TeardownSignalMonitor() -- end 2009-06-19 17:13:38.809 TVRec(6): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2009-06-19 17:13:38.809 TVRec(6): ClearFlags(WaitingForSignal,) -> RunMainLoop,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2009-06-19 17:13:38.809 TVRec(6): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,NeedToStartRecorder,RingBufferReady, 2009-06-19 17:13:38.813 TVRec(6): FinishedRecording(Still Standing) in recgroup: LiveTV 2009-06-19 17:13:38.813 Chain: Updated endtime for '10502_20090619171336' to 20090619171338 2009-06-19 17:13:38.814 Finished recording Still Standing "Still Changing": channel 10502 2009-06-19 17:13:38.815 TVRec(6): Tearing down RingBuffer 2009-06-19 17:13:38.816 TVRec(6): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady, 2009-06-19 17:13:38.816 AutoExpire: CalcParams(): Max required Free Space: 1.0 GB w/freq: 15 min 2009-06-19 17:13:38.818 MythSocket(9309ad8:-1): writeStringList: Error, socket went unconnected. 2009-06-19 17:13:43.063 AutoExpire: CalcParams(): Max required Free Space: 1.0 GB w/freq: 15 min