[2018-01-01 02:00:05,115] [Log ] [4 ] [INFO ] - Sky Plugin : Sky Channel and EPG Grabber initialised [2018-01-01 02:00:05,143] [Log ] [23 ] [INFO ] - Sky Plugin : Huffman Loaded [2018-01-01 02:00:05,150] [Log ] [23 ] [INFO ] - Sky Plugin : Grabbing Data [2018-01-01 02:00:05,152] [Log ] [23 ] [INFO ] - Sky Plugin : Grabber set to grab 90 seconds of data [2018-01-01 02:00:05,155] [Log ] [25 ] [INFO ] - Controller: StartTimeShifting Sky UK Grabber 159 [2018-01-01 02:00:05,155] [Log ] [25 ] [INFO ] - Controller: epg stop [2018-01-01 02:00:05,156] [EPG ] [25 ] [INFO ] - EPG: grabber stopped.. [2018-01-01 02:00:05,157] [Log ] [25 ] [INFO ] - Controller: find free card for channel Sky UK Grabber [2018-01-01 02:00:05,157] [Log ] [25 ] [INFO ] - Controller: find card for channel Sky UK Grabber [2018-01-01 02:00:05,159] [Log ] [25 ] [INFO ] - Controller: got 1 tuning details for Sky UK Grabber [2018-01-01 02:00:05,160] [Log ] [25 ] [INFO ] - Controller: channel #1 DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:00:05,160] [Log ] [25 ] [INFO ] - Controller: card:1 type:RadioWebStream cannot tune to channel [2018-01-01 02:00:05,161] [Log ] [25 ] [INFO ] - Controller: card:2 type:DvbIP cannot tune to channel [2018-01-01 02:00:05,162] [Log ] [25 ] [INFO ] - Controller: card:3 type:DvbT cannot tune to channel [2018-01-01 02:00:05,163] [Log ] [25 ] [INFO ] - Controller: card:4 type:DvbT cannot tune to channel [2018-01-01 02:00:05,164] [Log ] [25 ] [INFO ] - Controller: card:5 type:DvbS can tune to channel [2018-01-01 02:00:05,165] [Log ] [25 ] [INFO ] - Controller: card:6 type:DvbS can tune to channel [2018-01-01 02:00:05,166] [Log ] [25 ] [INFO ] - Controller: found 2 card(s) for channel [2018-01-01 02:00:05,166] [Log ] [25 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 9 msec [2018-01-01 02:00:05,167] [Log ] [25 ] [INFO ] - Controller: found 2 free card(s) [2018-01-01 02:00:05,168] [Log ] [25 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 11 msec [2018-01-01 02:00:05,170] [Log ] [25 ] [INFO ] - Controller: card:5 type:DvbS users: 0 [2018-01-01 02:00:05,170] [Log ] [25 ] [INFO ] - Controller: card:5 type:DvbS is available [2018-01-01 02:00:05,171] [Log ] [25 ] [INFO ] - Controller: card:6 type:DvbS users: 0 [2018-01-01 02:00:05,172] [Log ] [25 ] [INFO ] - Controller: card:6 type:DvbS is available [2018-01-01 02:00:05,172] [Log ] [25 ] [INFO ] - Controller: try max 2 of 2 cards for timeshifting [2018-01-01 02:00:05,174] [Log ] [25 ] [INFO ] - card: CardTune 5 Sky UK Grabber Custom_159.ts:5:-1 [2018-01-01 02:00:05,176] [Log ] [25 ] [INFO ] - card: Tune on card 5 to subchannel Sky UK Grabber [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - dvbs: Tune:DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - dvbs: Tune:DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - dvb:GetNewSubChannel:0 #0 [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - TvDvbChannel ctor new subchIndex:0 [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - card: AddTuneEvent card: 5 / subch: 0 [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - LNB low:9750 hi:10600 switch:11700 [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - dvbs:channel modulation is set to ModNotSet [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - dvbs:channel FECRate is set to RateNotSet [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - Digital Devices: SimpleA - SendDiSEqCCommand(0x00) [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - Digital Devices: SendDiSEqC Command 0 [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - Digital Devices: put_Range:0 success:0 [2018-01-01 02:00:05,178] [Log ] [25 ] [INFO ] - Digital Devices: CommitChanges() Succeeded [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - dvb:Submiting tunerequest Channel:Sky UK Grabber subChannel:0 [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - dvb:using existing subchannel:0 [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest size:1 new:0 [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - subch:0 OnBeforeTune [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest calling put_TuneRequest [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest done calling put_TuneRequest [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - subch:0 OnAfterTune [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - RunGraph [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - subch:0 OnGraphStart [2018-01-01 02:00:05,293] [Log ] [25 ] [INFO ] - dvb: RunGraph [2018-01-01 02:00:06,155] [Log ] [25 ] [INFO ] - dvb: LockInOnSignal ok [2018-01-01 02:00:06,156] [Log ] [25 ] [INFO ] - subch:0 OnGraphStarted [2018-01-01 02:00:06,156] [Log ] [25 ] [INFO ] - subch:0 SetupPmtGrabber:pid 100 sid:1038 [2018-01-01 02:00:06,157] [Log ] [25 ] [INFO ] - subch:0 set pmt grabber pmt:100 sid:1038 [2018-01-01 02:00:16,168] [Log ] [25 ] [INFO ] - subch:0 SetupPmtGrabber:pid 0 sid:1038 [2018-01-01 02:00:16,169] [Log ] [25 ] [INFO ] - subch:0 set pmt grabber pmt:0 sid:1038 [2018-01-01 02:00:19,424] [Log ] [PS StandbyWakeup] [INFO ] - PS: System changed from busy state to idle state [2018-01-01 02:00:26,175] [Log ] [25 ] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0 [2018-01-01 02:00:26,176] [Log ] [25 ] [INFO ] - DVB subch:0 Decompose() [2018-01-01 02:00:26,177] [Log ] [25 ] [INFO ] - FreeSubChannel CA: freeing sub channel : 0 [2018-01-01 02:00:26,178] [Log ] [25 ] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph [2018-01-01 02:00:26,178] [Log ] [25 ] [INFO ] - dvb:StopGraph called [2018-01-01 02:00:26,179] [Log ] [25 ] [INFO ] - tvcard:FreeAllSubChannels [2018-01-01 02:00:26,180] [Log ] [25 ] [INFO ] - dvb:StopGraph [2018-01-01 02:00:26,185] [Log ] [25 ] [INFO ] - debug: IMediaControl stopped! hr = 0x0 :) [2018-01-01 02:00:26,186] [Log ] [25 ] [INFO ] - card2:Custom_159.ts 5 -1 [2018-01-01 02:00:26,187] [Log ] [25 ] [INFO ] - card: SignalTuneEvent card: 5 / subch: 0 [2018-01-01 02:00:26,187] [Log ] [25 ] [INFO ] - Controller: Custom_159.ts 5 -1 [2018-01-01 02:00:26,188] [Log ] [25 ] [INFO ] - Controller: Timeshifting failed, lets try next available card. [2018-01-01 02:00:26,190] [Log ] [25 ] [INFO ] - card: CardTune 6 Sky UK Grabber Custom_159.ts:6:-1 [2018-01-01 02:00:26,191] [Log ] [25 ] [INFO ] - card: Tune on card 6 to subchannel Sky UK Grabber [2018-01-01 02:00:26,198] [Log ] [25 ] [INFO ] - dvbs: Tune:DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:00:26,199] [Log ] [25 ] [INFO ] - dvbs: Tune:DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:00:26,200] [Log ] [25 ] [INFO ] - dvbs:BuildGraph [2018-01-01 02:00:26,203] [Log ] [25 ] [INFO ] - dvb:AddNetworkProviderFilter [2018-01-01 02:00:26,204] [Log ] [25 ] [INFO ] - dvb:AddNetworkProviderFilter [2018-01-01 02:00:26,207] [Log ] [25 ] [INFO ] - dvb:Add Generic Network Provider [2018-01-01 02:00:26,209] [Log ] [25 ] [INFO ] - dvb: Add Mediaportal TsWriter filter [2018-01-01 02:00:26,210] [Log ] [25 ] [INFO ] - dvbs:CreateTuningSpace() [2018-01-01 02:00:26,222] [Log ] [25 ] [INFO ] - dvbs:found correct tuningspace MediaPortal DVBS TuningSpace [2018-01-01 02:00:26,223] [Log ] [25 ] [INFO ] - dvb:Add MPEG2 Demultiplexer filter [2018-01-01 02:00:26,225] [Log ] [25 ] [INFO ] - dvb:AddAndConnectBDABoardFilters [2018-01-01 02:00:26,226] [Log ] [25 ] [INFO ] - dvb: find bda tuner [2018-01-01 02:00:26,244] [Log ] [25 ] [INFO ] - dvb: using [Tuner]: Digital Devices DVB-S/S2 Tuner 2 [2018-01-01 02:00:26,245] [Log ] [25 ] [INFO ] - dvb: Render [Network provider]->[Tuner] OK [2018-01-01 02:00:26,246] [Log ] [25 ] [INFO ] - dvb: Setting lastFilter to Tuner filter [2018-01-01 02:00:26,247] [Log ] [25 ] [INFO ] - dvb: Find BDA receiver [2018-01-01 02:00:26,247] [Log ] [25 ] [INFO ] - dvb: match Capture by Tuner device path [2018-01-01 02:00:26,250] [Log ] [25 ] [INFO ] - dvb: -Digital Devices Digital Video Capture 2 [2018-01-01 02:00:26,251] [Log ] [25 ] [INFO ] - dvb: -Digital Devices Digital Video Capture 1 [2018-01-01 02:00:26,252] [Log ] [25 ] [INFO ] - dvb: -Digital Devices Digital Video Capture 1 [2018-01-01 02:00:26,253] [Log ] [25 ] [INFO ] - dvb: -Digital Devices Digital Video Capture 2 [2018-01-01 02:00:26,254] [Log ] [25 ] [INFO ] - dvb: Match by device path failed - trying alternative method [2018-01-01 02:00:26,255] [Log ] [25 ] [INFO ] - dvb: match Capture filter by Tuner device connection [2018-01-01 02:00:26,257] [Log ] [25 ] [INFO ] - dvb: -Digital Devices Digital Video Capture 2 [2018-01-01 02:00:26,268] [Log ] [25 ] [INFO ] - dvb: Render [Tuner]->[Capture] AOK [2018-01-01 02:00:26,269] [Log ] [25 ] [INFO ] - dvb: Setting lastFilter to Capture device [2018-01-01 02:00:26,272] [Log ] [25 ] [INFO ] - dvb: WinTv CI module not detected. [2018-01-01 02:00:26,272] [Log ] [25 ] [INFO ] - dvb: DigitalDevices CI: try to connect [demux] [2018-01-01 02:00:26,275] [Log ] [25 ] [INFO ] - dvb: DigitalDevices CI: connection to [demux] successful, CI not available or configured for this tuner. [2018-01-01 02:00:26,276] [Log ] [25 ] [INFO ] - dvb: DigitalDevices CI: disconnect [demux], HR:0 [2018-01-01 02:00:26,277] [Log ] [25 ] [INFO ] - dvb:add Inf Tee filter [2018-01-01 02:00:26,279] [Log ] [25 ] [INFO ] - dvb: Render ...->[inftee] [2018-01-01 02:00:26,280] [Log ] [25 ] [INFO ] - dvb: Setting lastFilter to Inf Tee [2018-01-01 02:00:26,281] [Log ] [25 ] [INFO ] - dvb: Render [inftee]->[demux] [2018-01-01 02:00:26,283] [Log ] [25 ] [INFO ] - dvb: AddTransportStreamFiltersToGraph [2018-01-01 02:00:26,285] [Log ] [25 ] [INFO ] - add BDA MPEG2 Transport Information Filter filter [2018-01-01 02:00:26,286] [Log ] [25 ] [INFO ] - pinTif:name:IB Input [3/0] Direction:Input Connected:False [2018-01-01 02:00:26,287] [Log ] [25 ] [INFO ] - Connect tif and mpeg2 sections and tables [2018-01-01 02:00:26,288] [Log ] [25 ] [INFO ] - dvb:try tif:name:001 [5/0] Direction:Output Connected:False [2018-01-01 02:00:26,290] [Log ] [25 ] [INFO ] - tif connected [2018-01-01 02:00:26,291] [Log ] [25 ] [INFO ] - dvb: Render ..->[TsWriter] [2018-01-01 02:00:26,292] [Log ] [25 ] [INFO ] - dvb: Checking for hardware specific extensions [2018-01-01 02:00:26,293] [Log ] [25 ] [INFO ] - CAM is Default model [2018-01-01 02:00:26,293] [Log ] [25 ] [INFO ] - Check for KNC [2018-01-01 02:00:26,295] [Log ] [25 ] [INFO ] - KNC: IsKNC False [2018-01-01 02:00:26,296] [Log ] [25 ] [INFO ] - Check for Digital Everywhere [2018-01-01 02:00:26,296] [Log ] [25 ] [INFO ] - Check for Twinhan [2018-01-01 02:00:26,297] [Log ] [25 ] [INFO ] - Twinhan: CI detection finished [2018-01-01 02:00:26,298] [Log ] [25 ] [INFO ] - Check for TechnoTrend [2018-01-01 02:00:26,298] [Log ] [25 ] [INFO ] - Check for Hauppauge [2018-01-01 02:00:26,299] [Log ] [25 ] [INFO ] - Check for ProfRed [2018-01-01 02:00:26,300] [Log ] [25 ] [INFO ] - Check for TeVii [2018-01-01 02:00:26,326] [Log ] [25 ] [INFO ] - dvb: GetTunerSignalStatistics() [2018-01-01 02:00:26,327] [Log ] [25 ] [INFO ] - dvb:GetNewSubChannel:0 #0 [2018-01-01 02:00:26,328] [Log ] [25 ] [INFO ] - TvDvbChannel ctor new subchIndex:0 [2018-01-01 02:00:26,329] [Log ] [25 ] [INFO ] - card: AddTuneEvent card: 6 / subch: 0 [2018-01-01 02:00:26,330] [Log ] [25 ] [INFO ] - LNB low:9750 hi:10600 switch:11700 [2018-01-01 02:00:26,331] [Log ] [25 ] [INFO ] - dvbs:channel modulation is set to ModNotSet [2018-01-01 02:00:26,332] [Log ] [25 ] [INFO ] - dvbs:channel FECRate is set to RateNotSet [2018-01-01 02:00:26,333] [Log ] [25 ] [INFO ] - Digital Devices: SimpleA - SendDiSEqCCommand(0x00) [2018-01-01 02:00:26,333] [Log ] [25 ] [INFO ] - Digital Devices: SendDiSEqC Command 0 [2018-01-01 02:00:26,334] [Log ] [25 ] [INFO ] - Digital Devices: put_Range:0 success:0 [2018-01-01 02:00:26,335] [Log ] [25 ] [INFO ] - Digital Devices: CommitChanges() Succeeded [2018-01-01 02:00:26,439] [Log ] [25 ] [INFO ] - dvb:Submiting tunerequest Channel:Sky UK Grabber subChannel:0 [2018-01-01 02:00:26,439] [Log ] [25 ] [INFO ] - dvb:using existing subchannel:0 [2018-01-01 02:00:26,440] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest size:1 new:0 [2018-01-01 02:00:26,441] [Log ] [25 ] [INFO ] - subch:0 OnBeforeTune [2018-01-01 02:00:26,442] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest calling put_TuneRequest [2018-01-01 02:00:26,443] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest done calling put_TuneRequest [2018-01-01 02:00:26,444] [Log ] [25 ] [INFO ] - subch:0 OnAfterTune [2018-01-01 02:00:26,445] [Log ] [25 ] [INFO ] - RunGraph [2018-01-01 02:00:26,445] [Log ] [25 ] [INFO ] - subch:0 OnGraphStart [2018-01-01 02:00:26,446] [Log ] [25 ] [INFO ] - dvb: RunGraph [2018-01-01 02:00:27,297] [Log ] [25 ] [INFO ] - dvb: LockInOnSignal ok [2018-01-01 02:00:27,298] [Log ] [25 ] [INFO ] - subch:0 OnGraphStarted [2018-01-01 02:00:27,299] [Log ] [25 ] [INFO ] - subch:0 SetupPmtGrabber:pid 100 sid:1038 [2018-01-01 02:00:27,300] [Log ] [25 ] [INFO ] - subch:0 set pmt grabber pmt:100 sid:1038 [2018-01-01 02:00:37,307] [Log ] [25 ] [INFO ] - subch:0 SetupPmtGrabber:pid 0 sid:1038 [2018-01-01 02:00:37,308] [Log ] [25 ] [INFO ] - subch:0 set pmt grabber pmt:0 sid:1038 [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0 [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - DVB subch:0 Decompose() [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - FreeSubChannel CA: freeing sub channel : 0 [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - dvb:StopGraph called [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - tvcard:FreeAllSubChannels [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - dvb:StopGraph [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - debug: IMediaControl stopped! hr = 0x0 :) [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - card2:Custom_159.ts 6 -1 [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - card: SignalTuneEvent card: 6 / subch: 0 [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - Controller: Custom_159.ts 6 -1 [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - Controller: Timeshifting failed, no more cards available. [2018-01-01 02:00:47,318] [Log ] [25 ] [INFO ] - Controller: epg start [2018-01-01 02:00:47,355] [EPG ] [25 ] [INFO ] - EPG: grabber initialized for 13 transponders.. [2018-01-01 02:00:47,355] [Log ] [17 ] [INFO ] - Sky Plugin : Error Occured:- NoPmtFound [2018-01-01 02:00:55,167] [Log ] [3 ] [INFO ] - Sky Plugin : Sky Channel and EPG Grabber initialised [2018-01-01 02:00:55,184] [Log ] [17 ] [INFO ] - Sky Plugin : Huffman Loaded [2018-01-01 02:00:55,188] [Log ] [17 ] [INFO ] - Sky Plugin : Grabbing Data [2018-01-01 02:00:55,189] [Log ] [17 ] [INFO ] - Sky Plugin : Grabber set to grab 90 seconds of data [2018-01-01 02:00:55,191] [Log ] [25 ] [INFO ] - Controller: StartTimeShifting Sky UK Grabber 159 [2018-01-01 02:00:55,192] [Log ] [25 ] [INFO ] - Controller: epg stop [2018-01-01 02:00:55,192] [EPG ] [25 ] [INFO ] - EPG: grabber stopped.. [2018-01-01 02:00:55,193] [Log ] [25 ] [INFO ] - Controller: find free card for channel Sky UK Grabber [2018-01-01 02:00:55,194] [Log ] [25 ] [INFO ] - Controller: find card for channel Sky UK Grabber [2018-01-01 02:00:55,195] [Log ] [25 ] [INFO ] - Controller: got 1 tuning details for Sky UK Grabber [2018-01-01 02:00:55,196] [Log ] [25 ] [INFO ] - Controller: channel #1 DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:00:55,196] [Log ] [25 ] [INFO ] - Controller: card:1 type:RadioWebStream cannot tune to channel [2018-01-01 02:00:55,197] [Log ] [25 ] [INFO ] - Controller: card:2 type:DvbIP cannot tune to channel [2018-01-01 02:00:55,197] [Log ] [25 ] [INFO ] - Controller: card:3 type:DvbT cannot tune to channel [2018-01-01 02:00:55,198] [Log ] [25 ] [INFO ] - Controller: card:4 type:DvbT cannot tune to channel [2018-01-01 02:00:55,199] [Log ] [25 ] [INFO ] - Controller: card:5 type:DvbS can tune to channel [2018-01-01 02:00:55,200] [Log ] [25 ] [INFO ] - Controller: card:6 type:DvbS can tune to channel [2018-01-01 02:00:55,201] [Log ] [25 ] [INFO ] - Controller: found 2 card(s) for channel [2018-01-01 02:00:55,202] [Log ] [25 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 8 msec [2018-01-01 02:00:55,202] [Log ] [25 ] [INFO ] - Controller: found 2 free card(s) [2018-01-01 02:00:55,203] [Log ] [25 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 9 msec [2018-01-01 02:00:55,204] [Log ] [25 ] [INFO ] - Controller: card:5 type:DvbS users: 0 [2018-01-01 02:00:55,205] [Log ] [25 ] [INFO ] - Controller: card:5 type:DvbS is available [2018-01-01 02:00:55,206] [Log ] [25 ] [INFO ] - Controller: card:6 type:DvbS users: 0 [2018-01-01 02:00:55,206] [Log ] [25 ] [INFO ] - Controller: card:6 type:DvbS is available [2018-01-01 02:00:55,207] [Log ] [25 ] [INFO ] - Controller: try max 2 of 2 cards for timeshifting [2018-01-01 02:00:55,209] [Log ] [25 ] [INFO ] - card: CardTune 5 Sky UK Grabber Custom_159.ts:5:-1 [2018-01-01 02:00:55,210] [Log ] [25 ] [INFO ] - card: Tune on card 5 to subchannel Sky UK Grabber [2018-01-01 02:00:55,215] [Log ] [25 ] [INFO ] - dvbs: Tune:DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:00:55,216] [Log ] [25 ] [INFO ] - dvbs: Tune:DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:00:55,216] [Log ] [25 ] [INFO ] - dvb:GetNewSubChannel:0 #0 [2018-01-01 02:00:55,217] [Log ] [25 ] [INFO ] - TvDvbChannel ctor new subchIndex:0 [2018-01-01 02:00:55,218] [Log ] [25 ] [INFO ] - card: AddTuneEvent card: 5 / subch: 0 [2018-01-01 02:00:55,218] [Log ] [25 ] [INFO ] - LNB low:9750 hi:10600 switch:11700 [2018-01-01 02:00:55,219] [Log ] [25 ] [INFO ] - dvbs:channel modulation is set to ModNotSet [2018-01-01 02:00:55,220] [Log ] [25 ] [INFO ] - dvbs:channel FECRate is set to RateNotSet [2018-01-01 02:00:55,220] [Log ] [25 ] [INFO ] - Digital Devices: SimpleA - SendDiSEqCCommand(0x00) [2018-01-01 02:00:55,221] [Log ] [25 ] [INFO ] - Digital Devices: SendDiSEqC Command 0 [2018-01-01 02:00:55,222] [Log ] [25 ] [INFO ] - Digital Devices: put_Range:0 success:0 [2018-01-01 02:00:55,222] [Log ] [25 ] [INFO ] - Digital Devices: CommitChanges() Succeeded [2018-01-01 02:00:55,335] [Log ] [25 ] [INFO ] - dvb:Submiting tunerequest Channel:Sky UK Grabber subChannel:0 [2018-01-01 02:00:55,336] [Log ] [25 ] [INFO ] - dvb:using existing subchannel:0 [2018-01-01 02:00:55,337] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest size:1 new:0 [2018-01-01 02:00:55,338] [Log ] [25 ] [INFO ] - subch:0 OnBeforeTune [2018-01-01 02:00:55,338] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest calling put_TuneRequest [2018-01-01 02:00:55,339] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest done calling put_TuneRequest [2018-01-01 02:00:55,340] [Log ] [25 ] [INFO ] - subch:0 OnAfterTune [2018-01-01 02:00:55,340] [Log ] [25 ] [INFO ] - RunGraph [2018-01-01 02:00:55,341] [Log ] [25 ] [INFO ] - subch:0 OnGraphStart [2018-01-01 02:00:55,342] [Log ] [25 ] [INFO ] - dvb: RunGraph [2018-01-01 02:00:56,193] [Log ] [25 ] [INFO ] - dvb: LockInOnSignal ok [2018-01-01 02:00:56,194] [Log ] [25 ] [INFO ] - subch:0 OnGraphStarted [2018-01-01 02:00:56,195] [Log ] [25 ] [INFO ] - subch:0 SetupPmtGrabber:pid 100 sid:1038 [2018-01-01 02:00:56,195] [Log ] [25 ] [INFO ] - subch:0 set pmt grabber pmt:100 sid:1038 [2018-01-01 02:01:06,209] [Log ] [25 ] [INFO ] - subch:0 SetupPmtGrabber:pid 0 sid:1038 [2018-01-01 02:01:06,210] [Log ] [25 ] [INFO ] - subch:0 set pmt grabber pmt:0 sid:1038 [2018-01-01 02:01:16,212] [Log ] [25 ] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0 [2018-01-01 02:01:16,213] [Log ] [25 ] [INFO ] - DVB subch:0 Decompose() [2018-01-01 02:01:16,213] [Log ] [25 ] [INFO ] - FreeSubChannel CA: freeing sub channel : 0 [2018-01-01 02:01:16,214] [Log ] [25 ] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph [2018-01-01 02:01:16,215] [Log ] [25 ] [INFO ] - dvb:StopGraph called [2018-01-01 02:01:16,216] [Log ] [25 ] [INFO ] - tvcard:FreeAllSubChannels [2018-01-01 02:01:16,216] [Log ] [25 ] [INFO ] - dvb:StopGraph [2018-01-01 02:01:16,221] [Log ] [25 ] [INFO ] - debug: IMediaControl stopped! hr = 0x0 :) [2018-01-01 02:01:16,222] [Log ] [25 ] [INFO ] - card2:Custom_159.ts 5 -1 [2018-01-01 02:01:16,223] [Log ] [25 ] [INFO ] - card: SignalTuneEvent card: 5 / subch: 0 [2018-01-01 02:01:16,223] [Log ] [25 ] [INFO ] - Controller: Custom_159.ts 5 -1 [2018-01-01 02:01:16,225] [Log ] [25 ] [INFO ] - Controller: Timeshifting failed, lets try next available card. [2018-01-01 02:01:16,226] [Log ] [25 ] [INFO ] - card: CardTune 6 Sky UK Grabber Custom_159.ts:6:-1 [2018-01-01 02:01:16,227] [Log ] [25 ] [INFO ] - card: Tune on card 6 to subchannel Sky UK Grabber [2018-01-01 02:01:16,234] [Log ] [25 ] [INFO ] - dvbs: Tune:DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:01:16,235] [Log ] [25 ] [INFO ] - dvbs: Tune:DVBS:radio:DJBlu Sky UK Grabber Freq:11778000 ONID:2 TSID:2004 SID:4152 PMT:0x100 FTA:True LCN:10000 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:RateNotSet DisEqc:SimpleA band:Universal Pilot:NotSet RollOff:NotSet [2018-01-01 02:01:16,236] [Log ] [25 ] [INFO ] - dvb:GetNewSubChannel:0 #0 [2018-01-01 02:01:16,237] [Log ] [25 ] [INFO ] - TvDvbChannel ctor new subchIndex:0 [2018-01-01 02:01:16,238] [Log ] [25 ] [INFO ] - card: AddTuneEvent card: 6 / subch: 0 [2018-01-01 02:01:16,238] [Log ] [25 ] [INFO ] - LNB low:9750 hi:10600 switch:11700 [2018-01-01 02:01:16,239] [Log ] [25 ] [INFO ] - dvbs:channel modulation is set to ModNotSet [2018-01-01 02:01:16,240] [Log ] [25 ] [INFO ] - dvbs:channel FECRate is set to RateNotSet [2018-01-01 02:01:16,241] [Log ] [25 ] [INFO ] - Digital Devices: SimpleA - SendDiSEqCCommand(0x00) [2018-01-01 02:01:16,242] [Log ] [25 ] [INFO ] - Digital Devices: SendDiSEqC Command 0 [2018-01-01 02:01:16,242] [Log ] [25 ] [INFO ] - Digital Devices: put_Range:0 success:0 [2018-01-01 02:01:16,244] [Log ] [25 ] [INFO ] - Digital Devices: CommitChanges() Succeeded [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - dvb:Submiting tunerequest Channel:Sky UK Grabber subChannel:0 [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - dvb:using existing subchannel:0 [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest size:1 new:0 [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - subch:0 OnBeforeTune [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest calling put_TuneRequest [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - dvb:Submit tunerequest done calling put_TuneRequest [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - subch:0 OnAfterTune [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - RunGraph [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - subch:0 OnGraphStart [2018-01-01 02:01:16,362] [Log ] [25 ] [INFO ] - dvb: RunGraph [2018-01-01 02:01:17,245] [Log ] [25 ] [INFO ] - dvb: LockInOnSignal ok [2018-01-01 02:01:17,245] [Log ] [25 ] [INFO ] - subch:0 OnGraphStarted [2018-01-01 02:01:17,245] [Log ] [25 ] [INFO ] - subch:0 SetupPmtGrabber:pid 100 sid:1038 [2018-01-01 02:01:17,245] [Log ] [25 ] [INFO ] - subch:0 set pmt grabber pmt:100 sid:1038 [2018-01-01 02:01:27,258] [Log ] [25 ] [INFO ] - subch:0 SetupPmtGrabber:pid 0 sid:1038 [2018-01-01 02:01:27,259] [Log ] [25 ] [INFO ] - subch:0 set pmt grabber pmt:0 sid:1038 [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0 [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - DVB subch:0 Decompose() [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - FreeSubChannel CA: freeing sub channel : 0 [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - dvb:StopGraph called [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - tvcard:FreeAllSubChannels [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - dvb:StopGraph [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - debug: IMediaControl stopped! hr = 0x0 :) [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - card2:Custom_159.ts 6 -1 [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - card: SignalTuneEvent card: 6 / subch: 0 [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - Controller: Custom_159.ts 6 -1 [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - Controller: Timeshifting failed, no more cards available. [2018-01-01 02:01:37,271] [Log ] [25 ] [INFO ] - Controller: epg start [2018-01-01 02:01:37,302] [EPG ] [25 ] [INFO ] - EPG: grabber initialized for 13 transponders.. [2018-01-01 02:01:37,317] [Log ] [29 ] [INFO ] - Sky Plugin : Error Occured:- NoPmtFound