all of a sudden I cant record tv its driving me insane. has this happened to anyone else or does anyone know a fix? ive included the log below but im unsure if its the right one to include. thanks in advance for any help given.
[collapse]
[2013-11-06 19:38:14,920] [Log ] [13 ] [INFO ] - Controller: find free card for channel Pick
[2013-11-06 19:38:14,921] [Log ] [13 ] [INFO ] - Controller: find card for channel Pick
[2013-11-06 19:38:14,922] [Log ] [13 ] [INFO ] - Controller: got 1 tuning details for Pick
[2013-11-06 19:38:14,923] [Log ] [13 ] [INFO ] - Controller: channel #1 DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,923] [Log ] [13 ] [INFO ] - Controller: card:1 type:RadioWebStream cannot tune to channel
[2013-11-06 19:38:14,923] [Log ] [13 ] [INFO ] - Controller: card:2 typevbIP cannot tune to channel
[2013-11-06 19:38:14,924] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT can tune to channel
[2013-11-06 19:38:14,925] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT users: 2
[2013-11-06 19:38:14,926] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT can tune to channel
[2013-11-06 19:38:14,926] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT users: 0
[2013-11-06 19:38:14,927] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT can tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT users: 0
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT can tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT users: 0
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: found 4 card(s) for channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 9 msec
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT is available
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT is available
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT is available
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT is not available, tuned to different transponder
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: found 3 free card(s)
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 13 msec
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: TimeShiftingWouldUseCard Pick 69
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: find free card for channel Pick
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: find card for channel Pick
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: got 1 tuning details for Pick
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: channel #1 DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:1 type:RadioWebStream cannot tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:2 typevbIP cannot tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT can tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT users: 2
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT can tune to channel
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT users: 0
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT can tune to channel
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT users: 0
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT can tune to channel
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT users: 0
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: found 4 card(s) for channel
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 9 msec
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT is available
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT is available
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT is available
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT is not available, tuned to different transponder
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: found 3 free card(s)
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 12 msec
[2013-11-06 19:38:14,944] [Log ] [13 ] [DEBUG] - CiMenuSupported called cardid 4
[2013-11-06 19:38:14,944] [Log ] [13 ] [DEBUG] - CiMenuSupported card TBS 6284 DVBT/T2/C Tuner B supported: False
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: StartTimeShifting Pick 69
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: epg stop
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: find free card for channel Pick
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: find card for channel Pick
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: got 1 tuning details for Pick
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: channel #1 DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:1 type:RadioWebStream cannot tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:2 typevbIP cannot tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT can tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT can tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT can tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT can tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: found 4 card(s) for channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 8 msec
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: found 4 free card(s)
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 9 msec
[2013-11-06 19:38:14,959] [Log ] [13 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=117, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=118, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=119, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=120, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT users: 2
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT is not available, tuned to different transponder
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT users: 0
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT is available
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT users: 0
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT is available
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT users: 0
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT is available
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - CancelCardReservationsExceedingMaxConcurrentTickets: removing exceeding nr of tickets, only 2 allowed at a time but found 4
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - CardReservation.CancelCardReservation id=120
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - CardReservation.CancelCardReservation id=117
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: try max 3 of 3 cards for timeshifting
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - CardReservationBase: tvcard=4, user=media-server, dbChannel=69, ticket=118, tunestate=Tuning, stopstate=Idle
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - card: CardTune 4 Pick media-server:4:-1
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - card: Tune on card 4 to subchannel Pick
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - card: user: media-server:4:-1 tune DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,991] [Log ] [13 ] [DEBUG] - TimeShifter.OnBeforeTune: resetting audio/video events
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbt: TuneVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbubmiting tunerequest Channelick subChannel:-1
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvb:Getting new subchannel
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvb:GetNewSubChannel:0 #0
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - TvDvbChannel ctor new subchIndex:0
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - card: AddTuneEvent card: 4 / subch: 0
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbubmit tunerequest size:1 new:0
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - subch:0 OnBeforeTune
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbubmit tunerequest calling put_TuneRequest
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbubmit tunerequest done calling put_TuneRequest
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - subch:0 OnAfterTune
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - RunGraph
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - subch:0 OnGraphStart
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvb: RunGraph
[2013-11-06 19:38:15,616] [Log ] [13 ] [INFO ] - dvb: LockInOnSignal ok
[2013-11-06 19:38:15,616] [Log ] [13 ] [INFO ] - subch:0 OnGraphStarted
[2013-11-06 19:38:15,616] [Log ] [13 ] [INFO ] - subch:0 SetupPmtGrabberid 2BF sid:56C0
[2013-11-06 19:38:15,616] [Log ] [13 ] [INFO ] - subch:0 set pmt grabber pmt:2BF sid:56C0
[2013-11-06 19:38:15,616] [Log ] [13 ] [DEBUG] - TimeShifter.OnAfterTune: resetting audio/video time
[2013-11-06 19:38:15,631] [Log ] [13 ] [DEBUG] - WaitForPMT: Waiting for PMT 2BF
[2013-11-06 19:38:15,772] [Log ] [27 ] [INFO ] - subch:0 OnPMTReceived() pmt:2BF ran:True dynamic:False
[2013-11-06 19:38:15,772] [Log ] [13 ] [DEBUG] - WaitForPMT: Found PMT after 0.140628 seconds.
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 SendPmt:56C0 56C0 FFFFFFFF 13
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Decode pmt
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Set descriptor data with length 3
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Set descriptor data with length 3
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - PROBLEM : descriptor lengths dont match 6 9
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Set descriptor data with length 3
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - PROBLEM : descriptor lengths dont match 6 9
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Set descriptor data with length 3
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - PROBLEM : descriptor lengths dont match 10 13
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 SendPMT: Channel is FTA, nothing to do.
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 SetMpegPidMapping
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:12D pcr
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:2BF pmt
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:12D video type:MPEG-2
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 map pid:12D video type:MPEG-2
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:12E audio lang:eng type:MPEG-2
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 map pid:12E audio lang:eng type:MPEG-2
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:130 audio lang:eng type:MPEG-2
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 pid:12F subtitle type:6
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 map pid:12F subtitle type:6
[2013-11-06 19:38:15,788] [Log ] [13 ] [DEBUG] - OnPMTReceived: MDAPI disabled. Possible reasons are _mdplugs=null or provider not listed
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 stop tif
[2013-11-06 19:38:15,788] [Log ] [13 ] [DEBUG] - WaitForPmt: PMT handling took 0.0156234 seconds.
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - dvbt: tune: Graph running. Returning TvLibrary.Implementations.DVB.TvDvbChannel
[2013-11-06 19:38:15,788] [Log ] [13 ] [DEBUG] - card: Tuner locked: True
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - **************************************************
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - ***** SIGNAL LEVEL: 51, SIGNAL QUALITY: 62 *****
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - **************************************************
[2013-11-06 19:38:15,788] [Log ] [13 ] [DEBUG] - card: tuned user: media-server subchannel: 0
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - user:media-server add
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - card2:media-server 4 0
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - Controller: delete timeshift files D:\Recorded TV\live4-0.ts
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - Controller: epg stop
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - card: StartTimeShifting 4 D:\Recorded TV\live4-0.ts
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - card: CAM enabled : False
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 SetTimeShiftFileName:\Recorded TV\live4-0.ts
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - Set video / audio observer
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 SetTimeShiftFileName fill in pids
[2013-11-06 19:38:15,803] [Log ] [13 ] [INFO ] - subch:0-0 tswriter StartTimeshifting...
[2013-11-06 19:38:15,803] [Log ] [13 ] [INFO ] - card: WaitForFile - waiting _eventAudio & _eventVideo
[2013-11-06 19:38:15,881] [Log ] [27 ] [INFO ] - PID seen - type = Video
[2013-11-06 19:38:15,881] [Log ] [27 ] [INFO ] - audioVideoEventHandler Video
[2013-11-06 19:38:15,913] [Log ] [27 ] [INFO ] - PID seen - type = Audio
[2013-11-06 19:38:15,913] [Log ] [27 ] [INFO ] - audioVideoEventHandler Audio
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - card: WaitForFile - video and audio are seen after 0.1093751 seconds
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - user:media-server card:4 sub:0 add stream:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - Controller: StartTimeShifting started on card:4 to D:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:38:15,913] [Log ] [13 ] [DEBUG] - CardReservation.RemoveTuneTicket: removed reservation with id=118, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - card: SignalTuneEvent card: 4 / subch: 0
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - Controller: media-server 4 0
[2013-11-06 19:38:15,913] [Log ] [13 ] [DEBUG] - CardReservation.CancelCardReservation id=119
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - control2:media-server 4 0
[2013-11-06 19:38:15,928] [Log ] [13 ] [DEBUG] - CiMenuSupported called cardid 4
[2013-11-06 19:38:15,928] [Log ] [13 ] [DEBUG] - CiMenuSupported card TBS 6284 DVBT/T2/C Tuner B supported: False
[2013-11-06 19:38:18,711] [Log ] [32 ] [DEBUG] - Controller: DoSetChannelStates for 54 channels
[2013-11-06 19:38:18,725] [Log ] [32 ] [INFO ] - ChannelStates.GetAllTimeshiftingAndRecordingChannels took 3 msec
[2013-11-06 19:38:18,984] [Log ] [32 ] [INFO ] - ChannelStates.DoSetChannelStates took 273 msec
[2013-11-06 19:38:35,092] [Log ] [32 ] [DEBUG] - Deleting invalid recordings
[2013-11-06 19:39:06,689] [Log ] [32 ] [DEBUG] - Deleting invalid recordings
[2013-11-06 19:40:34,014] [Log ] [19 ] [INFO ] - Controller: StopTimeShifting 4
[2013-11-06 19:40:34,015] [Log ] [19 ] [DEBUG] - CardTuner.RequestCardStopReservation: placed reservation with id=121, user=media-server
[2013-11-06 19:40:34,117] [Log ] [19 ] [DEBUG] - CardTuner.Stop: ticket id=121, found=True
[2013-11-06 19:40:34,117] [Log ] [19 ] [INFO ] - Stop cardid=4, ticket=121, tunestate=Idle, stopstate=Stopping
[2013-11-06 19:40:34,117] [Log ] [19 ] [INFO ] - card TBS 6284 DVBT/T2/C Tuner B: StopTimeShifting user:media-server sub:0
[2013-11-06 19:40:34,118] [Log ] [19 ] [DEBUG] - card not IDLE - removing user: media-server
[2013-11-06 19:40:34,119] [Log ] [19 ] [DEBUG] - usermanagement.RemoveUser: media-server, subch: 0 of 1, card: 4
[2013-11-06 19:40:34,119] [Log ] [19 ] [INFO ] - user:media-server remove
[2013-11-06 19:40:34,119] [Log ] [19 ] [INFO ] - subch:0-0 tswriter StopTimeshifting...
[2013-11-06 19:40:34,155] [Log ] [19 ] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0
[2013-11-06 19:40:34,155] [Log ] [19 ] [INFO ] - DVB subch:0 Decompose()
[2013-11-06 19:40:34,158] [Log ] [19 ] [INFO ] - FreeSubChannel CA: freeing sub channel : 0
[2013-11-06 19:40:34,158] [Log ] [19 ] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph
[2013-11-06 19:40:34,159] [Log ] [19 ] [INFO ] - dvbtopGraph called
[2013-11-06 19:40:34,159] [Log ] [19 ] [INFO ] - tvcard:FreeAllSubChannels
[2013-11-06 19:40:34,160] [Log ] [19 ] [INFO ] - dvbtopGraph
[2013-11-06 19:40:34,210] [Log ] [19 ] [INFO ] - dvbtopGraph called
[2013-11-06 19:40:34,210] [Log ] [19 ] [INFO ] - tvcard:FreeAllSubChannels
[2013-11-06 19:40:34,212] [Log ] [19 ] [INFO ] - dvbtopGraph filterstate already stopped, returning.
[2013-11-06 19:40:34,214] [Log ] [TS_File_Cleanup] [INFO ] - card: delete timeshift files D:\Recorded TV\live4-0.ts
[2013-11-06 19:40:34,214] [Log ] [19 ] [INFO ] - user:media-server remove
[2013-11-06 19:40:34,214] [Log ] [TS_File_Cleanup] [INFO ] - card: trying to delete D:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:40:34,217] [Log ] [19 ] [DEBUG] - CardReservation.RemoveStopTicket: removed STOP reservation with id=121
[2013-11-06 19:40:34,217] [Log ] [19 ] [INFO ] - Controller:Timeshifting stopped on card:4
[2013-11-06 19:40:34,217] [Log ] [19 ] [INFO ] - RTSP: remove stream stream4.0
[2013-11-06 19:40:39,220] [Log ] [TS_File_Cleanup] [INFO ] - card: delete timeshift files D:\Recorded TV\live4-0.ts
[2013-11-06 19:40:39,238] [Log ] [TS_File_Cleanup] [INFO ] - card: trying to delete D:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:40:39,243] [Log ] [TS_File_Cleanup] [INFO ] - card: deleted file D:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:40:39,243] [Log ] [TS_File_Cleanup] [INFO ] - card: trying to delete D:\Recorded TV\live4-0.ts.tsbuffer1.ts
[2013-11-06 19:40:39,247] [Log ] [TS_File_Cleanup] [INFO ] - card: deleted file D:\Recorded TV\live4-0.ts.tsbuffer1.ts
[2013-11-06 19:41:00,656] [Log ] [32 ] [INFO ] - Controller: epg stop[/collapse]
[collapse]
[2013-11-06 19:38:14,920] [Log ] [13 ] [INFO ] - Controller: find free card for channel Pick
[2013-11-06 19:38:14,921] [Log ] [13 ] [INFO ] - Controller: find card for channel Pick
[2013-11-06 19:38:14,922] [Log ] [13 ] [INFO ] - Controller: got 1 tuning details for Pick
[2013-11-06 19:38:14,923] [Log ] [13 ] [INFO ] - Controller: channel #1 DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,923] [Log ] [13 ] [INFO ] - Controller: card:1 type:RadioWebStream cannot tune to channel
[2013-11-06 19:38:14,923] [Log ] [13 ] [INFO ] - Controller: card:2 typevbIP cannot tune to channel
[2013-11-06 19:38:14,924] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT can tune to channel
[2013-11-06 19:38:14,925] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT users: 2
[2013-11-06 19:38:14,926] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT can tune to channel
[2013-11-06 19:38:14,926] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT users: 0
[2013-11-06 19:38:14,927] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT can tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT users: 0
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT can tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT users: 0
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: found 4 card(s) for channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 9 msec
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT is available
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT is available
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT is available
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT is not available, tuned to different transponder
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: found 3 free card(s)
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 13 msec
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: TimeShiftingWouldUseCard Pick 69
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: find free card for channel Pick
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: find card for channel Pick
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: got 1 tuning details for Pick
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: channel #1 DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:1 type:RadioWebStream cannot tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:2 typevbIP cannot tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT can tune to channel
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT users: 2
[2013-11-06 19:38:14,928] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT can tune to channel
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT users: 0
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT can tune to channel
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT users: 0
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT can tune to channel
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT users: 0
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: found 4 card(s) for channel
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 9 msec
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT is available
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT is available
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT is available
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT is not available, tuned to different transponder
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: found 3 free card(s)
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 12 msec
[2013-11-06 19:38:14,944] [Log ] [13 ] [DEBUG] - CiMenuSupported called cardid 4
[2013-11-06 19:38:14,944] [Log ] [13 ] [DEBUG] - CiMenuSupported card TBS 6284 DVBT/T2/C Tuner B supported: False
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: StartTimeShifting Pick 69
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: epg stop
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: find free card for channel Pick
[2013-11-06 19:38:14,944] [Log ] [13 ] [INFO ] - Controller: find card for channel Pick
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: got 1 tuning details for Pick
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: channel #1 DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:1 type:RadioWebStream cannot tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:2 typevbIP cannot tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT can tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT can tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT can tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT can tune to channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: found 4 card(s) for channel
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 8 msec
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: found 4 free card(s)
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 9 msec
[2013-11-06 19:38:14,959] [Log ] [13 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=117, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=118, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=119, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=120, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,959] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT users: 2
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:3 typevbT is not available, tuned to different transponder
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT users: 0
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:4 typevbT is available
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT users: 0
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:5 typevbT is available
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT users: 0
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: card:6 typevbT is available
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - CancelCardReservationsExceedingMaxConcurrentTickets: removing exceeding nr of tickets, only 2 allowed at a time but found 4
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - CardReservation.CancelCardReservation id=120
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - CardReservation.CancelCardReservation id=117
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - Controller: try max 3 of 3 cards for timeshifting
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - CardReservationBase: tvcard=4, user=media-server, dbChannel=69, ticket=118, tunestate=Tuning, stopstate=Idle
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - card: CardTune 4 Pick media-server:4:-1
[2013-11-06 19:38:14,975] [Log ] [13 ] [INFO ] - card: Tune on card 4 to subchannel Pick
[2013-11-06 19:38:14,975] [Log ] [13 ] [DEBUG] - card: user: media-server:4:-1 tune DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,991] [Log ] [13 ] [DEBUG] - TimeShifter.OnBeforeTune: resetting audio/video events
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbt: TuneVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbubmiting tunerequest Channelick subChannel:-1
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvb:Getting new subchannel
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvb:GetNewSubChannel:0 #0
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - TvDvbChannel ctor new subchIndex:0
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - card: AddTuneEvent card: 4 / subch: 0
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbubmit tunerequest size:1 new:0
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - subch:0 OnBeforeTune
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbubmit tunerequest calling put_TuneRequest
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvbubmit tunerequest done calling put_TuneRequest
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - subch:0 OnAfterTune
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - RunGraph
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - subch:0 OnGraphStart
[2013-11-06 19:38:14,991] [Log ] [13 ] [INFO ] - dvb: RunGraph
[2013-11-06 19:38:15,616] [Log ] [13 ] [INFO ] - dvb: LockInOnSignal ok
[2013-11-06 19:38:15,616] [Log ] [13 ] [INFO ] - subch:0 OnGraphStarted
[2013-11-06 19:38:15,616] [Log ] [13 ] [INFO ] - subch:0 SetupPmtGrabberid 2BF sid:56C0
[2013-11-06 19:38:15,616] [Log ] [13 ] [INFO ] - subch:0 set pmt grabber pmt:2BF sid:56C0
[2013-11-06 19:38:15,616] [Log ] [13 ] [DEBUG] - TimeShifter.OnAfterTune: resetting audio/video time
[2013-11-06 19:38:15,631] [Log ] [13 ] [DEBUG] - WaitForPMT: Waiting for PMT 2BF
[2013-11-06 19:38:15,772] [Log ] [27 ] [INFO ] - subch:0 OnPMTReceived() pmt:2BF ran:True dynamic:False
[2013-11-06 19:38:15,772] [Log ] [13 ] [DEBUG] - WaitForPMT: Found PMT after 0.140628 seconds.
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 SendPmt:56C0 56C0 FFFFFFFF 13
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Decode pmt
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Set descriptor data with length 3
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Set descriptor data with length 3
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - PROBLEM : descriptor lengths dont match 6 9
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Set descriptor data with length 3
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - PROBLEM : descriptor lengths dont match 6 9
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - Set descriptor data with length 3
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - PROBLEM : descriptor lengths dont match 10 13
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 SendPMT: Channel is FTA, nothing to do.
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 SetMpegPidMapping
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:12D pcr
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:2BF pmt
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:12D video type:MPEG-2
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 map pid:12D video type:MPEG-2
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:12E audio lang:eng type:MPEG-2
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 map pid:12E audio lang:eng type:MPEG-2
[2013-11-06 19:38:15,772] [Log ] [13 ] [INFO ] - subch:0 pid:130 audio lang:eng type:MPEG-2
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 pid:12F subtitle type:6
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 map pid:12F subtitle type:6
[2013-11-06 19:38:15,788] [Log ] [13 ] [DEBUG] - OnPMTReceived: MDAPI disabled. Possible reasons are _mdplugs=null or provider not listed
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 stop tif
[2013-11-06 19:38:15,788] [Log ] [13 ] [DEBUG] - WaitForPmt: PMT handling took 0.0156234 seconds.
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - dvbt: tune: Graph running. Returning TvLibrary.Implementations.DVB.TvDvbChannel
[2013-11-06 19:38:15,788] [Log ] [13 ] [DEBUG] - card: Tuner locked: True
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - **************************************************
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - ***** SIGNAL LEVEL: 51, SIGNAL QUALITY: 62 *****
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - **************************************************
[2013-11-06 19:38:15,788] [Log ] [13 ] [DEBUG] - card: tuned user: media-server subchannel: 0
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - user:media-server add
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - card2:media-server 4 0
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - Controller: delete timeshift files D:\Recorded TV\live4-0.ts
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - Controller: epg stop
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - card: StartTimeShifting 4 D:\Recorded TV\live4-0.ts
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - card: CAM enabled : False
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 SetTimeShiftFileName:\Recorded TV\live4-0.ts
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - Set video / audio observer
[2013-11-06 19:38:15,788] [Log ] [13 ] [INFO ] - subch:0 SetTimeShiftFileName fill in pids
[2013-11-06 19:38:15,803] [Log ] [13 ] [INFO ] - subch:0-0 tswriter StartTimeshifting...
[2013-11-06 19:38:15,803] [Log ] [13 ] [INFO ] - card: WaitForFile - waiting _eventAudio & _eventVideo
[2013-11-06 19:38:15,881] [Log ] [27 ] [INFO ] - PID seen - type = Video
[2013-11-06 19:38:15,881] [Log ] [27 ] [INFO ] - audioVideoEventHandler Video
[2013-11-06 19:38:15,913] [Log ] [27 ] [INFO ] - PID seen - type = Audio
[2013-11-06 19:38:15,913] [Log ] [27 ] [INFO ] - audioVideoEventHandler Audio
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - card: WaitForFile - video and audio are seen after 0.1093751 seconds
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - user:media-server card:4 sub:0 add stream:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - Controller: StartTimeShifting started on card:4 to D:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:38:15,913] [Log ] [13 ] [DEBUG] - CardReservation.RemoveTuneTicket: removed reservation with id=118, tuningdetails=DVBT:tv: Pick Freq:770000 ONID:9018 TSID:20544 SID:22208 PMT:0x2BF FTA:True LCN:11 BandWidth:8
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - card: SignalTuneEvent card: 4 / subch: 0
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - Controller: media-server 4 0
[2013-11-06 19:38:15,913] [Log ] [13 ] [DEBUG] - CardReservation.CancelCardReservation id=119
[2013-11-06 19:38:15,913] [Log ] [13 ] [INFO ] - control2:media-server 4 0
[2013-11-06 19:38:15,928] [Log ] [13 ] [DEBUG] - CiMenuSupported called cardid 4
[2013-11-06 19:38:15,928] [Log ] [13 ] [DEBUG] - CiMenuSupported card TBS 6284 DVBT/T2/C Tuner B supported: False
[2013-11-06 19:38:18,711] [Log ] [32 ] [DEBUG] - Controller: DoSetChannelStates for 54 channels
[2013-11-06 19:38:18,725] [Log ] [32 ] [INFO ] - ChannelStates.GetAllTimeshiftingAndRecordingChannels took 3 msec
[2013-11-06 19:38:18,984] [Log ] [32 ] [INFO ] - ChannelStates.DoSetChannelStates took 273 msec
[2013-11-06 19:38:35,092] [Log ] [32 ] [DEBUG] - Deleting invalid recordings
[2013-11-06 19:39:06,689] [Log ] [32 ] [DEBUG] - Deleting invalid recordings
[2013-11-06 19:40:34,014] [Log ] [19 ] [INFO ] - Controller: StopTimeShifting 4
[2013-11-06 19:40:34,015] [Log ] [19 ] [DEBUG] - CardTuner.RequestCardStopReservation: placed reservation with id=121, user=media-server
[2013-11-06 19:40:34,117] [Log ] [19 ] [DEBUG] - CardTuner.Stop: ticket id=121, found=True
[2013-11-06 19:40:34,117] [Log ] [19 ] [INFO ] - Stop cardid=4, ticket=121, tunestate=Idle, stopstate=Stopping
[2013-11-06 19:40:34,117] [Log ] [19 ] [INFO ] - card TBS 6284 DVBT/T2/C Tuner B: StopTimeShifting user:media-server sub:0
[2013-11-06 19:40:34,118] [Log ] [19 ] [DEBUG] - card not IDLE - removing user: media-server
[2013-11-06 19:40:34,119] [Log ] [19 ] [DEBUG] - usermanagement.RemoveUser: media-server, subch: 0 of 1, card: 4
[2013-11-06 19:40:34,119] [Log ] [19 ] [INFO ] - user:media-server remove
[2013-11-06 19:40:34,119] [Log ] [19 ] [INFO ] - subch:0-0 tswriter StopTimeshifting...
[2013-11-06 19:40:34,155] [Log ] [19 ] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0
[2013-11-06 19:40:34,155] [Log ] [19 ] [INFO ] - DVB subch:0 Decompose()
[2013-11-06 19:40:34,158] [Log ] [19 ] [INFO ] - FreeSubChannel CA: freeing sub channel : 0
[2013-11-06 19:40:34,158] [Log ] [19 ] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph
[2013-11-06 19:40:34,159] [Log ] [19 ] [INFO ] - dvbtopGraph called
[2013-11-06 19:40:34,159] [Log ] [19 ] [INFO ] - tvcard:FreeAllSubChannels
[2013-11-06 19:40:34,160] [Log ] [19 ] [INFO ] - dvbtopGraph
[2013-11-06 19:40:34,210] [Log ] [19 ] [INFO ] - dvbtopGraph called
[2013-11-06 19:40:34,210] [Log ] [19 ] [INFO ] - tvcard:FreeAllSubChannels
[2013-11-06 19:40:34,212] [Log ] [19 ] [INFO ] - dvbtopGraph filterstate already stopped, returning.
[2013-11-06 19:40:34,214] [Log ] [TS_File_Cleanup] [INFO ] - card: delete timeshift files D:\Recorded TV\live4-0.ts
[2013-11-06 19:40:34,214] [Log ] [19 ] [INFO ] - user:media-server remove
[2013-11-06 19:40:34,214] [Log ] [TS_File_Cleanup] [INFO ] - card: trying to delete D:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:40:34,217] [Log ] [19 ] [DEBUG] - CardReservation.RemoveStopTicket: removed STOP reservation with id=121
[2013-11-06 19:40:34,217] [Log ] [19 ] [INFO ] - Controller:Timeshifting stopped on card:4
[2013-11-06 19:40:34,217] [Log ] [19 ] [INFO ] - RTSP: remove stream stream4.0
[2013-11-06 19:40:39,220] [Log ] [TS_File_Cleanup] [INFO ] - card: delete timeshift files D:\Recorded TV\live4-0.ts
[2013-11-06 19:40:39,238] [Log ] [TS_File_Cleanup] [INFO ] - card: trying to delete D:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:40:39,243] [Log ] [TS_File_Cleanup] [INFO ] - card: deleted file D:\Recorded TV\live4-0.ts.tsbuffer
[2013-11-06 19:40:39,243] [Log ] [TS_File_Cleanup] [INFO ] - card: trying to delete D:\Recorded TV\live4-0.ts.tsbuffer1.ts
[2013-11-06 19:40:39,247] [Log ] [TS_File_Cleanup] [INFO ] - card: deleted file D:\Recorded TV\live4-0.ts.tsbuffer1.ts
[2013-11-06 19:41:00,656] [Log ] [32 ] [INFO ] - Controller: epg stop[/collapse]
Last edited by a moderator: