2011-03-22 19:56:22.951293 [scheduler thread(12)]: Controller: card:2 type:DvbC is available priority:3 #users:0 same transponder:True 2011-03-22 19:56:22.951293 [scheduler thread(12)]: Controller: card:3 type:RadioWebStream is disabled 2011-03-22 19:56:22.951293 [scheduler thread(12)]: Controller: card:4 type:DvbC is available priority:1 #users:0 same transponder:True 2011-03-22 19:56:22.951293 [scheduler thread(12)]: Controller: found 2 available 2011-03-22 19:56:22.951293 [scheduler thread(12)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 1156 msec 2011-03-22 19:56:22.966893 [scheduler thread(12)]: Scheduler : record on free card:2 priority:3 2011-03-22 19:56:22.966893 [scheduler thread(12)]: Controller: epg stop 2011-03-22 19:56:22.966893 [scheduler thread(12)]: Scheduler : record, first tune to channel 2011-03-22 19:56:22.982494 [scheduler thread(12)]: card: Tune 2 to RTL 4 HD 2011-03-22 19:56:22.982494 [scheduler thread(12)]: card: user: scheduler1:2:-1 tune DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:56:22.982494 [scheduler thread(12)]: dvbc: Tune:DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:56:22.982494 [scheduler thread(12)]: dvbc:BuildGraph 2011-03-22 19:56:22.998094 [scheduler thread(12)]: dvb:AddNetworkProviderFilter 2011-03-22 19:56:22.998094 [scheduler thread(12)]: dvb:Add Generic Network Provider 2011-03-22 19:56:22.998094 [scheduler thread(12)]: dvbc:CreateTuningSpace() 2011-03-22 19:56:22.998094 [scheduler thread(12)]: dvbc:Found correct tuningspace MediaPortal DVBC TuningSpace 2011-03-22 19:56:22.998094 [scheduler thread(12)]: dvb:Add MPEG2 Demultiplexer filter 2011-03-22 19:56:22.998094 [scheduler thread(12)]: dvb:add Inf Tee filter 2011-03-22 19:56:23.013694 [scheduler thread(12)]: dvb:AddAndConnectBDABoardFilters 2011-03-22 19:56:23.013694 [scheduler thread(12)]: dvb: find bda tuner 2011-03-22 19:56:23.029294 [scheduler thread(12)]: dvb: using [Tuner]: FireDTV BDA Tuner DVBC 2011-03-22 19:56:23.029294 [scheduler thread(12)]: dvb: Render [Network provider]->[Tuner] OK 2011-03-22 19:56:23.044894 [scheduler thread(12)]: dvb: Find BDA receiver 2011-03-22 19:56:23.044894 [scheduler thread(12)]: dvb: match Capture by Tuner device path 2011-03-22 19:56:23.044894 [scheduler thread(12)]: dvb: -FireDTV BDA Receiver DVBC 2011-03-22 19:56:23.044894 [scheduler thread(12)]: dvb: -FireDTV BDA Receiver DVBC 2011-03-22 19:56:23.044894 [scheduler thread(12)]: dvb: Render [Tuner]->[Capture] AOK 2011-03-22 19:56:23.044894 [scheduler thread(12)]: dvb: WinTv CI module not detected. 2011-03-22 19:56:23.044894 [scheduler thread(12)]: dvb: Render [capture]->[inftee] 2011-03-22 19:56:23.044894 [scheduler thread(12)]: dvb: OK 2011-03-22 19:56:23.060494 [scheduler thread(12)]: dvb: Render [inftee]->[demux] 2011-03-22 19:56:23.060494 [scheduler thread(12)]: dvb: Add Mediaportal TsWriter filter 2011-03-22 19:56:23.060494 [scheduler thread(12)]: dvb: Render [InfTee]->[TsWriter] 2011-03-22 19:56:23.076094 [scheduler thread(12)]: CAM is Default model 2011-03-22 19:56:23.076094 [scheduler thread(12)]: Check for KNC 2011-03-22 19:56:23.076094 [scheduler thread(12)]: KNC: IsKNC False 2011-03-22 19:56:23.076094 [scheduler thread(12)]: KNC: Disable CI 2011-03-22 19:56:23.076094 [scheduler thread(12)]: KNC: Disposing CI handler 2011-03-22 19:56:23.076094 [scheduler thread(12)]: Check for Digital Everywhere 2011-03-22 19:56:23.076094 [scheduler thread(12)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:23.076094 [scheduler thread(12)]: FireDTV cam detected : True 2011-03-22 19:56:23.091694 [scheduler thread(12)]: FireDTV cam specs : manufacturer_code=8266, application_manufacturer=8266 2011-03-22 19:56:23.091694 [scheduler thread(12)]: FireDTV cam name : "AlphaCrypt" 2011-03-22 19:56:23.091694 [scheduler thread(12)]: FireDTV driver version: 5.0 (6070-3000) x64 2011-03-22 19:56:23.107294 [scheduler thread(12)]: FireDTV board version : HW 01.26.02, FW 02.04.04 build 61030 2011-03-22 19:56:23.107294 [scheduler thread(12)]: Digital Everywhere card detected 2011-03-22 19:56:23.122894 [scheduler thread(12)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:23.122894 [scheduler thread(12)]: FireDTV:cam is inserted 2011-03-22 19:56:23.122894 [scheduler thread(12)]: FireDTV:cam is valid 2011-03-22 19:56:23.122894 [scheduler thread(12)]: FireDTV:cam is ready 2011-03-22 19:56:23.122894 [scheduler thread(12)]: FireDTV:cam is able to descramble 2011-03-22 19:56:23.122894 [scheduler thread(12)]: Digital Everywhere registering CI menu capabilities 2011-03-22 19:56:23.138494 [scheduler thread(12)]: dvb: AddTransportStreamFiltersToGraph 2011-03-22 19:56:23.138494 [scheduler thread(12)]: add BDA MPEG2 Transport Information Filter filter 2011-03-22 19:56:23.138494 [scheduler thread(12)]: pinTif:name:IB Input [3/1] Direction:Input Connected:False 2011-03-22 19:56:23.138494 [scheduler thread(12)]: Connect tif and mpeg2 sections and tables 2011-03-22 19:56:23.138494 [scheduler thread(12)]: dvb:try tif:name:001 [5/1] Direction:Output Connected:False 2011-03-22 19:56:23.138494 [scheduler thread(12)]: tif connected 2011-03-22 19:56:23.278894 [scheduler thread(12)]: dvb: GetTunerSignalStatistics() 2011-03-22 19:56:23.294494 [scheduler thread(12)]: dvb:GetNewSubChannel:0 #0 2011-03-22 19:56:23.294494 [scheduler thread(12)]: TvDvbChannel ctor new subchIndex:0 2011-03-22 19:56:23.294494 [scheduler thread(12)]: dvb:Submiting tunerequest Channel:RTL 4 HD subChannel:0 2011-03-22 19:56:23.294494 [scheduler thread(12)]: dvb:using existing subchannel:0 2011-03-22 19:56:23.294494 [scheduler thread(12)]: dvb:Submit tunerequest size:1 new:0 2011-03-22 19:56:23.294494 [scheduler thread(12)]: subch:0 OnBeforeTune 2011-03-22 19:56:23.310094 [scheduler thread(12)]: dvb:Submit tunerequest calling put_TuneRequest 2011-03-22 19:56:23.310094 [scheduler thread(12)]: dvb:Submit tunerequest done calling put_TuneRequest 2011-03-22 19:56:23.310094 [scheduler thread(12)]: subch:0 OnAfterTune 2011-03-22 19:56:23.310094 [scheduler thread(12)]: FireDTV: HW Filtering disabled. 2011-03-22 19:56:23.310094 [scheduler thread(12)]: FireDTV: Set H/W pid filtering is not supported 2011-03-22 19:56:23.310094 [scheduler thread(12)]: subch:0 OnGraphStart 2011-03-22 19:56:23.310094 [scheduler thread(12)]: dvb: RunGraph 2011-03-22 19:56:23.668895 [scheduler thread(12)]: dvb: LockedInOnSignal ok 2011-03-22 19:56:23.668895 [scheduler thread(12)]: subch:0 OnGraphStarted 2011-03-22 19:56:23.668895 [scheduler thread(12)]: subch:0 SetupPmtGrabber:pid 64 sid:CC 2011-03-22 19:56:23.668895 [scheduler thread(12)]: subch:0 set pmt grabber pmt:64 sid:CC 2011-03-22 19:56:23.668895 [scheduler thread(12)]: WaitForPMT: Waiting for PMT 64 2011-03-22 19:56:24.121296 [(4)]: subch:0 OnPMTReceived() pmt:64 ran:True dynamic:False 2011-03-22 19:56:24.136896 [scheduler thread(12)]: WaitForPMT: Found PMT after 0,4680008 seconds. 2011-03-22 19:56:24.136896 [scheduler thread(12)]: subch:0 SendPmt:CC CC FFFFFFFF 7 2011-03-22 19:56:24.136896 [scheduler thread(12)]: Decode pmt 2011-03-22 19:56:24.136896 [scheduler thread(12)]: descr1 len:6 9 4 6 4 f3 8f 2011-03-22 19:56:24.136896 [scheduler thread(12)]: Set descriptor data with length 7 2011-03-22 19:56:24.136896 [scheduler thread(12)]: subch:0 SendPMT version:7 len:89 204 2011-03-22 19:56:24.152496 [scheduler thread(12)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:24.152496 [scheduler thread(12)]: FireDTV:cam is inserted 2011-03-22 19:56:24.152496 [scheduler thread(12)]: FireDTV:cam is valid 2011-03-22 19:56:24.152496 [scheduler thread(12)]: FireDTV:cam is ready 2011-03-22 19:56:24.152496 [scheduler thread(12)]: FireDTV:cam is able to descramble 2011-03-22 19:56:24.168096 [scheduler thread(12)]: FireDTV cam specs : manufacturer_code=8266, application_manufacturer=8266 2011-03-22 19:56:24.168096 [scheduler thread(12)]: FireDTV cam name : "AlphaCrypt" 2011-03-22 19:56:24.168096 [scheduler thread(12)]: FireDTV: #0/1 pmt data:0x0 0x2 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x5B 0x3 0x1 0x2 0xB0 0x59 0x0 0xCC 0xCF 0x0 0x0 0xE0 0x65 0xF0 0x6 0x9 0x4 0x6 0x4 0xF3 0x8F 0x1B 0xE0 0x65 0xF0 0x3 0x11 0x1 0xFF 0x3 0xE0 0x66 0xF0 0x0 0x6 0xE0 0x72 0xF0 0x25 0x56 0x5 0x64 0x75 0x74 0x9 0x0 0x45 0x1C 0x1 0x1A 0xE7 0xE8 0xE9 0xEA 0xEB 0xEC 0xED 0xEE 0xEF 0xF0 0xF3 0xF4 0xF5 0xC7 0xC8 0xC9 0xCA 0xCB 0xCC 0xCD 0xCE 0xCF 0xD0 0xD3 0xD4 0xD5 0x6 0xE1 0xC2 0xF0 0xA 0x5 0x4 0x41 0x43 0x2D 0x33 0x6A 0x2 0x80 0x0 0x53 2011-03-22 19:56:24.199296 [scheduler thread(12)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:24.199296 [scheduler thread(12)]: FireDTV:cam is inserted 2011-03-22 19:56:24.199296 [scheduler thread(12)]: FireDTV:cam is valid 2011-03-22 19:56:24.199296 [scheduler thread(12)]: FireDTV:cam is ready 2011-03-22 19:56:24.199296 [scheduler thread(12)]: FireDTV:cam is able to descramble 2011-03-22 19:56:24.199296 [scheduler thread(12)]: subch:0 cam flags:True 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 SetMpegPidMapping 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 pid:65 pcr 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 pid:64 pmt 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 pid:65 video type:H.264 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 map pid:65 video type:H.264 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 pid:66 audio lang: type:MPEG-1 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 map pid:66 audio lang: type:MPEG-1 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 pid:72 teletext type:6 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 map pid:72 teletext type:6 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 pid:1C2 audio lang: type:AC3 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 map pid:1C2 audio lang: type:AC3 2011-03-22 19:56:24.214896 [scheduler thread(12)]: FireDTV: HW Filtering disabled. 2011-03-22 19:56:24.214896 [scheduler thread(12)]: FireDTV: Set H/W pid filtering is not supported 2011-03-22 19:56:24.214896 [scheduler thread(12)]: subch:0 stop tif 2011-03-22 19:56:24.214896 [scheduler thread(12)]: WaitForPmt: PMT handling took 0,0780001 seconds. 2011-03-22 19:56:24.386496 [scheduler thread(12)]: card: Tuner locked: True 2011-03-22 19:56:24.386496 [scheduler thread(12)]: ************************************************** 2011-03-22 19:56:24.386496 [scheduler thread(12)]: ***** SIGNAL LEVEL: 49, SIGNAL QUALITY: 74 ***** 2011-03-22 19:56:24.386496 [scheduler thread(12)]: ************************************************** 2011-03-22 19:56:24.386496 [scheduler thread(12)]: card: tuned user: scheduler1 subchannel: 0 2011-03-22 19:56:24.386496 [scheduler thread(12)]: user:scheduler1 add 2011-03-22 19:56:24.402096 [scheduler thread(12)]: Scheduler: MakeFileName() using "seriesformat" (_isSerie=True) 2011-03-22 19:56:24.402096 [scheduler thread(12)]: Scheduler : record to D:\\RTL 4 HD\Goede tijden, slechte tijden 2011-03-22\Goede tijden, slechte tijden_1.ts 2011-03-22 19:56:24.402096 [scheduler thread(12)]: Recorder.start add audioVideoEventHandler 2011-03-22 19:56:24.402096 [scheduler thread(12)]: card: StartRecording 2 D:\\RTL 4 HD\Goede tijden, slechte tijden 2011-03-22\Goede tijden, slechte tijden_1.ts 2011-03-22 19:56:24.402096 [scheduler thread(12)]: StartRecording to D:\\RTL 4 HD\Goede tijden, slechte tijden 2011-03-22\Goede tijden, slechte tijden_1.ts 2011-03-22 19:56:24.417696 [scheduler thread(12)]: subch:0 StartRecord(D:\\RTL 4 HD\Goede tijden, slechte tijden 2011-03-22\Goede tijden, slechte tijden_1.ts) 2011-03-22 19:56:24.417696 [scheduler thread(12)]: subch:0-0 tswriter StartRecording... 2011-03-22 19:56:24.417696 [scheduler thread(12)]: SetRecorderPids 2011-03-22 19:56:24.417696 [scheduler thread(12)]: Set video / audio observer 2011-03-22 19:56:24.417696 [scheduler thread(12)]: DVB subch:0 Started recording 2011-03-22 19:56:24.417696 [scheduler thread(12)]: card: WaitForRecordingFile - waiting _eventAudio & _eventVideo 2011-03-22 19:56:24.417696 [(4)]: PID seen - type = Audio 2011-03-22 19:56:24.433296 [(4)]: Recorder audioVideoEventHandler Audio 2011-03-22 19:56:24.464496 [(4)]: PID seen - type = Audio 2011-03-22 19:56:24.464496 [(4)]: Recorder audioVideoEventHandler Audio 2011-03-22 19:56:24.464496 [(4)]: PID seen - type = Video 2011-03-22 19:56:24.464496 [(4)]: Recorder audioVideoEventHandler Video 2011-03-22 19:56:24.464496 [scheduler thread(12)]: card: WaitForRecordingFile - video and audio are seen after 0,0468001 seconds 2011-03-22 19:56:24.542496 [scheduler thread(12)]: Scheduler: adding new row in db for title="Goede tijden, slechte tijden" of type="6" 2011-03-22 19:56:24.542496 [scheduler thread(12)]: Scheduler: recList: count: 1 add scheduleid: 1 card: FireDTV BDA Tuner DVBC 2011-03-22 19:56:50.734942 [(9)]: Controller: TimeShiftingWouldUseCard RTL 4 HD 185 2011-03-22 19:56:50.734942 [(9)]: Controller: find free card for channel RTL 4 HD 2011-03-22 19:56:50.734942 [(9)]: Controller: got 1 tuning details for RTL 4 HD 2011-03-22 19:56:50.734942 [(9)]: Controller: channel #1 DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:56:50.734942 [(9)]: Controller: card:1 type:DvbIP is disabled 2011-03-22 19:56:50.750542 [(9)]: Controller: card:2 type:DvbC is tuned to same transponder decrypting 1/4 channels 2011-03-22 19:56:50.750542 [(9)]: Controller: card:2 type:DvbC is available priority:3 #users:1 same transponder:True 2011-03-22 19:56:50.750542 [(9)]: Controller: card:3 type:RadioWebStream is disabled 2011-03-22 19:56:50.750542 [(9)]: Controller: card:4 type:DvbC is available priority:1 #users:0 same transponder:True 2011-03-22 19:56:50.750542 [(9)]: Controller: found 2 available 2011-03-22 19:56:50.750542 [(9)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 17 msec 2011-03-22 19:56:50.750542 [(9)]: CiMenuSupported called cardid 2 2011-03-22 19:56:50.750542 [(9)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:50.766142 [(9)]: FireDTV:cam is inserted 2011-03-22 19:56:50.766142 [(9)]: FireDTV:cam is valid 2011-03-22 19:56:50.766142 [(9)]: FireDTV:cam is ready 2011-03-22 19:56:50.766142 [(9)]: FireDTV:cam is able to descramble 2011-03-22 19:56:50.766142 [(9)]: CiMenuSupported card FireDTV BDA Tuner DVBC supported: True 2011-03-22 19:56:50.766142 [(9)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:50.766142 [(9)]: FireDTV:cam is inserted 2011-03-22 19:56:50.766142 [(9)]: FireDTV:cam is valid 2011-03-22 19:56:50.766142 [(9)]: FireDTV:cam is ready 2011-03-22 19:56:50.766142 [(9)]: FireDTV:cam is able to descramble 2011-03-22 19:56:50.766142 [(9)]: CiMenu: registered client event for callback 2011-03-22 19:56:50.781742 [(9)]: TvController: EnableCiMenuHandler called 2011-03-22 19:56:50.781742 [(9)]: FireDTV: registering ci callbacks 2011-03-22 19:56:50.781742 [(9)]: FireDTV: Starting new CI handler thread 2011-03-22 19:56:50.781742 [(9)]: TvController: SetCiMenuHandler: result True 2011-03-22 19:56:50.781742 [FireDTV CiMenuHandler(17)]: FireDTV: CI handler thread start polling status 2011-03-22 19:56:50.797342 [(9)]: Controller: StartTimeShifting RTL 4 HD 185 2011-03-22 19:56:50.797342 [(9)]: Controller: find free card for channel RTL 4 HD 2011-03-22 19:56:50.797342 [(9)]: Controller: got 1 tuning details for RTL 4 HD 2011-03-22 19:56:50.797342 [(9)]: Controller: channel #1 DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:56:50.797342 [(9)]: Controller: card:1 type:DvbIP is disabled 2011-03-22 19:56:50.797342 [(9)]: Controller: card:2 type:DvbC is tuned to same transponder decrypting 1/4 channels 2011-03-22 19:56:50.797342 [(9)]: Controller: card:2 type:DvbC is available priority:3 #users:1 same transponder:True 2011-03-22 19:56:50.797342 [(9)]: Controller: card:3 type:RadioWebStream is disabled 2011-03-22 19:56:50.797342 [(9)]: Controller: card:4 type:DvbC is available priority:1 #users:0 same transponder:True 2011-03-22 19:56:50.797342 [(9)]: Controller: found 2 available 2011-03-22 19:56:50.797342 [(9)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 7 msec 2011-03-22 19:56:50.812942 [(9)]: card: CardTune 2 RTL 4 HD woka01:2:-1 2011-03-22 19:56:50.812942 [(9)]: card: Tune 2 to RTL 4 HD 2011-03-22 19:56:50.812942 [(9)]: card: user: woka01:2:-1 tune DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:56:50.812942 [(9)]: tvcard:FreeSubChannel: subchannels count 1 subch#-1 keep graph=False 2011-03-22 19:56:50.812942 [(9)]: tvcard:FreeSubChannel :-1 - sub channel not found 2011-03-22 19:56:50.812942 [(9)]: dvbc: Tune:DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:56:50.812942 [(9)]: dvb:Submiting tunerequest Channel:RTL 4 HD subChannel:-1 2011-03-22 19:56:50.812942 [(9)]: dvb:Getting new subchannel 2011-03-22 19:56:50.812942 [(9)]: dvb:GetNewSubChannel:1 #1 2011-03-22 19:56:50.812942 [(9)]: TvDvbChannel ctor new subchIndex:1 2011-03-22 19:56:50.812942 [(9)]: dvb:Submit tunerequest size:2 new:1 2011-03-22 19:56:50.812942 [(9)]: subch:1 OnBeforeTune 2011-03-22 19:56:50.812942 [(9)]: subch:1 OnAfterTune 2011-03-22 19:56:50.828542 [(9)]: FireDTV: HW Filtering disabled. 2011-03-22 19:56:50.828542 [(9)]: FireDTV: Set H/W pid filtering is not supported 2011-03-22 19:56:50.844142 [(9)]: dvb: LockedInOnSignal ok 2011-03-22 19:56:50.844142 [(9)]: subch:1 OnGraphStart 2011-03-22 19:56:50.844142 [(9)]: subch:1 Graph already running - WaitForPMT 2011-03-22 19:56:50.844142 [(9)]: subch:1 SetupPmtGrabber:pid 64 sid:CC 2011-03-22 19:56:50.844142 [(9)]: subch:1 set pmt grabber pmt:64 sid:CC 2011-03-22 19:56:50.844142 [(9)]: WaitForPMT: Waiting for PMT 64 2011-03-22 19:56:51.187343 [(4)]: subch:1 OnPMTReceived() pmt:64 ran:True dynamic:False 2011-03-22 19:56:51.187343 [(9)]: WaitForPMT: Found PMT after 0,3432006 seconds. 2011-03-22 19:56:51.187343 [(9)]: subch:1 SendPmt:CC CC FFFFFFFF 7 2011-03-22 19:56:51.187343 [(9)]: Decode pmt 2011-03-22 19:56:51.187343 [(9)]: descr1 len:6 9 4 6 4 f3 8f 2011-03-22 19:56:51.187343 [(9)]: Set descriptor data with length 7 2011-03-22 19:56:51.187343 [(9)]: subch:1 SendPMT version:7 len:89 204 2011-03-22 19:56:51.202943 [(9)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:51.202943 [(9)]: FireDTV:cam is inserted 2011-03-22 19:56:51.202943 [(9)]: FireDTV:cam is valid 2011-03-22 19:56:51.202943 [(9)]: FireDTV:cam is ready 2011-03-22 19:56:51.202943 [(9)]: FireDTV:cam is able to descramble 2011-03-22 19:56:51.202943 [(9)]: FireDTV: #0/1 pmt data:0x0 0x2 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x5B 0x3 0x1 0x2 0xB0 0x59 0x0 0xCC 0xCF 0x0 0x0 0xE0 0x65 0xF0 0x6 0x9 0x4 0x6 0x4 0xF3 0x8F 0x1B 0xE0 0x65 0xF0 0x3 0x11 0x1 0xFF 0x3 0xE0 0x66 0xF0 0x0 0x6 0xE0 0x72 0xF0 0x25 0x56 0x5 0x64 0x75 0x74 0x9 0x0 0x45 0x1C 0x1 0x1A 0xE7 0xE8 0xE9 0xEA 0xEB 0xEC 0xED 0xEE 0xEF 0xF0 0xF3 0xF4 0xF5 0xC7 0xC8 0xC9 0xCA 0xCB 0xCC 0xCD 0xCE 0xCF 0xD0 0xD3 0xD4 0xD5 0x6 0xE1 0xC2 0xF0 0xA 0x5 0x4 0x41 0x43 0x2D 0x33 0x6A 0x2 0x80 0x0 0x53 2011-03-22 19:56:51.234143 [(9)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:51.234143 [(9)]: FireDTV:cam is inserted 2011-03-22 19:56:51.234143 [(9)]: FireDTV:cam is valid 2011-03-22 19:56:51.234143 [(9)]: FireDTV:cam is ready 2011-03-22 19:56:51.234143 [(9)]: FireDTV:cam is able to descramble 2011-03-22 19:56:51.234143 [(9)]: subch:1 cam flags:True 2011-03-22 19:56:51.234143 [(9)]: subch:1 SetMpegPidMapping 2011-03-22 19:56:51.234143 [(9)]: subch:1 pid:65 pcr 2011-03-22 19:56:51.234143 [(9)]: subch:1 pid:64 pmt 2011-03-22 19:56:51.234143 [(9)]: subch:1 pid:65 video type:H.264 2011-03-22 19:56:51.234143 [(9)]: subch:1 map pid:65 video type:H.264 2011-03-22 19:56:51.234143 [(9)]: subch:1 pid:66 audio lang: type:MPEG-1 2011-03-22 19:56:51.234143 [(9)]: subch:1 map pid:66 audio lang: type:MPEG-1 2011-03-22 19:56:51.234143 [(9)]: subch:1 pid:72 teletext type:6 2011-03-22 19:56:51.234143 [(9)]: subch:1 map pid:72 teletext type:6 2011-03-22 19:56:51.234143 [(9)]: subch:1 pid:1C2 audio lang: type:AC3 2011-03-22 19:56:51.234143 [(9)]: subch:1 map pid:1C2 audio lang: type:AC3 2011-03-22 19:56:51.234143 [(9)]: FireDTV: HW Filtering disabled. 2011-03-22 19:56:51.234143 [(9)]: FireDTV: Set H/W pid filtering is not supported 2011-03-22 19:56:51.234143 [(9)]: subch:1 stop tif 2011-03-22 19:56:51.234143 [(9)]: WaitForPmt: PMT handling took 0,0468001 seconds. 2011-03-22 19:56:51.436943 [(9)]: card: Tuner locked: True 2011-03-22 19:56:51.436943 [(9)]: ************************************************** 2011-03-22 19:56:51.436943 [(9)]: ***** SIGNAL LEVEL: 49, SIGNAL QUALITY: 49 ***** 2011-03-22 19:56:51.436943 [(9)]: ************************************************** 2011-03-22 19:56:51.436943 [(9)]: card: tuned user: woka01 subchannel: 1 2011-03-22 19:56:51.436943 [(9)]: user:woka01 add 2011-03-22 19:56:51.436943 [(9)]: card2:woka01 2 1 2011-03-22 19:56:51.436943 [(9)]: Controller: woka01 2 1 2011-03-22 19:56:51.436943 [(9)]: control2:woka01 2 1 2011-03-22 19:56:51.436943 [(9)]: Controller: delete timeshift files C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live2-1.ts 2011-03-22 19:56:51.452544 [(9)]: card: StartTimeShifting 2 C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live2-1.ts 2011-03-22 19:56:51.452544 [(9)]: card: CAM enabled : True 2011-03-22 19:56:51.452544 [(9)]: subch:1 SetTimeShiftFileName:C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live2-1.ts 2011-03-22 19:56:51.452544 [(9)]: Set video / audio observer 2011-03-22 19:56:51.452544 [(9)]: subch:1 SetTimeShiftFileName fill in pids 2011-03-22 19:56:51.452544 [(9)]: subch:1-1 tswriter StartTimeshifting... 2011-03-22 19:56:51.452544 [(4)]: PID seen - type = Audio 2011-03-22 19:56:51.452544 [(4)]: audioVideoEventHandler Audio 2011-03-22 19:56:51.468144 [(9)]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo 2011-03-22 19:56:51.483744 [(4)]: PID seen - type = Video 2011-03-22 19:56:51.483744 [(4)]: audioVideoEventHandler Video 2011-03-22 19:56:51.499344 [(9)]: card: WaitForTimeShiftFile - video and audio are seen after 0,0156 seconds 2011-03-22 19:56:51.499344 [(9)]: user:woka01 card:2 sub:1 add stream:C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live2-1.ts.tsbuffer 2011-03-22 19:56:51.499344 [(9)]: RTSP: start streamer 2011-03-22 19:56:51.499344 [RTSP Streaming thread(18)]: RTSP: Streamer started 2011-03-22 19:56:51.499344 [(9)]: RTSP: add stream stream2.1 file:C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live2-1.ts.tsbuffer 2011-03-22 19:56:51.499344 [(9)]: Controller: StartTimeShifting started on card:2 to C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live2-1.ts.tsbuffer 2011-03-22 19:56:51.514944 [(9)]: CiMenuSupported called cardid 2 2011-03-22 19:56:51.546144 [(9)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:51.546144 [(9)]: FireDTV:cam is inserted 2011-03-22 19:56:51.546144 [(9)]: FireDTV:cam is valid 2011-03-22 19:56:51.546144 [(9)]: FireDTV:cam is ready 2011-03-22 19:56:51.546144 [(9)]: FireDTV:cam is able to descramble 2011-03-22 19:56:51.546144 [(9)]: CiMenuSupported card FireDTV BDA Tuner DVBC supported: True 2011-03-22 19:56:51.561744 [(9)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:56:51.561744 [(9)]: FireDTV:cam is inserted 2011-03-22 19:56:51.561744 [(9)]: FireDTV:cam is valid 2011-03-22 19:56:51.561744 [(9)]: FireDTV:cam is ready 2011-03-22 19:56:51.561744 [(9)]: FireDTV:cam is able to descramble 2011-03-22 19:56:51.561744 [(4)]: PID seen - type = Audio 2011-03-22 19:56:51.561744 [(9)]: CiMenu: registered client event for callback 2011-03-22 19:56:51.561744 [(9)]: TvController: EnableCiMenuHandler called 2011-03-22 19:56:51.561744 [(9)]: FireDTV: registering ci callbacks 2011-03-22 19:56:51.561744 [(9)]: TvController: SetCiMenuHandler: result True 2011-03-22 19:57:15.757386 [(19)]: Controller: find free card for channel RTL 4 HD 2011-03-22 19:57:15.757386 [(19)]: Controller: got 1 tuning details for RTL 4 HD 2011-03-22 19:57:15.757386 [(19)]: Controller: channel #1 DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:57:15.757386 [(19)]: Controller: card:1 type:DvbIP is disabled 2011-03-22 19:57:15.772986 [(19)]: Controller: card:2 type:DvbC is tuned to same transponder decrypting 1/4 channels 2011-03-22 19:57:15.772986 [(19)]: Controller: card:2 type:DvbC is available priority:3 #users:1 same transponder:True 2011-03-22 19:57:15.772986 [(19)]: Controller: card:3 type:RadioWebStream is disabled 2011-03-22 19:57:15.772986 [(19)]: Controller: card:4 type:DvbC is available priority:1 #users:0 same transponder:True 2011-03-22 19:57:15.772986 [(19)]: Controller: found 2 available 2011-03-22 19:57:15.772986 [(19)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 8 msec 2011-03-22 19:57:15.772986 [(19)]: Controller: TimeShiftingWouldUseCard RTL 4 HD 185 2011-03-22 19:57:15.772986 [(19)]: Controller: find free card for channel RTL 4 HD 2011-03-22 19:57:15.772986 [(19)]: Controller: got 1 tuning details for RTL 4 HD 2011-03-22 19:57:15.772986 [(19)]: Controller: channel #1 DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:57:15.772986 [(19)]: Controller: card:1 type:DvbIP is disabled 2011-03-22 19:57:15.772986 [(19)]: Controller: card:2 type:DvbC is tuned to same transponder decrypting 1/4 channels 2011-03-22 19:57:15.772986 [(19)]: Controller: card:2 type:DvbC is available priority:3 #users:1 same transponder:True 2011-03-22 19:57:15.772986 [(19)]: Controller: card:3 type:RadioWebStream is disabled 2011-03-22 19:57:15.788586 [(19)]: Controller: card:4 type:DvbC is available priority:1 #users:0 same transponder:True 2011-03-22 19:57:15.788586 [(19)]: Controller: found 2 available 2011-03-22 19:57:15.788586 [(19)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 7 msec 2011-03-22 19:57:15.788586 [(19)]: CiMenuSupported called cardid 2 2011-03-22 19:57:15.788586 [(19)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:57:15.788586 [(19)]: FireDTV:cam is inserted 2011-03-22 19:57:15.788586 [(19)]: FireDTV:cam is valid 2011-03-22 19:57:15.788586 [(19)]: FireDTV:cam is ready 2011-03-22 19:57:15.788586 [(19)]: FireDTV:cam is able to descramble 2011-03-22 19:57:15.788586 [(19)]: CiMenuSupported card FireDTV BDA Tuner DVBC supported: True 2011-03-22 19:57:15.804186 [(19)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:57:15.804186 [(19)]: FireDTV:cam is inserted 2011-03-22 19:57:15.804186 [(19)]: FireDTV:cam is valid 2011-03-22 19:57:15.804186 [(19)]: FireDTV:cam is ready 2011-03-22 19:57:15.804186 [(19)]: FireDTV:cam is able to descramble 2011-03-22 19:57:15.804186 [(19)]: CiMenu: registered client event for callback 2011-03-22 19:57:15.804186 [(19)]: TvController: EnableCiMenuHandler called 2011-03-22 19:57:15.804186 [(19)]: FireDTV: registering ci callbacks 2011-03-22 19:57:15.804186 [(19)]: TvController: SetCiMenuHandler: result True 2011-03-22 19:57:15.819786 [(19)]: Controller: StartTimeShifting RTL 4 HD 185 2011-03-22 19:57:15.819786 [(19)]: Controller: find free card for channel RTL 4 HD 2011-03-22 19:57:15.819786 [(19)]: Controller: got 1 tuning details for RTL 4 HD 2011-03-22 19:57:15.819786 [(19)]: Controller: channel #1 DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:57:15.819786 [(19)]: Controller: card:1 type:DvbIP is disabled 2011-03-22 19:57:15.819786 [(19)]: Controller: card:2 type:DvbC is tuned to same transponder decrypting 1/4 channels 2011-03-22 19:57:15.819786 [(19)]: Controller: card:2 type:DvbC is available priority:3 #users:1 same transponder:True 2011-03-22 19:57:15.819786 [(19)]: Controller: card:3 type:RadioWebStream is disabled 2011-03-22 19:57:15.819786 [(19)]: Controller: card:4 type:DvbC is available priority:1 #users:0 same transponder:True 2011-03-22 19:57:15.819786 [(19)]: Controller: found 2 available 2011-03-22 19:57:15.819786 [(19)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 10 msec 2011-03-22 19:57:15.835386 [(19)]: card: CardTune 2 RTL 4 HD woka01:2:-1 2011-03-22 19:57:15.835386 [(19)]: Controller: woka01 2 1 2011-03-22 19:57:15.835386 [(19)]: control2:woka01 2 1 2011-03-22 19:57:15.835386 [(19)]: card: StartTimeShifting 2 C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live2-1.ts 2011-03-22 19:57:15.835386 [(19)]: card: CAM enabled : True 2011-03-22 19:57:15.835386 [(19)]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo 2011-03-22 19:57:30.842613 [(19)]: card: WaitForTimeShiftFile - no audio was found after 15,0072263 seconds 2011-03-22 19:57:30.842613 [(19)]: card FireDTV BDA Tuner DVBC: StopTimeShifting user:woka01 sub:1 2011-03-22 19:57:30.842613 [(19)]: card: StopTimeShifting user:woka01 sub:1 2011-03-22 19:57:30.842613 [(19)]: card not IDLE - removing user: woka01 2011-03-22 19:57:30.842613 [(19)]: user:woka01 remove 2011-03-22 19:57:30.842613 [(19)]: subch:1-1 tswriter StopTimeshifting... 2011-03-22 19:57:30.858213 [(19)]: tvcard:FreeSubChannel: subchannels count 2 subch#1 keep graph=False 2011-03-22 19:57:30.858213 [(19)]: DVB subch:1 Decompose() 2011-03-22 19:57:30.858213 [(19)]: FreeSubChannel CA: freeing sub channel : 1 2011-03-22 19:57:30.858213 [TS_File_Cleanup(24)]: card: delete timeshift files \live2-1.ts 2011-03-22 19:57:30.858213 [(19)]: user:woka01 remove 2011-03-22 19:57:30.858213 [(19)]: Controller: Timeshifting failed, lets try next available card. 2011-03-22 19:57:30.858213 [(19)]: card: CardTune 4 RTL 4 HD woka01:4:-1 2011-03-22 19:57:30.858213 [(19)]: card: Tune 4 to RTL 4 HD 2011-03-22 19:57:30.858213 [(19)]: card: user: woka01:4:-1 tune DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:57:30.873813 [(19)]: dvbc: Tune:DVBC:tv:Ziggo RTL 4 HD Freq:356000 ONID:1000 TSID:18 SID:204 PMT:0x64 FTA:False LCN:64 SymbolRate:6875 Modulation:Mod64Qam 2011-03-22 19:57:30.873813 [(19)]: dvbc:BuildGraph 2011-03-22 19:57:30.873813 [(19)]: dvb:AddNetworkProviderFilter 2011-03-22 19:57:30.873813 [(19)]: dvb:Add Generic Network Provider 2011-03-22 19:57:30.873813 [(19)]: dvbc:CreateTuningSpace() 2011-03-22 19:57:30.889413 [(19)]: dvbc:Found correct tuningspace MediaPortal DVBC TuningSpace 2011-03-22 19:57:30.889413 [(19)]: dvb:Add MPEG2 Demultiplexer filter 2011-03-22 19:57:30.889413 [(19)]: dvb:add Inf Tee filter 2011-03-22 19:57:30.889413 [(19)]: dvb:AddAndConnectBDABoardFilters 2011-03-22 19:57:30.889413 [(19)]: dvb: find bda tuner 2011-03-22 19:57:30.905013 [(19)]: dvb: using [Tuner]: FireDTV BDA Tuner DVBC 2011-03-22 19:57:30.905013 [(19)]: dvb: Render [Network provider]->[Tuner] OK 2011-03-22 19:57:30.905013 [(19)]: dvb: Find BDA receiver 2011-03-22 19:57:30.905013 [(19)]: dvb: match Capture by Tuner device path 2011-03-22 19:57:30.905013 [(19)]: dvb: -FireDTV BDA Receiver DVBC 2011-03-22 19:57:30.905013 [(19)]: dvb: Render [Tuner]->[Capture] AOK 2011-03-22 19:57:30.905013 [(19)]: dvb: WinTv CI module not detected. 2011-03-22 19:57:30.905013 [(19)]: dvb: Render [capture]->[inftee] 2011-03-22 19:57:30.905013 [(19)]: dvb: OK 2011-03-22 19:57:30.905013 [(19)]: dvb: Render [inftee]->[demux] 2011-03-22 19:57:30.905013 [(19)]: dvb: Add Mediaportal TsWriter filter 2011-03-22 19:57:30.905013 [(19)]: dvb: Render [InfTee]->[TsWriter] 2011-03-22 19:57:30.920613 [(19)]: CAM is Default model 2011-03-22 19:57:30.920613 [(19)]: Check for KNC 2011-03-22 19:57:30.920613 [(19)]: KNC: IsKNC False 2011-03-22 19:57:30.920613 [(19)]: KNC: Disable CI 2011-03-22 19:57:30.920613 [(19)]: KNC: Disposing CI handler 2011-03-22 19:57:30.920613 [(19)]: Check for Digital Everywhere 2011-03-22 19:57:30.920613 [(19)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:57:30.920613 [(19)]: FireDTV cam detected : True 2011-03-22 19:57:30.936213 [(19)]: FireDTV cam specs : manufacturer_code=8266, application_manufacturer=8266 2011-03-22 19:57:30.936213 [(19)]: FireDTV cam name : "AlphaCrypt" 2011-03-22 19:57:30.936213 [(19)]: FireDTV driver version: 5.0 (6070-3000) x64 2011-03-22 19:57:30.951813 [(19)]: FireDTV board version : HW 01.26.02, FW 02.04.04 build 61030 2011-03-22 19:57:30.951813 [(19)]: Digital Everywhere card detected 2011-03-22 19:57:30.967413 [(19)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:57:30.967413 [(19)]: FireDTV:cam is inserted 2011-03-22 19:57:30.967413 [(19)]: FireDTV:cam is valid 2011-03-22 19:57:30.967413 [(19)]: FireDTV:cam is ready 2011-03-22 19:57:30.967413 [(19)]: FireDTV:cam is able to descramble 2011-03-22 19:57:30.967413 [(19)]: Digital Everywhere registering CI menu capabilities 2011-03-22 19:57:30.967413 [(19)]: dvb: AddTransportStreamFiltersToGraph 2011-03-22 19:57:30.967413 [(19)]: add BDA MPEG2 Transport Information Filter filter 2011-03-22 19:57:30.967413 [(19)]: pinTif:name:IB Input [3/1] Direction:Input Connected:False 2011-03-22 19:57:30.967413 [(19)]: Connect tif and mpeg2 sections and tables 2011-03-22 19:57:30.967413 [(19)]: dvb:try tif:name:001 [5/1] Direction:Output Connected:False 2011-03-22 19:57:30.967413 [(19)]: tif connected 2011-03-22 19:57:31.061013 [(19)]: dvb: GetTunerSignalStatistics() 2011-03-22 19:57:31.061013 [(19)]: dvb:GetNewSubChannel:0 #0 2011-03-22 19:57:31.061013 [(19)]: TvDvbChannel ctor new subchIndex:0 2011-03-22 19:57:31.061013 [(19)]: dvb:Submiting tunerequest Channel:RTL 4 HD subChannel:0 2011-03-22 19:57:31.061013 [(19)]: dvb:using existing subchannel:0 2011-03-22 19:57:31.061013 [(19)]: dvb:Submit tunerequest size:1 new:0 2011-03-22 19:57:31.061013 [(19)]: subch:0 OnBeforeTune 2011-03-22 19:57:31.061013 [(19)]: dvb:Submit tunerequest calling put_TuneRequest 2011-03-22 19:57:31.061013 [(19)]: dvb:Submit tunerequest done calling put_TuneRequest 2011-03-22 19:57:31.061013 [(19)]: subch:0 OnAfterTune 2011-03-22 19:57:31.061013 [(19)]: FireDTV: HW Filtering disabled. 2011-03-22 19:57:31.061013 [(19)]: FireDTV: Set H/W pid filtering is not supported 2011-03-22 19:57:31.061013 [(19)]: subch:0 OnGraphStart 2011-03-22 19:57:31.061013 [(19)]: dvb: RunGraph 2011-03-22 19:57:31.404214 [(19)]: dvb: LockedInOnSignal ok 2011-03-22 19:57:31.404214 [(19)]: subch:0 OnGraphStarted 2011-03-22 19:57:31.404214 [(19)]: subch:0 SetupPmtGrabber:pid 64 sid:CC 2011-03-22 19:57:31.404214 [(19)]: subch:0 set pmt grabber pmt:64 sid:CC 2011-03-22 19:57:31.404214 [(19)]: WaitForPMT: Waiting for PMT 64 2011-03-22 19:57:31.575814 [(25)]: subch:0 OnPMTReceived() pmt:64 ran:True dynamic:False 2011-03-22 19:57:31.575814 [(19)]: WaitForPMT: Found PMT after 0,1716003 seconds. 2011-03-22 19:57:31.575814 [(19)]: subch:0 SendPmt:CC CC FFFFFFFF 7 2011-03-22 19:57:31.575814 [(19)]: Decode pmt 2011-03-22 19:57:31.575814 [(19)]: descr1 len:6 9 4 6 4 f3 8f 2011-03-22 19:57:31.575814 [(19)]: Set descriptor data with length 7 2011-03-22 19:57:31.575814 [(19)]: subch:0 SendPMT version:7 len:89 204 2011-03-22 19:57:31.591414 [(19)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:57:31.591414 [(19)]: FireDTV:cam is inserted 2011-03-22 19:57:31.591414 [(19)]: FireDTV:cam is valid 2011-03-22 19:57:31.591414 [(19)]: FireDTV:cam is ready 2011-03-22 19:57:31.591414 [(19)]: FireDTV:cam is able to descramble 2011-03-22 19:57:31.653814 [(19)]: FireDTV cam specs : manufacturer_code=8266, application_manufacturer=8266 2011-03-22 19:57:31.653814 [(19)]: FireDTV cam name : "AlphaCrypt" 2011-03-22 19:57:31.653814 [(19)]: FireDTV: #0/1 pmt data:0x0 0x2 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x5B 0x3 0x1 0x2 0xB0 0x59 0x0 0xCC 0xCF 0x0 0x0 0xE0 0x65 0xF0 0x6 0x9 0x4 0x6 0x4 0xF3 0x8F 0x1B 0xE0 0x65 0xF0 0x3 0x11 0x1 0xFF 0x3 0xE0 0x66 0xF0 0x0 0x6 0xE0 0x72 0xF0 0x25 0x56 0x5 0x64 0x75 0x74 0x9 0x0 0x45 0x1C 0x1 0x1A 0xE7 0xE8 0xE9 0xEA 0xEB 0xEC 0xED 0xEE 0xEF 0xF0 0xF3 0xF4 0xF5 0xC7 0xC8 0xC9 0xCA 0xCB 0xCC 0xCD 0xCE 0xCF 0xD0 0xD3 0xD4 0xD5 0x6 0xE1 0xC2 0xF0 0xA 0x5 0x4 0x41 0x43 0x2D 0x33 0x6A 0x2 0x80 0x0 0x53 2011-03-22 19:57:31.685014 [(19)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:57:31.685014 [(19)]: FireDTV:cam is inserted 2011-03-22 19:57:31.685014 [(19)]: FireDTV:cam is valid 2011-03-22 19:57:31.685014 [(19)]: FireDTV:cam is ready 2011-03-22 19:57:31.685014 [(19)]: FireDTV:cam is able to descramble 2011-03-22 19:57:31.685014 [(19)]: subch:0 cam flags:True 2011-03-22 19:57:31.685014 [(19)]: subch:0 SetMpegPidMapping 2011-03-22 19:57:31.685014 [(19)]: subch:0 pid:65 pcr 2011-03-22 19:57:31.685014 [(19)]: subch:0 pid:64 pmt 2011-03-22 19:57:31.685014 [(19)]: subch:0 pid:65 video type:H.264 2011-03-22 19:57:31.685014 [(19)]: subch:0 map pid:65 video type:H.264 2011-03-22 19:57:31.685014 [(19)]: subch:0 pid:66 audio lang: type:MPEG-1 2011-03-22 19:57:31.685014 [(19)]: subch:0 map pid:66 audio lang: type:MPEG-1 2011-03-22 19:57:31.685014 [(19)]: subch:0 pid:72 teletext type:6 2011-03-22 19:57:31.685014 [(19)]: subch:0 map pid:72 teletext type:6 2011-03-22 19:57:31.685014 [(19)]: subch:0 pid:1C2 audio lang: type:AC3 2011-03-22 19:57:31.685014 [(19)]: subch:0 map pid:1C2 audio lang: type:AC3 2011-03-22 19:57:31.685014 [(19)]: FireDTV: HW Filtering disabled. 2011-03-22 19:57:31.685014 [(19)]: FireDTV: Set H/W pid filtering is not supported 2011-03-22 19:57:31.685014 [(19)]: subch:0 stop tif 2011-03-22 19:57:31.685014 [(19)]: WaitForPmt: PMT handling took 0,1092002 seconds. 2011-03-22 19:57:31.872215 [(19)]: card: Tuner locked: True 2011-03-22 19:57:31.872215 [(19)]: ************************************************** 2011-03-22 19:57:31.872215 [(19)]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 100 ***** 2011-03-22 19:57:31.872215 [(19)]: ************************************************** 2011-03-22 19:57:31.872215 [(19)]: card: tuned user: woka01 subchannel: 0 2011-03-22 19:57:31.872215 [(19)]: user:woka01 add 2011-03-22 19:57:31.872215 [(19)]: card2:woka01 4 0 2011-03-22 19:57:31.872215 [(19)]: Controller: woka01 4 0 2011-03-22 19:57:31.872215 [(19)]: control2:woka01 4 0 2011-03-22 19:57:31.872215 [(19)]: Controller: delete timeshift files C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live4-0.ts 2011-03-22 19:57:31.887815 [(19)]: card: StartTimeShifting 4 C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live4-0.ts 2011-03-22 19:57:31.887815 [(19)]: card: CAM enabled : True 2011-03-22 19:57:31.887815 [(19)]: subch:0 SetTimeShiftFileName:C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live4-0.ts 2011-03-22 19:57:31.887815 [(19)]: Set video / audio observer 2011-03-22 19:57:31.887815 [(19)]: subch:0 SetTimeShiftFileName fill in pids 2011-03-22 19:57:31.887815 [(19)]: subch:0-0 tswriter StartTimeshifting... 2011-03-22 19:57:31.887815 [(19)]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo 2011-03-22 19:57:31.903415 [(25)]: PID seen - type = Video 2011-03-22 19:57:31.903415 [(25)]: audioVideoEventHandler Video 2011-03-22 19:57:31.903415 [(25)]: PID seen - type = Audio 2011-03-22 19:57:31.919015 [(25)]: audioVideoEventHandler Audio 2011-03-22 19:57:31.919015 [(19)]: card: WaitForTimeShiftFile - video and audio are seen after 0,0312 seconds 2011-03-22 19:57:31.919015 [(19)]: user:woka01 card:4 sub:0 add stream:C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live4-0.ts.tsbuffer 2011-03-22 19:57:31.919015 [(19)]: RTSP: add stream stream4.0 file:C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live4-0.ts.tsbuffer 2011-03-22 19:57:31.919015 [(19)]: Controller: StartTimeShifting started on card:4 to C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live4-0.ts.tsbuffer 2011-03-22 19:57:31.919015 [(23)]: CiMenuSupported called cardid 4 2011-03-22 19:57:31.919015 [(23)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:57:31.919015 [(23)]: FireDTV:cam is inserted 2011-03-22 19:57:31.919015 [(23)]: FireDTV:cam is valid 2011-03-22 19:57:31.934615 [(23)]: FireDTV:cam is ready 2011-03-22 19:57:31.934615 [(23)]: FireDTV:cam is able to descramble 2011-03-22 19:57:31.934615 [(23)]: CiMenuSupported card FireDTV BDA Tuner DVBC supported: True 2011-03-22 19:57:31.934615 [(23)]: FireDTV:GetCAMStatus() finished 2011-03-22 19:57:31.934615 [(23)]: FireDTV:cam is inserted 2011-03-22 19:57:31.934615 [(23)]: FireDTV:cam is valid 2011-03-22 19:57:31.934615 [(23)]: FireDTV:cam is ready 2011-03-22 19:57:31.934615 [(23)]: FireDTV:cam is able to descramble 2011-03-22 19:57:31.934615 [(23)]: CiMenu: registered client event for callback 2011-03-22 19:57:31.934615 [(23)]: TvController: EnableCiMenuHandler called 2011-03-22 19:57:31.934615 [(23)]: FireDTV: registering ci callbacks 2011-03-22 19:57:31.934615 [(23)]: FireDTV: Starting new CI handler thread 2011-03-22 19:57:31.934615 [(23)]: TvController: SetCiMenuHandler: result True 2011-03-22 19:57:31.934615 [FireDTV CiMenuHandler(15)]: FireDTV: CI handler thread start polling status 2011-03-22 19:57:32.012615 [(25)]: PID seen - type = Audio 2011-03-22 19:57:35.881422 [TS_File_Cleanup(24)]: card: delete timeshift files \live2-1.ts 2011-03-22 19:57:40.889030 [TS_File_Cleanup(24)]: card: delete timeshift files \live2-1.ts 2011-03-22 19:57:45.896639 [TS_File_Cleanup(24)]: card: delete timeshift files \live2-1.ts 2011-03-22 19:57:50.904248 [TS_File_Cleanup(24)]: card: delete timeshift files \live2-1.ts 2011-03-22 20:40:10.853909 [scheduler thread(12)]: Scheduler: stop record RTL 4 HD 22-3-2011 19:56:24-22-3-2011 20:30:00 Goede tijden, slechte tijden 2011-03-22 20:40:10.853909 [scheduler thread(12)]: card: StopRecording card=2, user=scheduler1 2011-03-22 20:40:10.853909 [scheduler thread(12)]: card: StopRecording for card:2 2011-03-22 20:40:10.853909 [scheduler thread(12)]: tvdvbchannel.OnStopRecording subch=0, subch index=0 2011-03-22 20:40:10.853909 [scheduler thread(12)]: tvdvbchannel.OnStopRecording subch:0-0 tswriter StopRecording... 2011-03-22 20:40:10.853909 [scheduler thread(12)]: tvcard:FreeSubChannel: subchannels count 1 subch#0 keep graph=False 2011-03-22 20:40:10.853909 [scheduler thread(12)]: DVB subch:0 Decompose() 2011-03-22 20:40:10.853909 [scheduler thread(12)]: FreeSubChannel CA: freeing sub channel : 0 2011-03-22 20:40:10.853909 [scheduler thread(12)]: tvcard:FreeSubChannel : no subchannels present, stopping graph 2011-03-22 20:40:10.853909 [scheduler thread(12)]: dvb:StopGraph called 2011-03-22 20:40:10.869509 [scheduler thread(12)]: tvcard:FreeAllSubChannels 2011-03-22 20:40:10.869509 [scheduler thread(12)]: dvb:StopGraph 2011-03-22 20:40:10.885109 [scheduler thread(12)]: user:scheduler1 remove 2011-03-22 20:40:10.885109 [scheduler thread(12)]: dvb:StopGraph called 2011-03-22 20:40:10.885109 [scheduler thread(12)]: tvcard:FreeAllSubChannels 2011-03-22 20:40:10.885109 [scheduler thread(12)]: dvb:StopGraph filterstate already stopped, returning. 2011-03-22 20:40:10.947509 [scheduler thread(12)]: Scheduler: endtime=22-3-2011 20:30:00, Program.EndTime=22-3-2011 20:30:00, postRecTime=10 2011-03-22 20:40:10.947509 [scheduler thread(12)]: diskmanagement: recording Goede tijden, slechte tijden ended. type:WorkingDays max episodes:2147483647