2013-09-19 21:45:21.682024 [(30)]: Controller: find free card for channel NFL
2013-09-19 21:45:21.682024 [(30)]: Controller: find card for channel NFL
2013-09-19 21:45:21.684024 [(30)]: Controller:   got 1 tuning details for NFL
2013-09-19 21:45:21.684024 [(30)]: Controller:   channel #1 tv:NFL Freq:57000000 Channel:57 Country:Antigua And Barbuda Tuner:Cable Video:Tuner Audio:Tuner 
2013-09-19 21:45:21.684024 [(30)]: Controller:    card:1 type:DvbIP cannot tune to channel
2013-09-19 21:45:21.685024 [(30)]: Controller:    card:3 type:RadioWebStream cannot tune to channel
2013-09-19 21:45:21.686024 [(30)]: Controller:    card:5 type:Analog can tune to channel
2013-09-19 21:45:21.687024 [(30)]: Controller:    card:5 type:Analog users: 0
2013-09-19 21:45:21.687024 [(30)]: Controller:    card:6 type:Analog can tune to channel
2013-09-19 21:45:21.688024 [(30)]: Controller:    card:6 type:Analog users: 0
2013-09-19 21:45:21.688024 [(30)]: Controller:    card:7 type:Analog can tune to channel
2013-09-19 21:45:21.689024 [(30)]: Controller:    card:7 type:Analog users: 0
2013-09-19 21:45:21.689024 [(30)]: Controller:    card:8 type:Atsc is disabled
2013-09-19 21:45:21.689024 [(30)]: Controller:    card:9 type:Atsc is disabled
2013-09-19 21:45:21.690024 [(30)]: Controller:    card:10 type:Analog is disabled
2013-09-19 21:45:21.690024 [(30)]: Controller:    card:11 type:Analog is disabled
2013-09-19 21:45:21.690024 [(30)]: Controller: found 3 card(s) for channel
2013-09-19 21:45:21.691025 [(30)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 8 msec
2013-09-19 21:45:21.691025 [(30)]: Controller:    card:5 type:Analog is available
2013-09-19 21:45:21.692025 [(30)]: Controller:    card:6 type:Analog is available
2013-09-19 21:45:21.692025 [(30)]: Controller:    card:7 type:Analog is available
2013-09-19 21:45:21.692025 [(30)]: Controller: found 3 free card(s)
2013-09-19 21:45:21.693025 [(30)]: AdvancedCardAllocation.GetFreeCardsForChannel took 11 msec
2013-09-19 21:45:21.701025 [(30)]: Controller: TimeShiftingWouldUseCard NFL 51
2013-09-19 21:45:21.701025 [(30)]: Controller: find free card for channel NFL
2013-09-19 21:45:21.702025 [(30)]: Controller: find card for channel NFL
2013-09-19 21:45:21.703025 [(30)]: Controller:   got 1 tuning details for NFL
2013-09-19 21:45:21.703025 [(30)]: Controller:   channel #1 tv:NFL Freq:57000000 Channel:57 Country:Antigua And Barbuda Tuner:Cable Video:Tuner Audio:Tuner 
2013-09-19 21:45:21.704025 [(30)]: Controller:    card:1 type:DvbIP cannot tune to channel
2013-09-19 21:45:21.704025 [(30)]: Controller:    card:3 type:RadioWebStream cannot tune to channel
2013-09-19 21:45:21.705025 [(30)]: Controller:    card:5 type:Analog can tune to channel
2013-09-19 21:45:21.705025 [(30)]: Controller:    card:5 type:Analog users: 0
2013-09-19 21:45:21.707025 [(30)]: Controller:    card:6 type:Analog can tune to channel
2013-09-19 21:45:21.707025 [(30)]: Controller:    card:6 type:Analog users: 0
2013-09-19 21:45:21.708026 [(30)]: Controller:    card:7 type:Analog can tune to channel
2013-09-19 21:45:21.708026 [(30)]: Controller:    card:7 type:Analog users: 0
2013-09-19 21:45:21.708026 [(30)]: Controller:    card:8 type:Atsc is disabled
2013-09-19 21:45:21.709026 [(30)]: Controller:    card:9 type:Atsc is disabled
2013-09-19 21:45:21.709026 [(30)]: Controller:    card:10 type:Analog is disabled
2013-09-19 21:45:21.710026 [(30)]: Controller:    card:11 type:Analog is disabled
2013-09-19 21:45:21.710026 [(30)]: Controller: found 3 card(s) for channel
2013-09-19 21:45:21.711026 [(30)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 8 msec
2013-09-19 21:45:21.711026 [(30)]: Controller:    card:5 type:Analog is available
2013-09-19 21:45:21.711026 [(30)]: Controller:    card:6 type:Analog is available
2013-09-19 21:45:21.712026 [(30)]: Controller:    card:7 type:Analog is available
2013-09-19 21:45:21.712026 [(30)]: Controller: found 3 free card(s)
2013-09-19 21:45:21.712026 [(30)]: AdvancedCardAllocation.GetFreeCardsForChannel took 10 msec
2013-09-19 21:45:21.727027 [(30)]: CiMenuSupported called cardid 5
2013-09-19 21:45:21.728027 [(30)]: CiMenuSupported card Hauppauge HD PVR Crossbar supported: False
2013-09-19 21:45:21.742027 [(30)]: Controller: StartTimeShifting NFL 51
2013-09-19 21:45:21.743028 [(30)]: Controller: epg stop
2013-09-19 21:45:21.743028 [(30)]: Controller: find free card for channel NFL
2013-09-19 21:45:21.744028 [(30)]: Controller: find card for channel NFL
2013-09-19 21:45:21.745028 [(30)]: Controller:   got 1 tuning details for NFL
2013-09-19 21:45:21.745028 [(30)]: Controller:   channel #1 tv:NFL Freq:57000000 Channel:57 Country:Antigua And Barbuda Tuner:Cable Video:Tuner Audio:Tuner 
2013-09-19 21:45:21.745028 [(30)]: Controller:    card:1 type:DvbIP cannot tune to channel
2013-09-19 21:45:21.746028 [(30)]: Controller:    card:3 type:RadioWebStream cannot tune to channel
2013-09-19 21:45:21.747028 [(30)]: Controller:    card:5 type:Analog can tune to channel
2013-09-19 21:45:21.748028 [(30)]: Controller:    card:6 type:Analog can tune to channel
2013-09-19 21:45:21.749028 [(30)]: Controller:    card:7 type:Analog can tune to channel
2013-09-19 21:45:21.749028 [(30)]: Controller:    card:8 type:Atsc is disabled
2013-09-19 21:45:21.749028 [(30)]: Controller:    card:9 type:Atsc is disabled
2013-09-19 21:45:21.750028 [(30)]: Controller:    card:10 type:Analog is disabled
2013-09-19 21:45:21.750028 [(30)]: Controller:    card:11 type:Analog is disabled
2013-09-19 21:45:21.750028 [(30)]: Controller: found 3 card(s) for channel
2013-09-19 21:45:21.750028 [(30)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 6 msec
2013-09-19 21:45:21.751028 [(30)]: Controller: found 3 free card(s)
2013-09-19 21:45:21.751028 [(30)]: AdvancedCardAllocation.GetFreeCardsForChannel took 7 msec
2013-09-19 21:45:21.753028 [(30)]: CardReservationBase.RequestCardTuneReservation: placed reservation with id=27, tuningdetails=tv:NFL Freq:57000000 Channel:57 Country:Antigua And Barbuda Tuner:Cable Video:Tuner Audio:Tuner
2013-09-19 21:45:21.754028 [(30)]: CardReservationBase.RequestCardTuneReservation: placed reservation with id=28, tuningdetails=tv:NFL Freq:57000000 Channel:57 Country:Antigua And Barbuda Tuner:Cable Video:Tuner Audio:Tuner
2013-09-19 21:45:21.754028 [(30)]: CardReservationBase.RequestCardTuneReservation: placed reservation with id=29, tuningdetails=tv:NFL Freq:57000000 Channel:57 Country:Antigua And Barbuda Tuner:Cable Video:Tuner Audio:Tuner
2013-09-19 21:45:21.755028 [(30)]: Controller:    card:5 type:Analog users: 0
2013-09-19 21:45:21.755028 [(30)]: Controller:    card:5 type:Analog is available
2013-09-19 21:45:21.756028 [(30)]: Controller:    card:6 type:Analog users: 0
2013-09-19 21:45:21.756028 [(30)]: Controller:    card:6 type:Analog is available
2013-09-19 21:45:21.756028 [(30)]: Controller:    card:7 type:Analog users: 0
2013-09-19 21:45:21.757028 [(30)]: Controller:    card:7 type:Analog is available
2013-09-19 21:45:21.757028 [(30)]: CancelCardReservationsExceedingMaxConcurrentTickets: removing exceeding nr of tickets, only 2 allowed at a time but found 3
2013-09-19 21:45:21.757028 [(30)]: CardReservation.CancelCardReservation id=29
2013-09-19 21:45:21.760028 [(30)]: Controller: try max 3 of 3 cards for timeshifting
2013-09-19 21:45:21.762029 [(30)]: TV3BlasterPlugin: Received TV Server Event "StartZapChannel"
2013-09-19 21:45:21.762029 [(30)]: TV3BlasterPlugin: Analog channel input source "Tuner"
2013-09-19 21:45:21.763029 [(30)]: TV3BlasterPlugin: Tune request - Card: 5, Channel: 57, NFL
2013-09-19 21:45:21.764029 [ProcessExternalChannel(29)]: TV3BlasterPlugin: ProcessExternalCommand("Blast: moto 5|Port 3", 5, 57)
2013-09-19 21:45:21.764029 [ProcessExternalChannel(29)]: TV3BlasterPlugin - BlastIR(): C:\ProgramData\IR Server Suite\IR Commands\moto 5.IR, Port 3
2013-09-19 21:45:21.765029 [(30)]: CardReservationBase: tvcard=5, user=office, dbChannel=51, ticket=27, tunestate=Tuning, stopstate=Idle
2013-09-19 21:45:22.067046 [GenericPCQueue(14)]: TV3BlasterPlugin: Received Message "BlastIR"
2013-09-19 21:45:22.067046 [GenericPCQueue(14)]: TV3BlasterPlugin: Blast successful
2013-09-19 21:45:22.100048 [(30)]: card: CardTune 5 NFL office:5:-1
2013-09-19 21:45:22.101048 [(30)]: card: Tune on card 5 to subchannel NFL
2013-09-19 21:45:22.101048 [(30)]: card: user: office:5:-1 tune tv:NFL Freq:57000000 Channel:57 Country:Antigua And Barbuda Tuner:Cable Video:Tuner Audio:Tuner
2013-09-19 21:45:22.105048 [(30)]: TimeShifter.OnBeforeTune: resetting audio/video events
2013-09-19 21:45:22.105048 [(30)]: HDPVR: Tune:-1, tv:NFL Freq:57000000 Channel:57 Country:Antigua And Barbuda Tuner:Cable Video:Tuner Audio:Tuner
2013-09-19 21:45:22.106048 [(30)]: HDPVR: GetNewSubChannel:0 #0
2013-09-19 21:45:22.108048 [(30)]: subch:0 OnBeforeTune
2013-09-19 21:45:22.108048 [(30)]: HDPVR: Tune
2013-09-19 21:45:22.108048 [(30)]: HDPVR: Tuned to channel NFL
2013-09-19 21:45:22.109048 [(30)]: subch:0 OnAfterTune
2013-09-19 21:45:22.109048 [(30)]: subch:0 OnGraphStart
2013-09-19 21:45:22.109048 [(30)]: HDPVR: RunGraph
2013-09-19 21:45:22.254057 [(30)]: HDPVR: Graph running
2013-09-19 21:45:22.255057 [(30)]: subch:0 OnGraphStarted
2013-09-19 21:45:22.255057 [(30)]: subch:0 SetupPmtGrabber:pid 100 sid:1
2013-09-19 21:45:22.256057 [(30)]: subch:0 set pmt grabber pmt:100 sid:1
2013-09-19 21:45:22.257057 [(30)]: TimeShifter.OnAfterTune: resetting audio/video time
2013-09-19 21:45:22.264057 [ProcessExternalChannel(29)]: TV3BlasterPlugin: ProcessExternalCommand("Blast: motor 7|Port 3", 7, 57)
2013-09-19 21:45:22.264057 [ProcessExternalChannel(29)]: TV3BlasterPlugin - BlastIR(): C:\ProgramData\IR Server Suite\IR Commands\motor 7.IR, Port 3
2013-09-19 21:45:22.626078 [GenericPCQueue(14)]: TV3BlasterPlugin: Received Message "BlastIR"
2013-09-19 21:45:22.626078 [GenericPCQueue(14)]: TV3BlasterPlugin: Blast successful
2013-09-19 21:45:22.716083 [(3)]: HDPVR: OnPMTReceived() subch:0 pid 0x100
2013-09-19 21:45:22.716083 [(30)]: HDPVR: found PMT after 0.4590262 seconds
2013-09-19 21:45:22.716083 [(30)]: HDPVR: PMT sid=0x1 pid=0x100 version=0x0
2013-09-19 21:45:22.717083 [(30)]: Decode pmt
2013-09-19 21:45:22.717083 [(30)]: subch:0 SetMpegPidMapping
2013-09-19 21:45:22.717083 [(30)]: subch:0  pid:1001 pcr
2013-09-19 21:45:22.718083 [(30)]: subch:0  pid:100 pmt
2013-09-19 21:45:22.718083 [(30)]: subch:0  pid:1011 video type:H.264
2013-09-19 21:45:22.718083 [(30)]: subch:0    map pid:1011 video type:H.264
2013-09-19 21:45:22.719083 [(30)]: subch:0  pid:1100 audio lang: type:AC3
2013-09-19 21:45:22.719083 [(30)]: subch:0    map pid:1100 audio lang: type:AC3
2013-09-19 21:45:22.720083 [(30)]: card: Tuner locked: True
2013-09-19 21:45:22.720083 [(30)]: **************************************************
2013-09-19 21:45:22.720083 [(30)]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 100 *****
2013-09-19 21:45:22.721083 [(30)]: **************************************************
2013-09-19 21:45:22.721083 [(30)]: card: tuned user: office subchannel: 0
2013-09-19 21:45:22.721083 [(30)]: user:office add
2013-09-19 21:45:22.722084 [(30)]: card2:office 5 0
2013-09-19 21:45:22.723084 [(30)]: Controller: delete timeshift files C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live5-0.ts
2013-09-19 21:45:22.725084 [(30)]: TV3BlasterPlugin: Received TV Server Event "StartTimeShifting"
2013-09-19 21:45:22.725084 [(30)]: Controller: epg stop
2013-09-19 21:45:22.727084 [(30)]: card: StartTimeShifting 5 C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live5-0.ts 
2013-09-19 21:45:22.728084 [(30)]: card: CAM enabled : False
2013-09-19 21:45:22.728084 [(30)]: analog: Encoder mode setting to ConstantBitRate
2013-09-19 21:45:22.729084 [(30)]: analog: Encoder mode set to ConstantBitRate
2013-09-19 21:45:22.729084 [(30)]: analog: Encoder BitRate setting to Default
2013-09-19 21:45:22.730084 [(30)]: analog: Encoder BitRate Min 200000 Max 13500000 Delta 100000
2013-09-19 21:45:22.730084 [(30)]: analog: Encoder BitRate set to 9000000
2013-09-19 21:45:22.731084 [(30)]: subch:0 SetTimeShiftFileName:C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live5-0.ts
2013-09-19 21:45:22.731084 [(30)]: Set video / audio observer
2013-09-19 21:45:22.733084 [(30)]: subch:0 SetTimeShiftFileName fill in pids
2013-09-19 21:45:22.735084 [(30)]: subch:0-0 tswriter StartTimeshifting...
2013-09-19 21:45:22.736084 [(30)]: card: WaitForFile - waiting _eventAudio & _eventVideo
2013-09-19 21:45:22.737084 [(3)]: PID seen - type = Video
2013-09-19 21:45:22.738084 [(3)]: audioVideoEventHandler Video
2013-09-19 21:45:22.764086 [ProcessExternalChannel(29)]: TV3BlasterPlugin: ProcessExternalCommand("Blast: moto enter|Port 3", -1, 57)
2013-09-19 21:45:22.764086 [ProcessExternalChannel(29)]: TV3BlasterPlugin - BlastIR(): C:\ProgramData\IR Server Suite\IR Commands\moto enter.IR, Port 3
2013-09-19 21:45:22.765086 [(3)]: PID seen - type = Audio
2013-09-19 21:45:22.765086 [(3)]: audioVideoEventHandler Audio
2013-09-19 21:45:22.766086 [(30)]: card: WaitForFile - video and audio are seen after 0.0300017 seconds
2013-09-19 21:45:22.770086 [(30)]: user:office card:5 sub:0 add stream:C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live5-0.ts.tsbuffer
2013-09-19 21:45:22.771086 [(30)]: RTSP: start streamer
2013-09-19 21:45:22.771086 [RTSP Streaming thread(10)]: RTSP: Streamer started
2013-09-19 21:45:22.772086 [(30)]: RTSP: add stream stream5.0 file:C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live5-0.ts.tsbuffer
2013-09-19 21:45:22.773086 [(30)]: Controller: StartTimeShifting started on card:5 to C:\ProgramData\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live5-0.ts.tsbuffer
2013-09-19 21:45:22.773086 [(30)]: CardReservation.RemoveTuneTicket: removed reservation with id=27, tuningdetails=tv:NFL Freq:57000000 Channel:57 Country:Antigua And Barbuda Tuner:Cable Video:Tuner Audio:Tuner
2013-09-19 21:45:22.774086 [(30)]: Controller: office 5 0
2013-09-19 21:45:22.774086 [(30)]: TV3BlasterPlugin: Received TV Server Event "EndZapChannel"
2013-09-19 21:45:22.774086 [(30)]: CardReservation.CancelCardReservation id=28
2013-09-19 21:45:22.775087 [(30)]: control2:office 5 0
2013-09-19 21:45:22.812089 [Channel state thread(16)]: Controller: DoSetChannelStates for 170 channels
2013-09-19 21:45:22.817089 [(30)]: CiMenuSupported called cardid 5
2013-09-19 21:45:22.818089 [(30)]: CiMenuSupported card Hauppauge HD PVR Crossbar supported: False
2013-09-19 21:45:22.818089 [Channel state thread(16)]: ChannelStates.GetAllTimeshiftingAndRecordingChannels took 1 msec
2013-09-19 21:45:23.004100 [Channel state thread(16)]: ChannelStates.DoSetChannelStates took 191 msec
2013-09-19 21:45:23.187110 [GenericPCQueue(14)]: TV3BlasterPlugin: Received Message "BlastIR"
2013-09-19 21:45:23.188110 [GenericPCQueue(14)]: TV3BlasterPlugin: Blast successful
2013-09-19 21:52:09.559353 [(18)]: DiskManagement: checking free disk space