I seem to be having a problem with some Clear QAM cable channels after I moved to MP1.0.2. This may be a change in the signal on the cable and have nothing to do with MP1.0.2. A tuner scan of the cable skipped some channels. At first I thought this was a video stream problem, as the common thread seemed to be that the TV channels that were unencrypted DC-II were being detected as Radio Channels. A little manual work on the database got them to show up as TV channels, but MP1.0.2 would respond with a noVideo/audio detected error message. From the TV log (below), it cam be seen that the problem is no audio was found after 15.03125 seconds.
I thought this might be similar to the problem the French guys have been having with HD signals, so tried their patch....no help. I have checked the channel using TSReaderLite and have no problem playing the channel, so the problem must come back to MP. The critical section of MP TVlog is attached below, as is the audio stream information from TSReaderLite. Any suggestions on how to resolve will be appreciated. If more information, testing is needed I can provide that.
2009-06-10 09:34:08.156250 [10]: Controller: StartTimeShifting 62 History 591
2009-06-10 09:34:08.171875 [10]: Controller: find free card for channel Unknown 595250-3A
2009-06-10 09:34:08.234375 [10]: Controller: got 1 tuning details for Unknown 595250-3A
2009-06-10 09:34:08.250000 [10]: Controller: channel #1 ATSC:tv: Unknown 595250-3A Freq:595250 ONID:0 TSID:10234 SID:9 PMT:0x3A FTA:True LCN:10000 phys:86 maj:0 min:0 SR:0 mod:Mod256Qam
2009-06-10 09:34:08.375000 [10]: Controller: card:1 type:Atsc is available priority:3 #users:0 same transponder:False
2009-06-10 09:34:08.390625 [10]: Controller: card:2 type:Analog cannot tune to channel
2009-06-10 09:34:08.390625 [10]: Controller: card:3 type:RadioWebStream cannot tune to channel
2009-06-10 09:34:08.390625 [10]: Controller: found 1 available
2009-06-10 09:34:08.421875 [10]: card: CardTune 1 Unknown 595250-3A Fluffy:1:-1
2009-06-10 09:34:08.437500 [10]: card: Tune 1 to Unknown 595250-3A
2009-06-10 09:34:08.437500 [10]: card: user: Fluffy:1:-1 tune ATSC:tv: Unknown 595250-3A Freq:595250 ONID:0 TSID:10234 SID:9 PMT:0x3A FTA:True LCN:10000 phys:86 maj:0 min:0 SR:0 mod:Mod256Qam
2009-06-10 09:34:08.453125 [10]: atsc:Tune:ATSC:tv: Unknown 595250-3A Freq:595250 ONID:0 TSID:10234 SID:9 PMT:0x3A FTA:True LCN:10000 phys:86 maj:0 min:0 SR:0 mod:Mod256Qam
2009-06-10 09:34:08.453125 [10]: Setting Generic ATSC modulation to Mod256Qam
2009-06-10 09:34:08.453125 [10]: GenericATSC: Set ModulationType: Mod256Qam
2009-06-10 09:34:08.609375 [10]: dvbubmiting tunerequest Channel:Unknown 595250-3A subChannel:-1
2009-06-10 09:34:08.609375 [10]: dvb:Getting new subchannel
2009-06-10 09:34:08.625000 [10]: dvb:GetNewSubChannel:0 #0
2009-06-10 09:34:10.031250 [10]: TvDvbChannel ctor new subchIndex:0
2009-06-10 09:34:10.031250 [10]: dvbubmit tunerequest size:1 new:0
2009-06-10 09:34:10.031250 [10]: subch:0 OnBeforeTune
2009-06-10 09:34:10.031250 [10]: dvbubmit tunerequest calling put_TuneRequest
2009-06-10 09:34:12.109375 [10]: dvbubmit tunerequest done calling put_TuneRequest
2009-06-10 09:34:12.156250 [10]: subch:0 OnAfterTune
2009-06-10 09:34:12.156250 [10]: subch:0 OnGraphStart
2009-06-10 09:34:12.156250 [10]: subch:0 Graph already running - skip WaitForPMT
2009-06-10 09:34:12.156250 [10]: dvb: RunGraph
2009-06-10 09:34:13.015625 [10]: dvb: LockedInOnSignal ok
2009-06-10 09:34:13.015625 [10]: subch:0 OnGraphStarted
2009-06-10 09:34:13.031250 [10]: subch:0 SetupPmtGrabberid 3A sid:9
2009-06-10 09:34:13.031250 [10]: subch:0 set pmt grabber pmt:3A sid:9
2009-06-10 09:34:13.031250 [10]: WaitForPMT: Waiting for PMT.
2009-06-10 09:34:13.046875 [12]: subch:0 OnPMTReceived() True
2009-06-10 09:34:13.046875 [10]: WaitForPMT: Found PMT after 0.015625 seconds.
2009-06-10 09:34:13.062500 [10]: subch:0 SendPmt:9 9 FFFFFFFF 6
2009-06-10 09:34:13.078125 [10]: Decode pmt
2009-06-10 09:34:13.078125 [10]: Set descriptor data with length 6
2009-06-10 09:34:13.078125 [10]: subch:0 SendPMT version:6 len:60 9
2009-06-10 09:34:13.078125 [10]: subch:0 cam flags:True
2009-06-10 09:34:13.109375 [10]: subch:0 SetMpegPidMapping
2009-06-10 09:34:13.109375 [10]: subch:0 pid:A40 pcr
2009-06-10 09:34:13.109375 [10]: subch:0 pid:3A pmt
2009-06-10 09:34:13.109375 [10]: subch:0 pid:A40 type:80
2009-06-10 09:34:13.109375 [10]: subch:0 pid:A41 audio lang:eng type:AC3
2009-06-10 09:34:13.109375 [10]: subch:0 map pid:A41 audio lang:eng type:AC3
2009-06-10 09:34:13.125000 [10]: subch:0 pid:A42 type:86
2009-06-10 09:34:13.125000 [10]: subch:0 pid:A43 type:C0
2009-06-10 09:34:13.125000 [10]: subch:0 pid:A44 type:C0
2009-06-10 09:34:13.125000 [10]: subch:0 stop tif
2009-06-10 09:34:13.125000 [10]: WaitForPMT: sending PMT to CAM took 0.078125 seconds.
2009-06-10 09:34:13.703125 [10]: card: Tuner locked: True
2009-06-10 09:34:13.718750 [10]: **************************************************
2009-06-10 09:34:13.718750 [10]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 100 *****
2009-06-10 09:34:13.718750 [10]: **************************************************
2009-06-10 09:34:13.718750 [10]: card: tuned user: Fluffy subchannel: 0
2009-06-10 09:34:13.718750 [10]: user:Fluffy add
2009-06-10 09:34:13.718750 [10]: card2:Fluffy 1 0
2009-06-10 09:34:13.718750 [10]: Controller: Fluffy 1 0
2009-06-10 09:34:13.734375 [10]: control2:Fluffy 1 0
2009-06-10 09:34:13.734375 [10]: Controller: delete timeshift files C:\Documents and Settings\All Users\Application Data\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live1-0.ts
2009-06-10 09:34:13.765625 [10]: card: StartTimeShifting 1 C:\Documents and Settings\All Users\Application Data\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live1-0.ts
2009-06-10 09:34:13.765625 [10]: card: CAM enabled : False
2009-06-10 09:34:13.765625 [10]: subch:0 SetTimeShiftFileName:C:\Documents and Settings\All Users\Application Data\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live1-0.ts
2009-06-10 09:34:13.765625 [10]: Set video / audio observer
2009-06-10 09:34:13.781250 [10]: subch:0 SetTimeShiftFileName fill in pids
2009-06-10 09:34:13.781250 [10]: subch:0-0 tswriter StartTimeshifting...
2009-06-10 09:34:13.812500 [10]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo
2009-06-10 09:34:13.843750 [12]: PID seen - type = Audio
2009-06-10 09:34:13.843750 [12]: audioVideoEventHandler Audio
2009-06-10 09:34:28.843750 [10]: card: WaitForTimeShiftFile - video was found, but audio was not found after 15.03125 seconds
2009-06-10 09:34:28.859375 [10]: card AVerMedia M780 PCIe BDA ATSC Tuner 2: StopTimeShifting user:Fluffy sub:0
2009-06-10 09:34:28.859375 [10]: card: StopTimeShifting user:Fluffy sub:0
2009-06-10 09:34:28.859375 [10]: card not IDLE - freeing subch: 0
2009-06-10 09:34:28.875000 [10]: subch:0-0 tswriter StopTimeshifting...
2009-06-10 09:34:28.906250 [10]: tvcard:FreeSubChannel: subchannels count 1 subch#0 keep graph=False
2009-06-10 09:34:28.906250 [10]: DVB subch:0 Decompose()
2009-06-10 09:34:28.906250 [10]: FreeSubChannel CA: freeing sub channel : 0
2009-06-10 09:34:28.921875 [10]: tvcard:FreeSubChannel : no subchannels present, stopping graph
2009-06-10 09:34:28.921875 [10]: dvbtopGraph called
2009-06-10 09:34:28.921875 [10]: tvcard:FreeAllSubChannels:
2009-06-10 09:34:28.921875 [10]: dvbtopGraph
2009-06-10 09:34:28.937500 [10]: user:Fluffy remove
TSReaderLite has no problem playing this audio stream, but MP doesn't seem to be able to handle it.
Elementary Stream PID 2625 (0x0a41) AC-3 Audio
AC3: Bitrate 128 Kbps Sample Rate 48 KHz
AC3: Mode complete main Coding 2/0 L, R
Descriptor: ISO639 Language Descriptor
Language: eng
Audio type: undefined
I thought this might be similar to the problem the French guys have been having with HD signals, so tried their patch....no help. I have checked the channel using TSReaderLite and have no problem playing the channel, so the problem must come back to MP. The critical section of MP TVlog is attached below, as is the audio stream information from TSReaderLite. Any suggestions on how to resolve will be appreciated. If more information, testing is needed I can provide that.
2009-06-10 09:34:08.156250 [10]: Controller: StartTimeShifting 62 History 591
2009-06-10 09:34:08.171875 [10]: Controller: find free card for channel Unknown 595250-3A
2009-06-10 09:34:08.234375 [10]: Controller: got 1 tuning details for Unknown 595250-3A
2009-06-10 09:34:08.250000 [10]: Controller: channel #1 ATSC:tv: Unknown 595250-3A Freq:595250 ONID:0 TSID:10234 SID:9 PMT:0x3A FTA:True LCN:10000 phys:86 maj:0 min:0 SR:0 mod:Mod256Qam
2009-06-10 09:34:08.375000 [10]: Controller: card:1 type:Atsc is available priority:3 #users:0 same transponder:False
2009-06-10 09:34:08.390625 [10]: Controller: card:2 type:Analog cannot tune to channel
2009-06-10 09:34:08.390625 [10]: Controller: card:3 type:RadioWebStream cannot tune to channel
2009-06-10 09:34:08.390625 [10]: Controller: found 1 available
2009-06-10 09:34:08.421875 [10]: card: CardTune 1 Unknown 595250-3A Fluffy:1:-1
2009-06-10 09:34:08.437500 [10]: card: Tune 1 to Unknown 595250-3A
2009-06-10 09:34:08.437500 [10]: card: user: Fluffy:1:-1 tune ATSC:tv: Unknown 595250-3A Freq:595250 ONID:0 TSID:10234 SID:9 PMT:0x3A FTA:True LCN:10000 phys:86 maj:0 min:0 SR:0 mod:Mod256Qam
2009-06-10 09:34:08.453125 [10]: atsc:Tune:ATSC:tv: Unknown 595250-3A Freq:595250 ONID:0 TSID:10234 SID:9 PMT:0x3A FTA:True LCN:10000 phys:86 maj:0 min:0 SR:0 mod:Mod256Qam
2009-06-10 09:34:08.453125 [10]: Setting Generic ATSC modulation to Mod256Qam
2009-06-10 09:34:08.453125 [10]: GenericATSC: Set ModulationType: Mod256Qam
2009-06-10 09:34:08.609375 [10]: dvbubmiting tunerequest Channel:Unknown 595250-3A subChannel:-1
2009-06-10 09:34:08.609375 [10]: dvb:Getting new subchannel
2009-06-10 09:34:08.625000 [10]: dvb:GetNewSubChannel:0 #0
2009-06-10 09:34:10.031250 [10]: TvDvbChannel ctor new subchIndex:0
2009-06-10 09:34:10.031250 [10]: dvbubmit tunerequest size:1 new:0
2009-06-10 09:34:10.031250 [10]: subch:0 OnBeforeTune
2009-06-10 09:34:10.031250 [10]: dvbubmit tunerequest calling put_TuneRequest
2009-06-10 09:34:12.109375 [10]: dvbubmit tunerequest done calling put_TuneRequest
2009-06-10 09:34:12.156250 [10]: subch:0 OnAfterTune
2009-06-10 09:34:12.156250 [10]: subch:0 OnGraphStart
2009-06-10 09:34:12.156250 [10]: subch:0 Graph already running - skip WaitForPMT
2009-06-10 09:34:12.156250 [10]: dvb: RunGraph
2009-06-10 09:34:13.015625 [10]: dvb: LockedInOnSignal ok
2009-06-10 09:34:13.015625 [10]: subch:0 OnGraphStarted
2009-06-10 09:34:13.031250 [10]: subch:0 SetupPmtGrabberid 3A sid:9
2009-06-10 09:34:13.031250 [10]: subch:0 set pmt grabber pmt:3A sid:9
2009-06-10 09:34:13.031250 [10]: WaitForPMT: Waiting for PMT.
2009-06-10 09:34:13.046875 [12]: subch:0 OnPMTReceived() True
2009-06-10 09:34:13.046875 [10]: WaitForPMT: Found PMT after 0.015625 seconds.
2009-06-10 09:34:13.062500 [10]: subch:0 SendPmt:9 9 FFFFFFFF 6
2009-06-10 09:34:13.078125 [10]: Decode pmt
2009-06-10 09:34:13.078125 [10]: Set descriptor data with length 6
2009-06-10 09:34:13.078125 [10]: subch:0 SendPMT version:6 len:60 9
2009-06-10 09:34:13.078125 [10]: subch:0 cam flags:True
2009-06-10 09:34:13.109375 [10]: subch:0 SetMpegPidMapping
2009-06-10 09:34:13.109375 [10]: subch:0 pid:A40 pcr
2009-06-10 09:34:13.109375 [10]: subch:0 pid:3A pmt
2009-06-10 09:34:13.109375 [10]: subch:0 pid:A40 type:80
2009-06-10 09:34:13.109375 [10]: subch:0 pid:A41 audio lang:eng type:AC3
2009-06-10 09:34:13.109375 [10]: subch:0 map pid:A41 audio lang:eng type:AC3
2009-06-10 09:34:13.125000 [10]: subch:0 pid:A42 type:86
2009-06-10 09:34:13.125000 [10]: subch:0 pid:A43 type:C0
2009-06-10 09:34:13.125000 [10]: subch:0 pid:A44 type:C0
2009-06-10 09:34:13.125000 [10]: subch:0 stop tif
2009-06-10 09:34:13.125000 [10]: WaitForPMT: sending PMT to CAM took 0.078125 seconds.
2009-06-10 09:34:13.703125 [10]: card: Tuner locked: True
2009-06-10 09:34:13.718750 [10]: **************************************************
2009-06-10 09:34:13.718750 [10]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 100 *****
2009-06-10 09:34:13.718750 [10]: **************************************************
2009-06-10 09:34:13.718750 [10]: card: tuned user: Fluffy subchannel: 0
2009-06-10 09:34:13.718750 [10]: user:Fluffy add
2009-06-10 09:34:13.718750 [10]: card2:Fluffy 1 0
2009-06-10 09:34:13.718750 [10]: Controller: Fluffy 1 0
2009-06-10 09:34:13.734375 [10]: control2:Fluffy 1 0
2009-06-10 09:34:13.734375 [10]: Controller: delete timeshift files C:\Documents and Settings\All Users\Application Data\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live1-0.ts
2009-06-10 09:34:13.765625 [10]: card: StartTimeShifting 1 C:\Documents and Settings\All Users\Application Data\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live1-0.ts
2009-06-10 09:34:13.765625 [10]: card: CAM enabled : False
2009-06-10 09:34:13.765625 [10]: subch:0 SetTimeShiftFileName:C:\Documents and Settings\All Users\Application Data\Team MediaPortal\MediaPortal TV Server\timeshiftbuffer\live1-0.ts
2009-06-10 09:34:13.765625 [10]: Set video / audio observer
2009-06-10 09:34:13.781250 [10]: subch:0 SetTimeShiftFileName fill in pids
2009-06-10 09:34:13.781250 [10]: subch:0-0 tswriter StartTimeshifting...
2009-06-10 09:34:13.812500 [10]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo
2009-06-10 09:34:13.843750 [12]: PID seen - type = Audio
2009-06-10 09:34:13.843750 [12]: audioVideoEventHandler Audio
2009-06-10 09:34:28.843750 [10]: card: WaitForTimeShiftFile - video was found, but audio was not found after 15.03125 seconds
2009-06-10 09:34:28.859375 [10]: card AVerMedia M780 PCIe BDA ATSC Tuner 2: StopTimeShifting user:Fluffy sub:0
2009-06-10 09:34:28.859375 [10]: card: StopTimeShifting user:Fluffy sub:0
2009-06-10 09:34:28.859375 [10]: card not IDLE - freeing subch: 0
2009-06-10 09:34:28.875000 [10]: subch:0-0 tswriter StopTimeshifting...
2009-06-10 09:34:28.906250 [10]: tvcard:FreeSubChannel: subchannels count 1 subch#0 keep graph=False
2009-06-10 09:34:28.906250 [10]: DVB subch:0 Decompose()
2009-06-10 09:34:28.906250 [10]: FreeSubChannel CA: freeing sub channel : 0
2009-06-10 09:34:28.921875 [10]: tvcard:FreeSubChannel : no subchannels present, stopping graph
2009-06-10 09:34:28.921875 [10]: dvbtopGraph called
2009-06-10 09:34:28.921875 [10]: tvcard:FreeAllSubChannels:
2009-06-10 09:34:28.921875 [10]: dvbtopGraph
2009-06-10 09:34:28.937500 [10]: user:Fluffy remove
TSReaderLite has no problem playing this audio stream, but MP doesn't seem to be able to handle it.
Elementary Stream PID 2625 (0x0a41) AC-3 Audio
AC3: Bitrate 128 Kbps Sample Rate 48 KHz
AC3: Mode complete main Coding 2/0 L, R
Descriptor: ISO639 Language Descriptor
Language: eng
Audio type: undefined