[2015-01-02 18:06:04,561] [713801 ] [68 ] [DEBUG] - Controller: StartTimeShifting ORF1 HD 842 [2015-01-02 18:06:04,561] [713801 ] [68 ] [DEBUG] - Controller: epg stop [2015-01-02 18:06:04,561] [713801 ] [68 ] [INFO ] - Controller: find free card for channel ORF1 HD [2015-01-02 18:06:04,561] [713801 ] [68 ] [INFO ] - Controller: find card for channel ORF1 HD [2015-01-02 18:06:04,561] [713801 ] [68 ] [INFO ] - Controller: got 1 tuning details for ORF1 HD [2015-01-02 18:06:04,561] [713801 ] [68 ] [INFO ] - Controller: channel #1 DVBS:TVORF ORF1 HD Freq:11303000 ONID:1 TSID:1007 SID:4911 PMT:107 FTA:False LCN:10000 SymbolRate:22000 Modulation:Mod8Psk Polarisation:LinearH InnerFecRate:Rate2_3 DiSEqC:None band:Universal Pilot:On RollOff:ThirtyFive [2015-01-02 18:06:04,561] [713801 ] [68 ] [INFO ] - Controller: card:4 type:DvbS can tune to channel [2015-01-02 18:06:04,561] [713801 ] [68 ] [INFO ] - Controller: card:5 type:DvbS can tune to channel [2015-01-02 18:06:04,561] [713801 ] [68 ] [INFO ] - Controller: card:3 type:DvbIP cannot tune to channel [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - Controller: card:8 type:DvbIP cannot tune to channel [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - Controller: found 2 card(s) for channel [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 2 msec [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - Controller: found 2 free card(s) [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 3 msec [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=42, tuningdetails=DVBS:TVORF ORF1 HD Freq:11303000 ONID:1 TSID:1007 SID:4911 PMT:107 FTA:False LCN:10000 SymbolRate:22000 Modulation:Mod8Psk Polarisation:LinearH InnerFecRate:Rate2_3 DiSEqC:None band:Universal Pilot:On RollOff:ThirtyFive [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=43, tuningdetails=DVBS:TVORF ORF1 HD Freq:11303000 ONID:1 TSID:1007 SID:4911 PMT:107 FTA:False LCN:10000 SymbolRate:22000 Modulation:Mod8Psk Polarisation:LinearH InnerFecRate:Rate2_3 DiSEqC:None band:Universal Pilot:On RollOff:ThirtyFive [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - Controller: card:4 type:DvbS users: 0 [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - Controller: card:4 type:DvbS is available [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - Controller: card:5 type:DvbS users: 0 [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - Controller: card:5 type:DvbS is available [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - Controller: try max 2 of 2 cards for timeshifting [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - TvServerEventDispatcher.DoOnTvServerEventAsynch : tvserver event received but no users found... [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - CardReservationBase: tvcard=4, user=setuptv, dbChannel=842, ticket=42, tunestate=Tuning, stopstate=Idle [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - card: CardTune 4 ORF1 HD setuptv:4:-1 [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - card: Tune on card 4 to subchannel ORF1 HD [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - card: user: setuptv:4:-1 tune DVBS:TVORF ORF1 HD Freq:11303000 ONID:1 TSID:1007 SID:4911 PMT:107 FTA:False LCN:10000 SymbolRate:22000 Modulation:Mod8Psk Polarisation:LinearH InnerFecRate:Rate2_3 DiSEqC:None band:Universal Pilot:On RollOff:ThirtyFive [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - card: to different transponder [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - TimeShifter.OnBeforeTune: resetting audio/video events [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - tuner base: tune channel, DVBS:TVORF ORF1 HD Freq:11303000 ONID:1 TSID:1007 SID:4911 PMT:107 FTA:False LCN:10000 SymbolRate:22000 Modulation:Mod8Psk Polarisation:LinearH InnerFecRate:Rate2_3 DiSEqC:None band:Universal Pilot:On RollOff:ThirtyFive [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - MPEG 2 sub-channel: reload configuration [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - sub-channel base: reload configuration [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - MPEG 2 sub-channel: new sub-channel 0 index 0 [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - card: AddTuneEvent card: 4 / subch: 0 [2015-01-02 18:06:04,577] [713816 ] [68 ] [INFO ] - tuner base: creating new sub-channel, ID = 0, count = 1 [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - subch:0 OnBeforeTune [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - DvbsChannel: LNB settings, low = 9750000 kHz, high = 10600000 kHz, switch = 11700000 kHz, bandstacked = False, toroidal = False, polarisation = LinearH [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - DvbsChannel: translated LNB settings, low = 9750000 kHz, high = 10600000 kHz, switch = 11700000 kHz, polarisation = LinearH [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - Microsoft BDA DiSEqC: on before tune call back [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - modulation = ModNbc8Psk [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - DiSEqC: switch to channel [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - DiSEqC: power on [2015-01-02 18:06:04,577] [713816 ] [68 ] [DEBUG] - Digital Devices: send DiSEqC command [2015-01-02 18:06:04,593] [713832 ] [68 ] [ERROR] - Digital Devices: failed to send DiSEqC command, hr = 0x800700aa [2015-01-02 18:06:04,593] [713832 ] [68 ] [DEBUG] - Digital Devices: result = False [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - DiSEqC: no need to send switch command [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - DiSEqC: no need to send positioner command [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - BDA base: perform tuning, standard BDA tuning [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - BDA base: apply tuning parameters [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - BDA base: parameters applied, hr = 0x0 [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - subch:0 OnAfterTune [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - tuner base: perform tuner action, action = Start [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - tuner base: set tuner state, current state = Stopped, requested state = Started [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - DirectShow base: perform set tuner state [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - tuner base: action succeeded [2015-01-02 18:06:04,702] [713941 ] [68 ] [DEBUG] - tuner base: lock in on signal [2015-01-02 18:06:05,435] [714674 ] [68 ] [DEBUG] - tuner base: locked [2015-01-02 18:06:05,435] [714674 ] [68 ] [DEBUG] - Mpeg2TunerController: configure PID filter, mode = Auto [2015-01-02 18:06:05,435] [714674 ] [68 ] [DEBUG] - MPEG 2 sub-channel: sub-channel 0 OnGraphRunning() [2015-01-02 18:06:05,435] [714674 ] [68 ] [DEBUG] - MPEG 2 sub-channel: sub-channel 0 wait for PMT, service ID = 4911, PMT PID = 107 [2015-01-02 18:06:05,435] [714674 ] [68 ] [DEBUG] - MPEG 2 sub-channel: configure PMT grabber, PMT PID = 107 [2015-01-02 18:06:05,435] [714674 ] [68 ] [DEBUG] - TimeShifter.OnAfterTune: resetting audio/video time [2015-01-02 18:06:05,872] [715111 ] [41 ] [DEBUG] - MPEG 2 sub-channel: sub-channel 0 OnPmtReceived(), PMT PID = 107, service ID = 4911, is service running = True, dynamic = False [2015-01-02 18:06:05,872] [715111 ] [68 ] [DEBUG] - MPEG 2 sub-channel: found PMT after 0.4368007 seconds [2015-01-02 18:06:05,872] [715111 ] [68 ] [DEBUG] - MPEG 2 sub-channel: sub-channel 0 handle PMT [2015-01-02 18:06:05,872] [715111 ] [68 ] [DEBUG] - PMT: decode [2015-01-02 18:06:05,872] [715111 ] [68 ] [DEBUG] - MPEG 2 sub-channel: service ID = 4911, PMT PID = 107, version = 3 [2015-01-02 18:06:05,872] [715111 ] [68 ] [DEBUG] - MPEG 2 sub-channel: new PMT version [2015-01-02 18:06:05,872] [715111 ] [68 ] [DEBUG] - MPEG 2 sub-channel: sub-channel 0 grab CAT [2015-01-02 18:06:07,962] [717202 ] [PS StandbyWakeup] [DEBUG] - PS: StandbyWakeupThread triggered by check interval [2015-01-02 18:06:08,009] [717248 ] [PS StandbyWakeup] [DEBUG] - PS: LoadSettings() [2015-01-02 18:06:08,009] [717248 ] [PS StandbyWakeup] [DEBUG] - PS: SetWakeupTimer() [2015-01-02 18:06:08,009] [717248 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting PowerController: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Scheduled Recordings: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting XmlTvImport: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: No pending events found in the future which should wakeup the system [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: CheckForStandby() [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting PowerController: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Remote Client: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Active Streams: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting TV Controller: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Processes (chrome, SetupTV, MP client inactive): StandbyPrevented [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Active Network: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Active Shares: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Ping Monitor: [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: SetStandbyMode(StandbyPrevented) [2015-01-02 18:06:08,025] [717264 ] [PS StandbyWakeup] [DEBUG] - PS: System is busy and should not go to standby [2015-01-02 18:06:08,867] [718106 ] [41 ] [DEBUG] - MPEG 2 sub-channel: sub-channel 0 OnCaReceived() [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - MPEG 2 sub-channel: CAT found after 2.9952053 seconds [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - CAT: decode [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - MPEG 2 sub-channel: sub-channel 0 build PID list [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Mpeg2TunerController: configure PID filter, mode = Auto [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Mpeg2TunerController: sub-channel 0 update decrypt list, mode = List, update action = Add [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Mpeg2TunerController: assembling service list [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Mpeg2TunerController: CA provider Digital Devices... [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Digital Devices: is conditional access interface ready [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Digital Devices: result = True [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Mpeg2TunerController: sending command(s) [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - command = OkDescrambling, action = Only, service = ORF1 HD [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Digital Devices: send conditional access command, list action = Only, command = OkDescrambling [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Digital Devices: program number = 4911, provider = ORF [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - slot 1, CryptoWorks... [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - provider supported, MTD already active [2015-01-02 18:06:08,867] [718106 ] [68 ] [ERROR] - Digital Devices: failed to send conditional access command, no slots available [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Mpeg2TunerController: attempt 2... [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Mpeg2TunerController: CA provider Digital Devices... [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Digital Devices: is conditional access interface ready [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Digital Devices: result = True [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Mpeg2TunerController: sending command(s) [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - command = OkDescrambling, action = Only, service = ORF1 HD [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Digital Devices: send conditional access command, list action = Only, command = OkDescrambling [2015-01-02 18:06:08,867] [718106 ] [68 ] [DEBUG] - Digital Devices: program number = 4911, provider = ORF [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - slot 1, CryptoWorks... [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - provider supported, MTD already active [2015-01-02 18:06:08,883] [718122 ] [68 ] [ERROR] - Digital Devices: failed to send conditional access command, no slots available [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - Mpeg2TunerController: attempt 3... [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - Mpeg2TunerController: CA provider Digital Devices... [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - Digital Devices: is conditional access interface ready [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - Digital Devices: result = True [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - Mpeg2TunerController: sending command(s) [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - command = OkDescrambling, action = Only, service = ORF1 HD [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - Digital Devices: send conditional access command, list action = Only, command = OkDescrambling [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - Digital Devices: program number = 4911, provider = ORF [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - slot 1, CryptoWorks... [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - provider supported, MTD already active [2015-01-02 18:06:08,883] [718122 ] [68 ] [ERROR] - Digital Devices: failed to send conditional access command, no slots available [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - card: Tuner locked: True [2015-01-02 18:06:08,883] [718122 ] [68 ] [INFO ] - ************************************************** [2015-01-02 18:06:08,883] [718122 ] [68 ] [INFO ] - ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 100 ***** [2015-01-02 18:06:08,883] [718122 ] [68 ] [INFO ] - ************************************************** [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - card: tuned user: setuptv subchannel: 0 [2015-01-02 18:06:08,883] [718122 ] [68 ] [INFO ] - user:setuptv AddSubChannelOrUser [2015-01-02 18:06:08,883] [718122 ] [68 ] [INFO ] - card2:setuptv 4 0 [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - Controller: delete timeshift files R:\TIMESHIFT\live4-0.ts [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - TvServerEventDispatcher.DoOnTvServerEventAsynch : tvserver event received but no users found... [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - Controller: epg stop [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - card: StartTimeShifting 4 R:\TIMESHIFT\live4-0.ts [2015-01-02 18:06:08,883] [718122 ] [PS StandbyWakeup] [DEBUG] - PS: StandbyWakeupThread triggered by event [2015-01-02 18:06:08,883] [718122 ] [68 ] [DEBUG] - card: CAM enabled : True [2015-01-02 18:06:08,945] [718184 ] [68 ] [DEBUG] - sub-channel base: sub-channel 0 start timeshifting to R:\TIMESHIFT\live4-0.ts [2015-01-02 18:06:08,929] [718169 ] [PS StandbyWakeup] [DEBUG] - PS: LoadSettings() [2015-01-02 18:06:08,945] [718184 ] [68 ] [DEBUG] - subch:0 SetTimeShiftFileName:R:\TIMESHIFT\live4-0.ts [2015-01-02 18:06:08,945] [718184 ] [68 ] [DEBUG] - Set video / audio observer [2015-01-02 18:06:08,945] [718184 ] [68 ] [DEBUG] - subch:0 SetTimeShiftFileName fill in pids [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: SetWakeupTimer() [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting PowerController: [2015-01-02 18:06:08,945] [718184 ] [68 ] [DEBUG] - subch:0-0 tswriter StartTimeshifting... [2015-01-02 18:06:08,945] [718184 ] [68 ] [DEBUG] - card: WaitForFile - waiting _eventAudio & _eventVideo [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Scheduled Recordings: [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting XmlTvImport: [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: No pending events found in the future which should wakeup the system [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: CheckForStandby() [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting PowerController: [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Remote Client: [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Active Streams: [2015-01-02 18:06:08,945] [718184 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting TV Controller (Remote timeshifting): AwayModeRequested [2015-01-02 18:06:08,961] [718200 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Processes (chrome, SetupTV, MP client inactive): StandbyPrevented [2015-01-02 18:06:08,961] [718200 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Active Network: [2015-01-02 18:06:08,961] [718200 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Active Shares: [2015-01-02 18:06:08,961] [718200 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Ping Monitor: [2015-01-02 18:06:08,961] [718200 ] [PS StandbyWakeup] [DEBUG] - PS: SetStandbyMode(AwayModeRequested) [2015-01-02 18:06:08,961] [718200 ] [PS StandbyWakeup] [DEBUG] - PS: System is busy and should not go to standby [2015-01-02 18:06:08,961] [718200 ] [41 ] [DEBUG] - PID seen - type = Video [2015-01-02 18:06:08,961] [718200 ] [41 ] [INFO ] - audioVideoEventHandler Video [2015-01-02 18:06:09,007] [718247 ] [41 ] [DEBUG] - PID seen - type = Audio [2015-01-02 18:06:09,007] [718247 ] [41 ] [INFO ] - audioVideoEventHandler Audio [2015-01-02 18:06:09,007] [718247 ] [68 ] [DEBUG] - card: WaitForFile - video and audio are seen after 0.0624002 seconds [2015-01-02 18:06:09,007] [718247 ] [68 ] [INFO ] - user:setuptv card:4 sub:0 add stream:R:\TIMESHIFT\live4-0.ts.tsbuffer [2015-01-02 18:06:09,007] [718247 ] [68 ] [DEBUG] - Controller: StartTimeShifting started on card:4 to R:\TIMESHIFT\live4-0.ts.tsbuffer [2015-01-02 18:06:09,007] [718247 ] [68 ] [DEBUG] - CardReservation.RemoveTuneTicket: removed reservation with id=42, tuningdetails=DVBS:TVORF ORF1 HD Freq:11303000 ONID:1 TSID:1007 SID:4911 PMT:107 FTA:False LCN:10000 SymbolRate:22000 Modulation:Mod8Psk Polarisation:LinearH InnerFecRate:Rate2_3 DiSEqC:None band:Universal Pilot:On RollOff:ThirtyFive [2015-01-02 18:06:09,007] [718247 ] [68 ] [INFO ] - card: SignalTuneEvent card: 4 / subch: 0 [2015-01-02 18:06:09,007] [718247 ] [68 ] [INFO ] - Controller: setuptv 4 0 [2015-01-02 18:06:09,007] [718247 ] [68 ] [DEBUG] - TvServerEventDispatcher.DoOnTvServerEventAsynch : tvserver event received but no users found... [2015-01-02 18:06:09,007] [718247 ] [68 ] [DEBUG] - CardReservation.CancelCardReservation id=43 [2015-01-02 18:06:09,007] [718247 ] [68 ] [INFO ] - control2:setuptv 4 0 [2015-01-02 18:06:09,007] [718247 ] [56 ] [DEBUG] - Controller: DoSetChannelStatesForAllUsers for 42 channels [2015-01-02 18:06:09,007] [718247 ] [56 ] [INFO ] - ChannelStates.GetAllTimeshiftingAndRecordingChannels took 0 msec [2015-01-02 18:06:09,007] [718247 ] [56 ] [INFO ] - ChannelStates.DoSetChannelStatesForAllUsers took 1 msec [2015-01-02 18:06:09,007] [718247 ] [56 ] [DEBUG] - DoSetChannelStatesForAllUsers OnChannelStatesSet user=setuptv [2015-01-02 18:06:09,023] [718262 ] [56 ] [DEBUG] - TvServerEventDispatcher.DoOnTvServerEventAsynch : tvserver event received but no users found... [2015-01-02 18:06:09,023] [718262 ] [5 ] [DEBUG] - Controller: DoSetChannelStatesForAllUsers for 42 channels [2015-01-02 18:06:09,023] [718262 ] [5 ] [INFO ] - ChannelStates.GetAllTimeshiftingAndRecordingChannels took 0 msec [2015-01-02 18:06:09,023] [718262 ] [5 ] [INFO ] - ChannelStates.DoSetChannelStatesForAllUsers took 1 msec [2015-01-02 18:06:09,023] [718262 ] [5 ] [DEBUG] - DoSetChannelStatesForAllUsers OnChannelStatesSet user=idle [2015-01-02 18:06:09,023] [718262 ] [5 ] [DEBUG] - TvServerEventDispatcher.DoOnTvServerEventAsynch : tvserver event received but no users found... [2015-01-02 18:06:09,023] [718262 ] [5 ] [DEBUG] - SetChannelStatesForUser OnChannelStatesSet user=idle [2015-01-02 18:06:09,023] [718262 ] [5 ] [DEBUG] - TvServerEventDispatcher.DoOnTvServerEventAsynch : tvserver event received but no users found... [2015-01-02 18:06:09,023] [718262 ] [41 ] [DEBUG] - PID seen - type = Audio [2015-01-02 18:06:09,023] [718262 ] [41 ] [INFO ] - audio last seen at 01/02/2015 18:06:09 [2015-01-02 18:06:23,968] [733207 ] [PS StandbyWakeup] [DEBUG] - PS: StandbyWakeupThread triggered by check interval [2015-01-02 18:06:24,015] [733254 ] [PS StandbyWakeup] [DEBUG] - PS: LoadSettings() [2015-01-02 18:06:24,015] [733254 ] [PS StandbyWakeup] [DEBUG] - PS: SetWakeupTimer() [2015-01-02 18:06:24,015] [733254 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting PowerController: [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Scheduled Recordings: [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting XmlTvImport: [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: No pending events found in the future which should wakeup the system [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: CheckForStandby() [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting PowerController: [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Remote Client: [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Active Streams: [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting TV Controller (Remote timeshifting): AwayModeRequested [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Processes (chrome, SetupTV, MP client inactive): StandbyPrevented [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Active Network: [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Active Shares: [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Ping Monitor: [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: SetStandbyMode(AwayModeRequested) [2015-01-02 18:06:24,030] [733270 ] [PS StandbyWakeup] [DEBUG] - PS: System is busy and should not go to standby [2015-01-02 18:06:33,043] [742283 ] [41 ] [INFO ] - OnLinkageReceived() [2015-01-02 18:06:33,044] [742284 ] [Channel linkage update thread] [INFO ] - ChannelLinkage received. 0 portal channels read