[HDPVR/Colossus] Channel Changing with NPVR Addon

[sub]

Does your STB not use HDCP? Most people have to resort to component video from their STB. Not sure HDCP is an issue here, but need to ask.

[toricred]

The older DirecTV receivers don't use HDCP for any channels other than HBO. I don't get any of the movie channels so I get to use HDMI for now.

[sub]

Have you been building the addon from source, or downloading the pre-built version?

I'm trying to work out the best way to give you a patch to collect more logging from the xbmc side.

[toricred]

I've been downloading the pre-built version.

[sub]

Try replacing your existing XBMC_NextPVR_win32.pvr addon with this one, then (after restarting recording service) reproduce and repost the three logs.

This patch will log info about info about the live stream data it's getting from nextpvr.

[toricred]

Here's the new XBMC log file.

[sub]

It appears the Colossus is not delivering any data, so nothing is ever delivered to the xbmc, which is sitting waiting for the first packet of data.

I've got to finish up for the day in a few minutes. (wife's instructions)

2012-10-10 20:01:13.726 [DEBUG][16] StartStream(7253:ESPNWHD, LIVE&L:\Timeshift\live-ESPNWHD-2356-3.ts) allocated handle: 2293766
2012-10-10 20:01:13.726 [DEBUG][16] Handle: 230006
2012-10-10 20:01:13.726 [DEBUG][16] StreamNative@9 (storing stream handle: 2293766)
2012-10-10 20:01:13.726 [DEBUG][16] clientHandle[XBMC-5c626e2cda7c4d5c90405e2c27f73a5d] = 2293766 *
2012-10-10 20:01:13.926 [DEBUG][16] StreamNative@10
2012-10-10 20:01:13.926 [DEBUG][16] RollingFile(L:\Timeshift\live-ESPNWHD-2356-3.ts)..
2012-10-10 20:01:13.926 [DEBUG][16] SharedMemoryHelper::Open()
2012-10-10 20:01:13.926 [DEBUG][16] Got file mapping
2012-10-10 20:01:13.926 [DEBUG][16] got shared memory helper
2012-10-10 20:01:13.926 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:13.926 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:13.926 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:13.926 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.026 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.026 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.126 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.126 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.227 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.227 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.327 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.327 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.427 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.427 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.527 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.527 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.627 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.627 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.727 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.727 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.827 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.827 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:14.927 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:14.927 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.027 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:15.027 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.127 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:15.127 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.227 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:15.227 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.327 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:15.327 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.427 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:15.427 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.527 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:15.527 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.627 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:15.627 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.727 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:15.727 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.827 [DEBUG][16] RollingFile.Position returning 0
2012-10-10 20:01:15.827 [DEBUG][16] RollingFile.Length returning 0
2012-10-10 20:01:15.927 [DEBUG][16] reached end of rolling file. Dropping connection...

[sub]

I've checked the logs and it definitely looks like it's tuning the HDMI input:

2012-10-10 20:01:13.576 [DEBUG][6] Building graph using: Hauppauge Colossus Crossbar 3 (87876444)
2012-10-10 20:01:13.599 [DEBUG][6] setting video routing (videoInput=3)
2012-10-10 20:01:13.608 [DEBUG][6] setting Colossus audio routing
2012-10-10 20:01:13.608 [DEBUG][6] using 'Audio SPDIFDigital In' (HDMI)
2012-10-10 20:01:13.619 [DEBUG][6] Graph filter list:
2012-10-10 20:01:13.619 [DEBUG][6] - NPVR Writer2
2012-10-10 20:01:13.619 [DEBUG][6] - NPVR Writer
2012-10-10 20:01:13.619 [DEBUG][6] - Infinite Pin Tee Filter
2012-10-10 20:01:13.619 [DEBUG][6] - Hauppauge Colossus TS Encoder 3
2012-10-10 20:01:13.619 [DEBUG][6] - Hauppauge Colossus Capture 3
2012-10-10 20:01:13.619 [DEBUG][6] - Hauppauge Colossus Crossbar 3

[sub]

If you attempt to record now, do you get file with data in it, or zero bytes? (ignore the fact you might have been able to record in the past)

[toricred]

I actually don't seem to be getting any file at all, but it might have been like last night where it is created and then immediately deleted only I didn't actually see it in between.