2008-03-13 09:24:32.738 CardUtil:   Group ID 2
2008-03-13 09:24:32.742 CardUtil:   Card ID 4
2008-03-13 09:24:33.326 DTVSM(0): Time Offset: -0.328503
2008-03-13 09:24:33.482 SM(0)::AddFlags: Seen(SDT,) Match() Wait()
2008-03-13 09:24:33.482 DTVSM(0)::SetSDT(): tsid = 16384 orig_net_id = 9018
2008-03-13 09:24:33.482 SM(0)::AddFlags: Seen() Match(SDT,) Wait()
2008-03-13 09:24:33.483 SM(0)::RemoveFlags: Seen() Match() Wait(Pos,)
2008-03-13 09:24:33.501 TVRec(1): Got good signal
2008-03-13 09:24:33.502 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,EITScannerRunning,
2008-03-13 09:24:33.503 EITScanner (1): Started passive scan.
2008-03-13 09:24:33.534 DVBSH(0): AddPIDFilter(0x12) priority 2
2008-03-13 09:24:33.538 PIDInfo(0): Opening filter for pid 0x12
2008-03-13 09:24:33.743 CardUtil:   Group ID 2
2008-03-13 09:24:33.746 CardUtil:   Card ID 4
2008-03-13 09:24:34.296 EITHelper: Added 1 events
2008-03-13 09:24:34.322 DTVSM(0): Time Offset: -0.326479
2008-03-13 09:24:34.703 EITHelper: Added 1 events
2008-03-13 09:24:34.747 CardUtil:   Group ID 2
2008-03-13 09:24:34.750 CardUtil:   Card ID 4
2008-03-13 09:24:35.110 EITHelper: Added 1 events
2008-03-13 09:24:35.314 DTVSM(0): Time Offset: -0.323473
2008-03-13 09:24:35.518 EITHelper: Added 1 events
2008-03-13 09:24:35.751 CardUtil:   Group ID 2
2008-03-13 09:24:35.754 CardUtil:   Card ID 4
2008-03-13 09:24:35.927 EITHelper: Added 1 events
2008-03-13 09:24:36.334 EITHelper: Added 1 events
2008-03-13 09:24:36.358 DTVSM(0): Time Offset: -0.330464
2008-03-13 09:24:36.755 CardUtil:   Group ID 2
2008-03-13 09:24:36.758 CardUtil:   Card ID 4
2008-03-13 09:24:37.350 DTVSM(0): Time Offset: -0.333795
2008-03-13 09:24:37.759 CardUtil:   Group ID 2
2008-03-13 09:24:37.762 CardUtil:   Card ID 4
2008-03-13 09:24:37.766 DTVSM(0)::SetNIT(): net_id = 12294
2008-03-13 09:24:37.770 SM(0)::AddFlags: Seen(NIT,) Match() Wait()
2008-03-13 09:24:37.970 MythSocket(a9240618:-1): DownRef: 0
2008-03-13 09:24:37.974 MythSocket(a9240618:-1): DownRef: -1
2008-03-13 09:24:37.982 MythSocket(a9240618:-1): delete socket
2008-03-13 09:24:38.346 DTVSM(0): Time Offset: -0.335597
2008-03-13 09:24:38.620 MythSocket(82d5e20:41): new socket
2008-03-13 09:24:38.622 MythSocket(82d5e20:41): setSocket: 40
2008-03-13 09:24:38.623 MythSocket(82d5e20:40): state change Idle -> Connected
2008-03-13 09:24:38.623 MythSocket(82d5e20:40): UpRef: 1
2008-03-13 09:24:38.624 MythSocket(82d5e20:40): socket is readable
2008-03-13 09:24:38.630 MythSocket(82d5e20:40): cb->readyRead()
2008-03-13 09:24:38.630 MythSocket(82d5e20:40): UpRef: 2
2008-03-13 09:24:38.631 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:24:38.634 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:24:38.634 MythSocket(82d5e20:40): DownRef: 1
2008-03-13 09:24:38.635 MythSocket(82d5e20:40): socket is readable
2008-03-13 09:24:38.642 MythSocket(82d5e20:40): cb->readyRead()
2008-03-13 09:24:38.642 MythSocket(82d5e20:40): UpRef: 2
2008-03-13 09:24:38.643 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:24:38.646 MainServer::HandleAnnounce Monitor
2008-03-13 09:24:38.646 adding: jawa as a client (events: 0)
2008-03-13 09:24:38.647 write -> 40 2       OK
2008-03-13 09:24:38.647 MythSocket(82d5e20:40): DownRef: 1
2008-03-13 09:24:38.663 MythSocket(82d5e20:40): socket is readable
2008-03-13 09:24:38.667 MythSocket(82d5e20:40): cb->readyRead()
2008-03-13 09:24:38.667 MythSocket(82d5e20:40): UpRef: 2
2008-03-13 09:24:38.668 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:24:38.679 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:24:38.681 MythSocket(82d5e20:40): DownRef: 1
2008-03-13 09:24:38.744 MythSocket(82d5e20:40): socket is readable
2008-03-13 09:24:38.747 MythSocket(82d5e20:40): socket closed
2008-03-13 09:24:38.747 MythSocket(82d5e20:40): state change Connected -> Idle
2008-03-13 09:24:38.748 MythSocket(82d5e20:-1): cb->connectionClosed()
2008-03-13 09:24:38.763 CardUtil:   Group ID 2
2008-03-13 09:24:38.766 CardUtil:   Card ID 4
2008-03-13 09:24:39.342 DTVSM(0): Time Offset: -0.336454
2008-03-13 09:24:39.767 CardUtil:   Group ID 2
2008-03-13 09:24:39.774 CardUtil:   Card ID 4
2008-03-13 09:24:40.334 DTVSM(0): Time Offset: -0.336231
2008-03-13 09:24:40.775 CardUtil:   Group ID 2
2008-03-13 09:24:40.778 CardUtil:   Card ID 4
2008-03-13 09:24:41.326 DTVSM(0): Time Offset: -0.33525
2008-03-13 09:24:41.779 CardUtil:   Group ID 2
2008-03-13 09:24:41.782 CardUtil:   Card ID 4
2008-03-13 09:24:42.310 MythSocket(82d80a8:41): new socket
2008-03-13 09:24:42.314 MythSocket(82d80a8:41): setSocket: 40
2008-03-13 09:24:42.322 DTVSM(0): Time Offset: -0.334086
2008-03-13 09:24:42.326 MythSocket(82d80a8:40): state change Idle -> Connected
2008-03-13 09:24:42.338 MythSocket(82d80a8:40): UpRef: 1
2008-03-13 09:24:42.338 MythSocket(82d80a8:40): socket is readable
2008-03-13 09:24:42.343 MythSocket(82d80a8:40): cb->readyRead()
2008-03-13 09:24:42.343 MythSocket(82d80a8:40): UpRef: 2
2008-03-13 09:24:42.344 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:24:42.346 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:24:42.346 MythSocket(82d80a8:40): DownRef: 1
2008-03-13 09:24:42.347 MythSocket(82d80a8:40): socket is readable
2008-03-13 09:24:42.354 MythSocket(82d80a8:40): cb->readyRead()
2008-03-13 09:24:42.354 MythSocket(82d80a8:40): UpRef: 2
2008-03-13 09:24:42.355 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:24:42.358 MainServer::HandleAnnounce Monitor
2008-03-13 09:24:42.358 adding: jawa as a client (events: 0)
2008-03-13 09:24:42.359 write -> 40 2       OK
2008-03-13 09:24:42.359 MythSocket(82d80a8:40): DownRef: 1
2008-03-13 09:24:42.374 MythSocket(82d80a8:40): socket is readable
2008-03-13 09:24:42.379 MythSocket(82d80a8:40): cb->readyRead()
2008-03-13 09:24:42.379 MythSocket(82d80a8:40): UpRef: 2
2008-03-13 09:24:42.380 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:24:42.391 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:24:42.393 MythSocket(82d80a8:40): DownRef: 1
2008-03-13 09:24:42.542 MythSocket(82d80a8:40): socket is readable
2008-03-13 09:24:42.551 MythSocket(82d80a8:40): socket closed
2008-03-13 09:24:42.551 MythSocket(82d80a8:40): state change Connected -> Idle
2008-03-13 09:24:42.552 MythSocket(82d80a8:-1): cb->connectionClosed()
2008-03-13 09:24:42.783 CardUtil:   Group ID 2
2008-03-13 09:24:42.786 CardUtil:   Card ID 4
2008-03-13 09:24:43.330 DTVSM(0): Time Offset: -0.333782
2008-03-13 09:24:43.787 CardUtil:   Group ID 2
2008-03-13 09:24:43.790 CardUtil:   Card ID 4
2008-03-13 09:24:44.322 DTVSM(0): Time Offset: -0.332911
2008-03-13 09:24:44.791 CardUtil:   Group ID 2
2008-03-13 09:24:44.798 CardUtil:   Card ID 4
2008-03-13 09:24:45.366 DTVSM(0): Time Offset: -0.335308
2008-03-13 09:24:45.799 CardUtil:   Group ID 2
2008-03-13 09:24:45.802 CardUtil:   Card ID 4
2008-03-13 09:24:46.306 DTVSM(0): Time Offset: -0.333385
2008-03-13 09:24:46.803 CardUtil:   Group ID 2
2008-03-13 09:24:46.806 CardUtil:   Card ID 4
2008-03-13 09:24:47.350 DTVSM(0): Time Offset: -0.334451
2008-03-13 09:24:47.807 CardUtil:   Group ID 2
2008-03-13 09:24:47.810 CardUtil:   Card ID 4
2008-03-13 09:24:48.342 DTVSM(0): Time Offset: -0.335194
2008-03-13 09:24:48.811 CardUtil:   Group ID 2
2008-03-13 09:24:48.814 CardUtil:   Card ID 4
2008-03-13 09:24:49.334 DTVSM(0): Time Offset: -0.335696
2008-03-13 09:24:49.815 CardUtil:   Group ID 2
2008-03-13 09:24:49.818 CardUtil:   Card ID 4
2008-03-13 09:24:50.330 DTVSM(0): Time Offset: -0.336198
2008-03-13 09:24:50.819 CardUtil:   Group ID 2
2008-03-13 09:24:50.822 CardUtil:   Card ID 4
2008-03-13 09:24:51.322 DTVSM(0): Time Offset: -0.336698
2008-03-13 09:24:51.823 CardUtil:   Group ID 2
2008-03-13 09:24:51.826 CardUtil:   Card ID 4
2008-03-13 09:24:52.314 DTVSM(0): Time Offset: -0.333948
2008-03-13 09:24:52.623 MythSocket(82d0b68:41): new socket
2008-03-13 09:24:52.626 MythSocket(82d0b68:41): setSocket: 40
2008-03-13 09:24:52.627 MythSocket(82d0b68:40): state change Idle -> Connected
2008-03-13 09:24:52.627 MythSocket(82d0b68:40): UpRef: 1
2008-03-13 09:24:52.628 MythSocket(82d0b68:40): socket is readable
2008-03-13 09:24:52.634 MythSocket(82d0b68:40): cb->readyRead()
2008-03-13 09:24:52.634 MythSocket(82d0b68:40): UpRef: 2
2008-03-13 09:24:52.635 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:24:52.642 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:24:52.642 MythSocket(82d0b68:40): DownRef: 1
2008-03-13 09:24:52.642 MythSocket(82d0b68:40): socket is readable
2008-03-13 09:24:52.646 MythSocket(82d0b68:40): cb->readyRead()
2008-03-13 09:24:52.646 MythSocket(82d0b68:40): UpRef: 2
2008-03-13 09:24:52.647 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:24:52.650 MainServer::HandleAnnounce Monitor
2008-03-13 09:24:52.650 adding: jawa as a client (events: 0)
2008-03-13 09:24:52.651 write -> 40 2       OK
2008-03-13 09:24:52.651 MythSocket(82d0b68:40): DownRef: 1
2008-03-13 09:24:52.666 MythSocket(82d0b68:40): socket is readable
2008-03-13 09:24:52.671 MythSocket(82d0b68:40): cb->readyRead()
2008-03-13 09:24:52.671 MythSocket(82d0b68:40): UpRef: 2
2008-03-13 09:24:52.672 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:24:52.683 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:24:52.685 MythSocket(82d0b68:40): DownRef: 1
2008-03-13 09:24:52.744 MythSocket(82d0b68:40): socket is readable
2008-03-13 09:24:52.755 MythSocket(82d0b68:40): socket closed
2008-03-13 09:24:52.755 MythSocket(82d0b68:40): state change Connected -> Idle
2008-03-13 09:24:52.756 MythSocket(82d0b68:-1): cb->connectionClosed()
2008-03-13 09:24:52.827 CardUtil:   Group ID 2
2008-03-13 09:24:52.830 CardUtil:   Card ID 4
2008-03-13 09:24:53.358 DTVSM(0): Time Offset: -0.334448
2008-03-13 09:24:53.831 CardUtil:   Group ID 2
2008-03-13 09:24:53.834 CardUtil:   Card ID 4
2008-03-13 09:24:54.350 DTVSM(0): Time Offset: -0.334701
2008-03-13 09:24:54.835 CardUtil:   Group ID 2
2008-03-13 09:24:54.838 CardUtil:   Card ID 4
2008-03-13 09:24:55.394 DTVSM(0): Time Offset: -0.337953
2008-03-13 09:24:55.839 CardUtil:   Group ID 2
2008-03-13 09:24:55.842 CardUtil:   Card ID 4
2008-03-13 09:24:56.334 DTVSM(0): Time Offset: -0.337954
2008-03-13 09:24:56.843 CardUtil:   Group ID 2
2008-03-13 09:24:56.846 CardUtil:   Card ID 4
2008-03-13 09:24:57.326 DTVSM(0): Time Offset: -0.337956
2008-03-13 09:24:57.847 CardUtil:   Group ID 2
2008-03-13 09:24:57.850 CardUtil:   Card ID 4
2008-03-13 09:24:58.318 DTVSM(0): Time Offset: -0.337707
2008-03-13 09:24:58.851 CardUtil:   Group ID 2
2008-03-13 09:24:58.854 CardUtil:   Card ID 4
2008-03-13 09:24:59.362 DTVSM(0): Time Offset: -0.339709
2008-03-13 09:24:59.855 CardUtil:   Group ID 2
2008-03-13 09:24:59.858 CardUtil:   Card ID 4
2008-03-13 09:25:00.302 DTVSM(0): Time Offset: -0.338457
2008-03-13 09:25:00.859 CardUtil:   Group ID 2
2008-03-13 09:25:00.862 CardUtil:   Card ID 4
2008-03-13 09:25:01.346 DTVSM(0): Time Offset: -0.337206
2008-03-13 09:25:01.863 CardUtil:   Group ID 2
2008-03-13 09:25:01.866 CardUtil:   Card ID 4
2008-03-13 09:25:02.338 DTVSM(0): Time Offset: -0.339203
2008-03-13 09:25:02.758 MythSocket(83cc870:41): new socket
2008-03-13 09:25:02.762 MythSocket(83cc870:41): setSocket: 40
2008-03-13 09:25:02.763 MythSocket(83cc870:40): state change Idle -> Connected
2008-03-13 09:25:02.763 MythSocket(83cc870:40): UpRef: 1
2008-03-13 09:25:02.764 MythSocket(83cc870:40): socket is readable
2008-03-13 09:25:02.766 MythSocket(83cc870:40): cb->readyRead()
2008-03-13 09:25:02.766 MythSocket(83cc870:40): UpRef: 2
2008-03-13 09:25:02.767 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:25:02.770 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:25:02.770 MythSocket(83cc870:40): DownRef: 1
2008-03-13 09:25:02.771 MythSocket(83cc870:40): socket is readable
2008-03-13 09:25:02.774 MythSocket(83cc870:40): cb->readyRead()
2008-03-13 09:25:02.774 MythSocket(83cc870:40): UpRef: 2
2008-03-13 09:25:02.775 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:25:02.778 MainServer::HandleAnnounce Monitor
2008-03-13 09:25:02.779 adding: jawa as a client (events: 0)
2008-03-13 09:25:02.779 write -> 40 2       OK
2008-03-13 09:25:02.779 MythSocket(83cc870:40): DownRef: 1
2008-03-13 09:25:02.794 MythSocket(83cc870:40): socket is readable
2008-03-13 09:25:02.803 MythSocket(83cc870:40): cb->readyRead()
2008-03-13 09:25:02.803 MythSocket(83cc870:40): UpRef: 2
2008-03-13 09:25:02.804 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:25:02.815 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:25:02.817 MythSocket(83cc870:40): DownRef: 1
2008-03-13 09:25:02.867 CardUtil:   Group ID 2
2008-03-13 09:25:02.875 CardUtil:   Card ID 4
2008-03-13 09:25:02.875 TVRec(3): StartRecording(The Jeremy Kyle Show)
2008-03-13 09:25:02.878 TVRec(3): Checking input group recorders - begin
2008-03-13 09:25:02.878 TVRec(3): Checking input group recorders - done
2008-03-13 09:25:02.953 ProgramInfo: StartedRecording: Recording to '/data/mythtv/recorded/1003_20080313092500.mpg'
2008-03-13 09:25:02.957 TVRec(3): StartedRecording(0x835fd78) fn(/data/mythtv/recorded/1003_20080313092500.mpg)
2008-03-13 09:25:02.958 MythEvent: RECORDING_LIST_CHANGE
2008-03-13 09:25:02.959 MythSocket(83cc870:40): UpRef: 2
2008-03-13 09:25:02.974 MythSocket(83cc870:40): DownRef: 1
2008-03-13 09:25:02.967 MythSocket(83cc870:40): socket is readable
2008-03-13 09:25:02.982 MythSocket(83cc870:40): socket closed
2008-03-13 09:25:02.982 MythSocket(83cc870:40): state change Connected -> Idle
2008-03-13 09:25:02.983 MythSocket(83cc870:-1): cb->connectionClosed()
2008-03-13 09:25:02.959 TVRec(3): ClearFlags(CancelNextRecording,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,EITScannerRunning,
2008-03-13 09:25:03.011 EITCache: Wrote 2 modified entries of 419 for channel 1071 to database.
2008-03-13 09:25:03.018 EITCache: Wrote 2 modified entries of 171 for channel 1081 to database.
2008-03-13 09:25:03.021 EITCache: Wrote 2 modified entries of 71 for channel 1087 to database.
2008-03-13 09:25:03.023 TVRec(3): ClearFlags(EITScannerRunning,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,
2008-03-13 09:25:03.024 TVRec(3): Changing from None to RecordingOnly
2008-03-13 09:25:03.024 TVRec(3): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,
2008-03-13 09:25:03.025 TVRec(3): Request: Program(yes) channel() input() flags(Recording,)
2008-03-13 09:25:03.026 TVRec(3): HW Tuner: 3->3
2008-03-13 09:25:03.056 TVRec(3): TeardownSignalMonitor() -- begin
2008-03-13 09:25:03.057 DVBSM(1): Stop() -- begin
2008-03-13 09:25:03.057 SM(1)::Stop: begin
2008-03-13 09:25:03.065 SM(1)::Stop: end
2008-03-13 09:25:03.066 DVBSH(1): RemoveListener(0x82d74e0) -- begin
2008-03-13 09:25:03.066 DVBSH(1): RemoveListener(0x82d74e0) -- locked
2008-03-13 09:25:03.106 DVBSH(1): RunTS(): shutdown
2008-03-13 09:25:03.110 DVBSH(1): RemovePIDFilter(0x0)
2008-03-13 09:25:03.110 PIDInfo(1): Closing filter for pid 0x0
2008-03-13 09:25:03.111 DVBSH(1): RemovePIDFilter(0x10)
2008-03-13 09:25:03.112 PIDInfo(1): Closing filter for pid 0x10
2008-03-13 09:25:03.112 DVBSH(1): RemovePIDFilter(0x11)
2008-03-13 09:25:03.113 PIDInfo(1): Closing filter for pid 0x11
2008-03-13 09:25:03.113 DVBSH(1): RemovePIDFilter(0x14)
2008-03-13 09:25:03.114 PIDInfo(1): Closing filter for pid 0x14
2008-03-13 09:25:03.115 DVBSH(1): RunTS(): end
2008-03-13 09:25:03.116 DVBSH(1): RemoveListener(0x82d74e0) -- end
2008-03-13 09:25:03.118 DVBSM(1): Stop() -- end
2008-03-13 09:25:03.119 DVBSM(1): Stop() -- begin
2008-03-13 09:25:03.120 SM(1)::Stop: begin
2008-03-13 09:25:03.120 SM(1)::Stop: end
2008-03-13 09:25:03.121 DVBSM(1): Stop() -- end
2008-03-13 09:25:03.121 TVRec(3): TeardownSignalMonitor() -- end
2008-03-13 09:25:03.121 DVBSM(1): Stop() -- begin
2008-03-13 09:25:03.122 TVRec(3): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,WaitingForSignal,
2008-03-13 09:25:03.126 SM(1)::Stop: begin
2008-03-13 09:25:03.130 TVRec(3): ClearFlags(WaitingForSignal,) -> RunMainLoop,
2008-03-13 09:25:03.134 SM(1)::Stop: end
2008-03-13 09:25:03.138 TVRec(3): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,
2008-03-13 09:25:03.142 DVBSM(1): Stop() -- end
2008-03-13 09:25:03.146 TVRec(3): No recorder yet, calling TuningFrequency
2008-03-13 09:25:03.150 SM(1)::Stop: begin
2008-03-13 09:25:03.158 DVBChan(3:1): Opening DVB channel
2008-03-13 09:25:03.162 SM(1)::Stop: end
2008-03-13 09:25:03.170 DVBChan(3:1): SetChannelByString(3): 
2008-03-13 09:25:03.184 DVBChan(3:1): 658166670 qam_64 a 2/3 1/2 8 2 1/32 n v
2008-03-13 09:25:03.185 DVBChan(3:1): Old Params: 746000000 qam_16 a 3/4 1/2 8 2 1/32 n v
			DVBChan(3:1): New Params: 658166670 qam_64 a 2/3 1/2 8 2 1/32 n v
2008-03-13 09:25:03.185 DVBChan(3:1): Tune(): Tuning to 658166670Hz
2008-03-13 09:25:03.334 DTVSM(0): Time Offset: -0.338205
2008-03-13 09:25:03.525 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,Sync,Lock,
2008-03-13 09:25:03.526 DVBChan(3:1): Tune(): Frequency tuning successful.
2008-03-13 09:25:03.526 DVBChan(3:1): SetChannelByString(3): Tuned to frequency.
2008-03-13 09:25:03.527 TVRec(3): Starting Signal Monitor
2008-03-13 09:25:03.527 TVRec(3): SetupSignalMonitor(1, 0)
2008-03-13 09:25:03.528 DVBChan(3:1): Opening DVB channel
2008-03-13 09:25:03.532 DVBSM(1): Can measure Signal Strength
2008-03-13 09:25:03.532 DVBSM(1): Can measure S/N
2008-03-13 09:25:03.536 DVBSM(1): Can measure Bit Error Rate
2008-03-13 09:25:03.538 DVBSM(1): Can count Uncorrected Blocks
2008-03-13 09:25:03.538 SM(1)::RemoveFlags: Seen() Match() Wait()
2008-03-13 09:25:03.539 DVBSM(1): DVBSignalMonitor::ctor initial flags Seen() Match() Wait(Sig,SNR,BER,UB,)
2008-03-13 09:25:03.539 TVRec(3): Signal monitor successfully created
2008-03-13 09:25:03.540 TVRec(3): Setting up table monitoring.
2008-03-13 09:25:03.542 Using profile 'Live TV' to record
2008-03-13 09:25:03.542 TVRec(3): DVB service_id 8262 on net_id 9018 tsid 8198
2008-03-13 09:25:03.543 DTVSM(1)::SetDVBService(transport_id: 8198, network_id: 9018, service_id: 8262): 
2008-03-13 09:25:03.543 SM(1)::RemoveFlags: Seen(PMT,SDT,Crypt,) Match(PMT,SDT,Crypt,) Wait()
2008-03-13 09:25:03.544 SM(1)::AddFlags: Seen() Match() Wait(PMT,SDT,)
2008-03-13 09:25:03.544 SM(1)::AddFlags: Seen() Match() Wait(PMT,SDT,Pos,)
2008-03-13 09:25:03.544 TVRec(3): Successfully set up DVB table monitoring.
2008-03-13 09:25:03.545 SM(1)::Start: begin
2008-03-13 09:25:03.545 SM(1)::AddFlags: Seen() Match() Wait(Sig,)
2008-03-13 09:25:03.545 SM(1)::Start: end
2008-03-13 09:25:03.550 TVRec(3): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning,
2008-03-13 09:25:03.550 TVRec(3): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,
2008-03-13 09:25:03.551 TVRec(3): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,
2008-03-13 09:25:03.551 TVRec(3): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,
2008-03-13 09:25:03.552 TVRec(3): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
2008-03-13 09:25:03.546 SM(1)::RemoveFlags: Seen() Match() Wait(Pos,)
2008-03-13 09:25:03.555 AutoExpire: Cardid 3: is starting a recording on an unknown fsID soon.
2008-03-13 09:25:03.562 AutoExpire: CalcParams()
2008-03-13 09:25:03.564 Cardid 3: max bitrate 142089 KB/min
2008-03-13 09:25:03.564 Maximal bitrate of busy encoders is 142089 KB/min
--- GetFilesystemInfos directory list start ---
Dir: jawa:/data/mythtv/recorded
     Location: Local
     Drive ID: 1
     TotalKB : 195303400
     UsedKB  : 2008-03-13 09:25:03.567 DVBSM(1): UpdateValues -- Signal Locked
2532496
     FreeKB  : 192770904
2008-03-13 09:25:03.570 DVBSH(1): AddListener(0xaa77a9a0) -- begin
--- GetFilesystemInfos directory list end ---

2008-03-13 09:25:03.579 fsID #1: Total:   186.3 GB   Used:     2.4 GB   Free:   183.8 GB
2008-03-13 09:25:03.582 DVBSH(1): AddListener(0xaa77a9a0) -- locked
2008-03-13 09:25:03.586     Cardid 3: max bitrate 18945 Kb/sec, fsID 1 max is now 142089 KB/min
2008-03-13 09:25:03.590 DVBSH(1): AddListener(0xaa77a9a0) -- end
2008-03-13 09:25:03.592 DVBSH(1): RunTS(): begin
2008-03-13 09:25:03.594   Max of 142089 KB/min for fsID 1 is higher than the existing Max of 0 so we'll use this Max instead
2008-03-13 09:25:03.603 DVBSH(1): AddPIDFilter(0x0) priority 2
2008-03-13 09:25:03.606 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 15 min
2008-03-13 09:25:03.610 PIDInfo(1): Opening filter for pid 0x0
2008-03-13 09:25:03.615 Started recording: The Jeremy Kyle Show: channel 1003 on cardid 3, sourceid 1
2008-03-13 09:25:03.623 DVBSH(1): AddPIDFilter(0x10) priority 2
2008-03-13 09:25:03.627 Scheduler: Update next_record for 9
2008-03-13 09:25:03.634 PIDInfo(1): Opening filter for pid 0x10
2008-03-13 09:25:03.642 MythEvent: SCHEDULE_CHANGE
2008-03-13 09:25:03.648 DVBSH(1): AddPIDFilter(0x11) priority 2
2008-03-13 09:25:03.658 PIDInfo(1): Opening filter for pid 0x11
2008-03-13 09:25:03.659 DVBSH(1): AddPIDFilter(0x14) priority 2
2008-03-13 09:25:03.659 PIDInfo(1): Opening filter for pid 0x14
2008-03-13 09:25:04.326 DTVSM(0): Time Offset: -0.337204
2008-03-13 09:25:04.742 EITHelper: Added 1 events
2008-03-13 09:25:05.370 DTVSM(0): Time Offset: -0.339454
2008-03-13 09:25:06.358 DTVSM(0): Time Offset: -0.341215
2008-03-13 09:25:07.294 DTVSM(0): Time Offset: -0.339499
2008-03-13 09:25:07.966 MythSocket(a92409e0:-1): DownRef: 0
2008-03-13 09:25:07.970 MythSocket(a92409e0:-1): DownRef: -1
2008-03-13 09:25:07.970 MythSocket(a920d290:-1): DownRef: 0
2008-03-13 09:25:07.974 MythSocket(a92409e0:-1): delete socket
2008-03-13 09:25:07.982 MythSocket(a920d290:-1): DownRef: -1
2008-03-13 09:25:07.982 MythSocket(a920d290:-1): delete socket
2008-03-13 09:25:08.498 DTVSM(0): Time Offset: -0.350999
2008-03-13 09:25:09.382 DTVSM(0): Time Offset: -0.352512
2008-03-13 09:25:10.318 DTVSM(0): Time Offset: -0.350524
2008-03-13 09:25:10.752 EITHelper: Added 1 events
2008-03-13 09:25:11.310 DTVSM(0): Time Offset: -0.345272
2008-03-13 09:25:12.298 DTVSM(0): Time Offset: -0.343031
2008-03-13 09:25:13.338 DTVSM(0): Time Offset: -0.34379
2008-03-13 09:25:14.326 DTVSM(0): Time Offset: -0.344299
2008-03-13 09:25:15.314 DTVSM(0): Time Offset: -0.341308
2008-03-13 09:25:16.302 DTVSM(0): Time Offset: -0.341329
2008-03-13 09:25:17.342 DTVSM(0): Time Offset: -0.341089
2008-03-13 09:25:18.330 DTVSM(0): Time Offset: -0.340599
2008-03-13 09:25:19.318 DTVSM(0): Time Offset: -0.339606
2008-03-13 09:25:19.976 MythSocket(83eb7e0:41): new socket
2008-03-13 09:25:19.982 MythSocket(83eb7e0:41): setSocket: 40
2008-03-13 09:25:19.983 MythSocket(83eb7e0:40): state change Idle -> Connected
2008-03-13 09:25:19.983 MythSocket(83eb7e0:40): UpRef: 1
2008-03-13 09:25:19.984 MythSocket(83eb7e0:40): socket is readable
2008-03-13 09:25:19.990 MythSocket(83eb7e0:40): cb->readyRead()
2008-03-13 09:25:19.990 MythSocket(83eb7e0:40): UpRef: 2
2008-03-13 09:25:19.991 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:25:19.998 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:25:19.998 MythSocket(83eb7e0:40): DownRef: 1
2008-03-13 09:25:19.998 MythSocket(83eb7e0:40): socket is readable
2008-03-13 09:25:20.002 MythSocket(83eb7e0:40): cb->readyRead()
2008-03-13 09:25:20.002 MythSocket(83eb7e0:40): UpRef: 2
2008-03-13 09:25:20.003 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:25:20.006 MainServer::HandleAnnounce Monitor
2008-03-13 09:25:20.006 adding: jawa as a client (events: 0)
2008-03-13 09:25:20.007 write -> 40 2       OK
2008-03-13 09:25:20.007 MythSocket(83eb7e0:40): DownRef: 1
2008-03-13 09:25:20.024 MythSocket(83eb7e0:40): socket is readable
2008-03-13 09:25:20.031 MythSocket(83eb7e0:40): cb->readyRead()
2008-03-13 09:25:20.031 MythSocket(83eb7e0:40): UpRef: 2
2008-03-13 09:25:20.032 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:25:20.047 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:25:20.049 MythSocket(83eb7e0:40): DownRef: 1
2008-03-13 09:25:20.104 MythSocket(83eb7e0:40): socket is readable
2008-03-13 09:25:20.114 MythSocket(83eb7e0:40): socket closed
2008-03-13 09:25:20.115 MythSocket(83eb7e0:40): state change Connected -> Idle
2008-03-13 09:25:20.115 MythSocket(83eb7e0:-1): cb->connectionClosed()
2008-03-13 09:25:20.310 DTVSM(0): Time Offset: -0.338605
2008-03-13 09:25:21.350 DTVSM(0): Time Offset: -0.337363
2008-03-13 09:25:21.878 MythSocket(82cc578:41): new socket
2008-03-13 09:25:21.886 MythSocket(82cc578:41): setSocket: 40
2008-03-13 09:25:21.887 MythSocket(82cc578:40): state change Idle -> Connected
2008-03-13 09:25:21.887 MythSocket(82cc578:40): UpRef: 1
2008-03-13 09:25:21.888 MythSocket(82cc578:40): socket is readable
2008-03-13 09:25:21.894 MythSocket(82cc578:40): cb->readyRead()
2008-03-13 09:25:21.894 MythSocket(82cc578:40): UpRef: 2
2008-03-13 09:25:21.895 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:25:21.902 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:25:21.902 MythSocket(82cc578:40): DownRef: 1
2008-03-13 09:25:21.902 MythSocket(82cc578:40): socket is readable
2008-03-13 09:25:21.910 MythSocket(82cc578:40): cb->readyRead()
2008-03-13 09:25:21.910 MythSocket(82cc578:40): UpRef: 2
2008-03-13 09:25:21.911 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:25:21.918 MainServer::HandleAnnounce Monitor
2008-03-13 09:25:21.918 adding: jawa as a client (events: 0)
2008-03-13 09:25:21.919 write -> 40 2       OK
2008-03-13 09:25:21.919 MythSocket(82cc578:40): DownRef: 1
2008-03-13 09:25:21.934 MythSocket(82cc578:40): socket is readable
2008-03-13 09:25:21.939 MythSocket(82cc578:40): cb->readyRead()
2008-03-13 09:25:21.939 MythSocket(82cc578:40): UpRef: 2
2008-03-13 09:25:21.940 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:25:21.955 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:25:21.957 MythSocket(82cc578:40): DownRef: 1
2008-03-13 09:25:22.030 MythSocket(82cc578:40): socket is readable
2008-03-13 09:25:22.043 MythSocket(82cc578:40): socket closed
2008-03-13 09:25:22.043 MythSocket(82cc578:40): state change Connected -> Idle
2008-03-13 09:25:22.044 MythSocket(82cc578:-1): cb->connectionClosed()
2008-03-13 09:25:22.342 DTVSM(0): Time Offset: -0.336352
2008-03-13 09:25:23.330 DTVSM(0): Time Offset: -0.338577
2008-03-13 09:25:24.370 DTVSM(0): Time Offset: -0.330588
2008-03-13 09:25:25.310 DTVSM(0): Time Offset: -0.326088
2008-03-13 09:25:26.298 DTVSM(0): Time Offset: -0.324834
2008-03-13 09:25:27.338 DTVSM(0): Time Offset: -0.326593
2008-03-13 09:25:28.326 DTVSM(0): Time Offset: -0.328343
2008-03-13 09:25:29.105 AutoExpire: Adding Programs to 'Do Not Expire' List
2008-03-13 09:25:29.106     1003 @ 2008-03-13T09:25:00 in use by recorder on jawa
2008-03-13 09:25:29.318 DTVSM(0): Time Offset: -0.327082
2008-03-13 09:25:29.809 TVRec(4): Deleting stale pending recording 3 'The Jeremy Kyle Show'
2008-03-13 09:25:29.836 JobQueue: Currently set to run up to 2 job(s) max.
2008-03-13 09:25:29.838 JobQueue: GetJobsInQueue: findJobs search bitmask 4, found 2 total jobs
2008-03-13 09:25:29.839 JobQueue: GetJobsInQueue: Ignore 'Flag Commercials' Job for 1003 @ 20080313032500 in Finished state.
2008-03-13 09:25:29.840 JobQueue: GetJobsInQueue: Ignore 'Flag Commercials' Job for 1005 @ 20080313051000 in Finished state.
2008-03-13 09:25:30.314 DTVSM(0): Time Offset: -0.326323
2008-03-13 09:25:31.406 DTVSM(0): Time Offset: -0.332071
2008-03-13 09:25:32.145 MythSocket(8421620:41): new socket
2008-03-13 09:25:32.150 MythSocket(8421620:41): setSocket: 40
2008-03-13 09:25:32.151 MythSocket(8421620:40): state change Idle -> Connected
2008-03-13 09:25:32.151 MythSocket(8421620:40): UpRef: 1
2008-03-13 09:25:32.152 MythSocket(8421620:40): socket is readable
2008-03-13 09:25:32.158 MythSocket(8421620:40): cb->readyRead()
2008-03-13 09:25:32.158 MythSocket(8421620:40): UpRef: 2
2008-03-13 09:25:32.159 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:25:32.162 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:25:32.162 MythSocket(8421620:40): DownRef: 1
2008-03-13 09:25:32.163 MythSocket(8421620:40): socket is readable
2008-03-13 09:25:32.166 MythSocket(8421620:40): cb->readyRead()
2008-03-13 09:25:32.166 MythSocket(8421620:40): UpRef: 2
2008-03-13 09:25:32.167 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:25:32.170 MainServer::HandleAnnounce Monitor
2008-03-13 09:25:32.170 adding: jawa as a client (events: 0)
2008-03-13 09:25:32.171 write -> 40 2       OK
2008-03-13 09:25:32.171 MythSocket(8421620:40): DownRef: 1
2008-03-13 09:25:32.186 MythSocket(8421620:40): socket is readable
2008-03-13 09:25:32.191 MythSocket(8421620:40): cb->readyRead()
2008-03-13 09:25:32.191 MythSocket(8421620:40): UpRef: 2
2008-03-13 09:25:32.192 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:25:32.203 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:25:32.205 MythSocket(8421620:40): DownRef: 1
2008-03-13 09:25:32.282 MythSocket(8421620:40): socket is readable
2008-03-13 09:25:32.295 MythSocket(8421620:40): socket closed
2008-03-13 09:25:32.295 MythSocket(8421620:40): state change Connected -> Idle
2008-03-13 09:25:32.296 MythSocket(8421620:-1): cb->connectionClosed()
2008-03-13 09:25:32.346 DTVSM(0): Time Offset: -0.3348
2008-03-13 09:25:33.386 DTVSM(0): Time Offset: -0.33755
2008-03-13 09:25:34.323 DTVSM(0): Time Offset: -0.337095
2008-03-13 09:25:35.310 DTVSM(0): Time Offset: -0.336598
2008-03-13 09:25:35.561 EITHelper: Added 1 events
2008-03-13 09:25:36.354 DTVSM(0): Time Offset: -0.33935
2008-03-13 09:25:37.342 DTVSM(0): Time Offset: -0.338851
2008-03-13 09:25:37.966 MythSocket(82d5e20:-1): DownRef: 0
2008-03-13 09:25:37.974 MythSocket(82d5e20:-1): DownRef: -1
2008-03-13 09:25:37.982 MythSocket(82d5e20:-1): delete socket
2008-03-13 09:25:37.974 MythSocket(82d80a8:-1): DownRef: 0
2008-03-13 09:25:37.990 MythSocket(82d80a8:-1): DownRef: -1
2008-03-13 09:25:37.994 MythSocket(82d80a8:-1): delete socket
2008-03-13 09:25:37.990 MythSocket(82d0b68:-1): DownRef: 0
2008-03-13 09:25:38.002 MythSocket(82d0b68:-1): DownRef: -1
2008-03-13 09:25:38.010 MythSocket(82d0b68:-1): delete socket
2008-03-13 09:25:38.002 MythSocket(83cc870:-1): DownRef: 0
2008-03-13 09:25:38.018 MythSocket(83cc870:-1): DownRef: -1
2008-03-13 09:25:38.022 MythSocket(83cc870:-1): delete socket
2008-03-13 09:25:38.386 DTVSM(0): Time Offset: -0.3416
2008-03-13 09:25:39.322 DTVSM(0): Time Offset: -0.341099
2008-03-13 09:25:40.362 DTVSM(0): Time Offset: -0.340595
2008-03-13 09:25:41.350 DTVSM(0): Time Offset: -0.343088
2008-03-13 09:25:42.342 DTVSM(0): Time Offset: -0.345836
2008-03-13 09:25:43.330 DTVSM(0): Time Offset: -0.345334
2008-03-13 09:25:44.370 DTVSM(0): Time Offset: -0.348079
2008-03-13 09:25:45.358 DTVSM(0): Time Offset: -0.350589
2008-03-13 09:25:46.078 MythSocket(8399da8:41): new socket
2008-03-13 09:25:46.082 MythSocket(8399da8:41): setSocket: 40
2008-03-13 09:25:46.083 MythSocket(8399da8:40): state change Idle -> Connected
2008-03-13 09:25:46.083 MythSocket(8399da8:40): UpRef: 1
2008-03-13 09:25:46.084 MythSocket(8399da8:40): socket is readable
2008-03-13 09:25:46.086 MythSocket(8399da8:40): cb->readyRead()
2008-03-13 09:25:46.086 MythSocket(8399da8:40): UpRef: 2
2008-03-13 09:25:46.087 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:25:46.090 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:25:46.090 MythSocket(8399da8:40): DownRef: 1
2008-03-13 09:25:46.091 MythSocket(8399da8:40): socket is readable
2008-03-13 09:25:46.094 MythSocket(8399da8:40): cb->readyRead()
2008-03-13 09:25:46.094 MythSocket(8399da8:40): UpRef: 2
2008-03-13 09:25:46.095 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:25:46.098 MainServer::HandleAnnounce Monitor
2008-03-13 09:25:46.099 adding: jawa as a client (events: 0)
2008-03-13 09:25:46.099 write -> 40 2       OK
2008-03-13 09:25:46.100 MythSocket(8399da8:40): DownRef: 1
2008-03-13 09:25:46.115 MythSocket(8399da8:40): socket is readable
2008-03-13 09:25:46.119 MythSocket(8399da8:40): cb->readyRead()
2008-03-13 09:25:46.119 MythSocket(8399da8:40): UpRef: 2
2008-03-13 09:25:46.120 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:25:46.131 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:25:46.133 MythSocket(8399da8:40): DownRef: 1
2008-03-13 09:25:46.313 MythSocket(8399da8:40): socket is readable
2008-03-13 09:25:46.315 MythSocket(8399da8:40): socket closed
2008-03-13 09:25:46.315 MythSocket(8399da8:40): state change Connected -> Idle
2008-03-13 09:25:46.316 MythSocket(8399da8:-1): cb->connectionClosed()
2008-03-13 09:25:46.354 DTVSM(0): Time Offset: -0.353101
2008-03-13 09:25:46.887 MythSocket(82d80a8:41): new socket
2008-03-13 09:25:46.894 MythSocket(82d80a8:41): setSocket: 40
2008-03-13 09:25:46.895 MythSocket(82d80a8:40): state change Idle -> Connected
2008-03-13 09:25:46.895 MythSocket(82d80a8:40): UpRef: 1
2008-03-13 09:25:46.896 MythSocket(82d80a8:40): socket is readable
2008-03-13 09:25:46.902 MythSocket(82d80a8:40): cb->readyRead()
2008-03-13 09:25:46.902 MythSocket(82d80a8:40): UpRef: 2
2008-03-13 09:25:46.903 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:25:46.906 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:25:46.906 MythSocket(82d80a8:40): DownRef: 1
2008-03-13 09:25:46.907 MythSocket(82d80a8:40): socket is readable
2008-03-13 09:25:46.910 MythSocket(82d80a8:40): cb->readyRead()
2008-03-13 09:25:46.910 MythSocket(82d80a8:40): UpRef: 2
2008-03-13 09:25:46.911 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:25:46.914 MainServer::HandleAnnounce Monitor
2008-03-13 09:25:46.914 adding: jawa as a client (events: 0)
2008-03-13 09:25:46.915 write -> 40 2       OK
2008-03-13 09:25:46.915 MythSocket(82d80a8:40): DownRef: 1
2008-03-13 09:25:46.931 MythSocket(82d80a8:40): socket is readable
2008-03-13 09:25:46.935 MythSocket(82d80a8:40): cb->readyRead()
2008-03-13 09:25:46.935 MythSocket(82d80a8:40): UpRef: 2
2008-03-13 09:25:46.936 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:25:46.951 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:25:46.953 MythSocket(82d80a8:40): DownRef: 1
2008-03-13 09:25:47.130 MythSocket(82d80a8:40): socket is readable
2008-03-13 09:25:47.143 MythSocket(82d80a8:40): socket closed
2008-03-13 09:25:47.143 MythSocket(82d80a8:40): state change Connected -> Idle
2008-03-13 09:25:47.144 MythSocket(82d80a8:-1): cb->connectionClosed()
2008-03-13 09:25:47.302 DTVSM(0): Time Offset: -0.346593
2008-03-13 09:25:48.342 DTVSM(0): Time Offset: -0.346371
2008-03-13 09:25:49.330 DTVSM(0): Time Offset: -0.342868
2008-03-13 09:25:50.318 DTVSM(0): Time Offset: -0.342572
2008-03-13 09:25:51.306 DTVSM(0): Time Offset: -0.342343
2008-03-13 09:25:51.829 MythSocket(837c4b0:41): new socket
2008-03-13 09:25:51.830 MythSocket(837c4b0:41): setSocket: 40
2008-03-13 09:25:51.831 MythSocket(837c4b0:40): state change Idle -> Connected
2008-03-13 09:25:51.831 MythSocket(837c4b0:40): UpRef: 1
2008-03-13 09:25:51.832 MythSocket(837c4b0:40): socket is readable
2008-03-13 09:25:51.838 MythSocket(837c4b0:40): cb->readyRead()
2008-03-13 09:25:51.838 MythSocket(837c4b0:40): UpRef: 2
2008-03-13 09:25:51.839 read  <- 40 21      MYTH_PROTO_VERSION 40
2008-03-13 09:25:51.842 write -> 40 13      ACCEPT[]:[]40
2008-03-13 09:25:51.843 MythSocket(837c4b0:40): DownRef: 1
2008-03-13 09:25:51.843 MythSocket(837c4b0:40): socket is readable
2008-03-13 09:25:51.846 MythSocket(837c4b0:40): cb->readyRead()
2008-03-13 09:25:51.846 MythSocket(837c4b0:40): UpRef: 2
2008-03-13 09:25:51.847 read  <- 40 18      ANN Monitor jawa 0
2008-03-13 09:25:51.850 MainServer::HandleAnnounce Monitor
2008-03-13 09:25:51.850 adding: jawa as a client (events: 0)
2008-03-13 09:25:51.851 write -> 40 2       OK
2008-03-13 09:25:51.851 MythSocket(837c4b0:40): DownRef: 1
2008-03-13 09:25:51.866 MythSocket(837c4b0:40): socket is readable
2008-03-13 09:25:51.875 MythSocket(837c4b0:40): cb->readyRead()
2008-03-13 09:25:51.876 MythSocket(837c4b0:40): UpRef: 2
2008-03-13 09:25:51.876 read  <- 40 19      QUERY_GETALLPENDING
2008-03-13 09:25:51.887 write -> 40 75342   0[]:[]143[]:[]The Jeremy Kyle Show[]:[][]:[]Jeremy Kyle deals wit...
2008-03-13 09:25:51.889 MythSocket(837c4b0:40): DownRef: 1
2008-03-13 09:25:51.943 MythSocket(837c4b0:40): socket is readable
2008-03-13 09:25:51.950 MythSocket(837c4b0:40): socket closed
2008-03-13 09:25:51.951 MythSocket(837c4b0:40): state change Connected -> Idle
2008-03-13 09:25:51.951 MythSocket(837c4b0:-1): cb->connectionClosed()
2008-03-13 09:25:52.354 DTVSM(0): Time Offset: -0.342343
2008-03-13 09:25:53.342 DTVSM(0): Time Offset: -0.34234
2008-03-13 09:25:54.382 DTVSM(0): Time Offset: -0.342099
2008-03-13 09:25:55.370 DTVSM(0): Time Offset: -0.3451
2008-03-13 09:25:56.306 DTVSM(0): Time Offset: -0.341605
2008-03-13 09:25:57.294 DTVSM(0): Time Offset: -0.33811
2008-03-13 09:25:58.334 DTVSM(0): Time Offset: -0.337613
2008-03-13 09:25:59.374 DTVSM(0): Time Offset: -0.340363
2008-03-13 09:26:00.362 DTVSM(0): Time Offset: -0.339868
2008-03-13 09:26:01.298 DTVSM(0): Time Offset: -0.33612
2008-03-13 09:26:02.338 DTVSM(0): Time Offset: -0.335135
2008-03-13 09:26:03.378 DTVSM(0): Time Offset: -0.339895
2008-03-13 09:26:04.314 DTVSM(0): Time Offset: -0.338129
2008-03-13 09:26:05.302 DTVSM(0): Time Offset: -0.33638
2008-03-13 09:26:06.342 DTVSM(0): Time Offset: -0.33788
2008-03-13 09:26:07.330 DTVSM(0): Time Offset: -0.33936
2008-03-13 09:26:07.966 MythSocket(83eb7e0:-1): DownRef: 0
2008-03-13 09:26:07.974 MythSocket(83eb7e0:-1): DownRef: -1
2008-03-13 09:26:07.974 MythSocket(82cc578:-1): DownRef: 0
2008-03-13 09:26:07.982 MythSocket(83eb7e0:-1): delete socket
2008-03-13 09:26:07.986 MythSocket(8421620:-1): DownRef: 0
2008-03-13 09:26:07.994 MythSocket(82cc578:-1): DownRef: -1
2008-03-13 09:26:08.010 MythSocket(82cc578:-1): delete socket
2008-03-13 09:26:08.011 MythSocket(8421620:-1): DownRef: -1
2008-03-13 09:26:08.011 MythSocket(8421620:-1): delete socket
2008-03-13 09:26:08.374 DTVSM(0): Time Offset: -0.34061
2008-03-13 09:26:09.310 DTVSM(0): Time Offset: -0.338613
2008-03-13 09:26:10.350 DTVSM(0): Time Offset: -0.336611
2008-03-13 09:26:11.338 DTVSM(0): Time Offset: -0.334613
2008-03-13 09:26:12.326 DTVSM(0): Time Offset: -0.33586
2008-03-13 09:26:13.318 DTVSM(0): Time Offset: -0.337358
2008-03-13 09:26:14.358 DTVSM(0): Time Offset: -0.338856
2008-03-13 09:26:15.346 DTVSM(0): Time Offset: -0.337107
2008-03-13 09:26:16.334 DTVSM(0): Time Offset: -0.335354
2008-03-13 09:26:17.322 DTVSM(0): Time Offset: -0.336851
2008-03-13 09:26:18.310 DTVSM(0): Time Offset: -0.335084
2008-03-13 09:26:19.350 DTVSM(0): Time Offset: -0.333332
2008-03-13 09:26:20.338 DTVSM(0): Time Offset: -0.334828
2008-03-13 09:26:21.326 DTVSM(0): Time Offset: -0.336325
2008-03-13 09:26:22.366 DTVSM(0): Time Offset: -0.337821
2008-03-13 09:26:23.302 DTVSM(0): Time Offset: -0.336069
2008-03-13 09:26:24.394 DTVSM(0): Time Offset: -0.337324
2008-03-13 09:26:25.330 DTVSM(0): Time Offset: -0.338573
2008-03-13 09:26:26.318 DTVSM(0): Time Offset: -0.336572
2008-03-13 09:26:27.306 DTVSM(0): Time Offset: -0.334572
2008-03-13 09:26:28.346 DTVSM(0): Time Offset: -0.335822
2008-03-13 09:26:29.107 AutoExpire: Adding Programs to 'Do Not Expire' List
2008-03-13 09:26:29.110     1003 @ 2008-03-13T09:25:00 in use by recorder on jawa
2008-03-13 09:26:29.111 AutoExpire: ExpireLiveTV(10000)
2008-03-13 09:26:29.111 AutoExpire: FillDBOrdered: Adding Short LiveTV programs in starttime order
2008-03-13 09:26:29.112 AutoExpire: SendDeleteMessages. Nothing to expire.
2008-03-13 09:26:29.338 DTVSM(0): Time Offset: -0.337062
2008-03-13 09:26:29.840 JobQueue: Currently set to run up to 2 job(s) max.
2008-03-13 09:26:29.842 JobQueue: GetJobsInQueue: findJobs search bitmask 4, found 2 total jobs
2008-03-13 09:26:29.843 JobQueue: GetJobsInQueue: Ignore 'Flag Commercials' Job for 1003 @ 20080313032500 in Finished state.
2008-03-13 09:26:29.843 JobQueue: GetJobsInQueue: Ignore 'Flag Commercials' Job for 1005 @ 20080313051000 in Finished state.
2008-03-13 09:26:30.330 DTVSM(0): Time Offset: -0.335304
2008-03-13 09:26:31.318 DTVSM(0): Time Offset: -0.333555
2008-03-13 09:26:32.358 DTVSM(0): Time Offset: -0.335055
2008-03-13 09:26:33.346 DTVSM(0): Time Offset: -0.336551
2008-03-13 09:26:34.334 DTVSM(0): Time Offset: -0.338049
2008-03-13 09:26:35.322 DTVSM(0): Time Offset: -0.3363
2008-03-13 09:26:35.566 EITScanner (1): Added 9 EIT Events
2008-03-13 09:26:35.570 MythEvent: RESCHEDULE_RECORDINGS -1
2008-03-13 09:26:35.571 Reschedule requested for id -1.