Failed to record - why oh why this one???

[time_lord]

Hi, went into TV Guide last night and set the NZ-Aus rugby on Prime to record. But checking this morning, there is no recording - I've missed the game! What a pain in the ****
I've looked at the GBPVR logs and it looks like it tried to start recording at 10:29 (correct), although it indicates some issue... Note also it DID create a folder ("International Rugby") in my Recordings, but nothing is in it. I have no mention of the recording in 'conflicts', 'pending', or 'whats new' (unlike another time when both devices of my dual tuner were busy and a failed recording was there and with the status 'failed', which made sense).

Relevant(?) part of GBPVRRecordingService.exe-1.log...

Code:

2008-09-13 22:29:00.109 INFO [5] Found new programme requiring recording: International Rugby (53) 2008-09-13 22:29:00.109 VERBOSE [5] Changing to channel (GBPVR.Backend.Common.NullTunerController): 319 2008-09-13 22:29:00.109 VERBOSE [5] Requesting IRecordingSource to start recording: D:\GBPVR\Recordings\International Rugby\International Rugby_20080913_22300130.mpg 2008-09-13 22:29:00.109 VERBOSE [5] DirectRecordingSource about to start recording oid:4 channel:319 2008-09-13 22:29:01.546 VERBOSE [5] recording started 2008-09-13 22:29:01.546 VERBOSE [5] Programme is now recording 2008-09-13 22:29:01.546 VERBOSE [5] RecordingFactory.save() 2008-09-13 22:29:01.609 VERBOSE [5] Save(): Updated existing scheduled recording 2008-09-13 22:29:01.609 VERBOSE [5] Adding D:\GBPVR\Recordings\International Rugby\International Rugby_20080913_22300130.mpg to parallel processing queue 2008-09-13 22:29:10.015 VERBOSE [11] File does not yet exist (may fail): D:\GBPVR\Recordings\International Rugby\International Rugby_20080913_22300130.mpg 2008-09-13 22:29:26.640 INFO [5] Recording file cant be found. Giving second chance: D:\GBPVR\Recordings\International Rugby\International Rugby_20080913_22300130.mpg 2008-09-13 22:29:26.640 VERBOSE [5] Stopping recording 2008-09-13 22:29:26.640 VERBOSE [5] Stopping recording oid:4 2008-09-13 22:29:27.250 VERBOSE [5] Restarting recording 2008-09-13 22:29:27.250 VERBOSE [5] DirectRecordingSource about to start recording oid:4 channel:319 2008-09-13 22:29:28.062 VERBOSE [5] recording started (After that last line there is no 'Programme is now recording' like there was the first time it tried to start???)

and

Code:

2008-09-14 01:32:00.093 VERBOSE [5] Recording has passed endtime+padding. Stopping. 2008-09-14 01:32:00.093 VERBOSE [5] Stopping recording oid:4 2008-09-14 01:32:00.203 VERBOSE [5] Adding D:\GBPVR\Recordings\International Rugby\International Rugby_20080913_22300130.mpg to commercial detection queue 2008-09-14 01:32:00.203 VERBOSE [5] Adding D:\GBPVR\Recordings\International Rugby\International Rugby_20080913_22300130.mpg to conversion detection queue 2008-09-14 01:32:00.265 VERBOSE [5] RecordingStatus is now RecordingStatus.RECORDING_COMPETED 2008-09-14 01:32:00.265 VERBOSE [5] RecordingFactory.save() 2008-09-14 01:32:00.359 VERBOSE [5] Save(): Updated existing scheduled recording 2008-09-14 01:32:00.359 VERBOSE [5] RecordingFactory.loadSchedule() 2008-09-14 01:32:00.359 VERBOSE [5] getValue cached value: /settings/AutoRemoveMissingRecordings : true 2008-09-14 01:32:00.468 VERBOSE [5] getValue() loading new key/value into cache: /settings/CheckForRenamedRecordings 2008-09-14 01:32:00.468 VERBOSE [5] getValue: /settings/CheckForRenamedRecordings : true 2008-09-14 01:32:00.562 VERBOSE [5] addPreviousEpisodes() 2008-09-14 01:32:00.562 VERBOSE [5] checking recordings 2008-09-14 01:32:00.562 VERBOSE [5] - checking Family Guy 2008-09-14 01:32:00.562 VERBOSE [5] - checking D:\GBPVR\Recordings\Family Guy\Family Guy_20080826_19001930.ts 2008-09-14 01:32:00.562 VERBOSE [5] - checking D:\GBPVR\Recordings\Family Guy\Family Guy_20080827_19001930.ts 2008-09-14 01:32:00.562 VERBOSE [5] - checking D:\GBPVR\Recordings\Family Guy\Family Guy_20080828_19001930.ts ... etc etc ... and the rugby isn't in here...

Let me know if the entire log - 100k+ (or a different log) is useful...

[sub]

Zip and attach the GBPVRRecordingService.exe.log and GBPVRRecordingService.exe-native.log and I'll take a look.

[tieke]

I'm not sure what time lord uses as an xml source, but I use dvbtoxml to get download my tvguide via dvb-s, and noticed yesterday that there was no scheduling information on prime for the duration of the game and thus set my recording manually. This may have been a contributing factor?

[time_lord]

I'm not sure what time lord uses as an xml source, but I use dvbtoxml to get download my tvguide via dvb-s, and noticed yesterday that there was no scheduling information on prime for the duration of the game and thus set my recording manually. This may have been a contributing factor?

I use djkxml (almost mandatory since I am picking up dvb-t and the epg is really short). Seems it was correct since the guide shows the coverage finishing at 1:30am (and the gbpvr log shows the recording finishing at 1:32am, which seems right).

[time_lord]

Zip and attach the GBPVRRecordingService.exe.log and GBPVRRecordingService.exe-native.log and I'll take a look.

Here you go, logs (rolled-over I assume) from saturday...

[sub]

It tried to do the recording, but the device was already in use.

2008-09-13 22:29:01.531 ERROR failed to start Conexant Graph
2008-09-13 22:29:01.531 VERBOSE ERROR_GEN_FAILURE

It related to the problem discussed in this thread: http://forums.nextpvr.com/showthread.php...post294080

[time_lord]

It tried to do the recording, but the device was already in use.

Hmmm, shouldn't have been... :confused:

It related to the problem discussed in this thread: http://forums.nextpvr.com/showthread.php...post294080

Oh I see. Shouldn't the recordings screen at least have listed the failed recording though?

[sub]

Hmmm, shouldn't have been... :confused:

The tuner was recording D:\GBPVR\Recordings\The Chasers War On Everything\The Chasers War On Everything_20080913_22102240.ts at the time.

Oh I see. Shouldn't the recordings screen at least have listed the failed recording though?

No it doesnt. It only ever marks a recording as failed if the recording service was not running at the time a recording was scheduled (liek machine switched off). For about the last two or three years I've intended to change this, but given I havnt yet, it may never happen.

[time_lord]

For about the last two or three years I've intended to change this, but given I havnt yet, it may never happen.

I'd like to vote for this ;-)

It related to the problem discussed in this thread: http://forums.nextpvr.com/showthread.php...post294080

Yes, I see, related to an issue I found :o sheesh, my mind like a sieve. I had thought I'd just wait for the next gbpvr update (with hvr2200 support). However 3 days later I got caught out yet again with what I expect is the same issue (so better try editing the bda.ini and direct.ini files).

I assume this is the same: Had Prime and TV1(?) set to record both at 8:30. When I started up pvrx2, both the Prime and TV1 recordings were in the "whats new" list. The Prime recording showed for literally about 1 second, then sound of static and a blue screen. Like the tuner had been taken away from it. Trying to play the TV1 recording gave me just a black screen, locking up pvrx2. After trying a couple of times, I looked in the recordings folder and it was 0 bytes.

Thought I should let you know... although it looks like the tuner was taken away from the Prime recording for the TV1 recording, the TV1 recording failed anyway. (But not listed as failed, hence my vote for that to be set as the status).
The other issue being that pvrx2 freezes when it tries to play this 0 byte file.