[dkclifton]

Skipping forward and backward when watching recorded TV programs is not working correctly. This is true for both small and big skip steps. For example, when I try to skip forward 5 minutes, it may skip forward anywhere from a few seconds to a few minutes. However, when I watch the program as a video, skipping works perfectly.

Here is a portion of the log when a big step forward (5 min) is requested while playing back a recorded TV program. Note that although the log says the seeking was a success, it actually wasn't.

Code:

21:54:30.282 T:140735132622848   DEBUG: Keyboard: scancode: 0x7e, sym: 0x0111, unicode: 0xf700, modifier: 0x0
21:54:30.414 T:140735132622848   DEBUG: OnKey: up (0xf080) pressed, action is ChapterOrBigStepForward
21:54:30.419 T:123145310429184   DEBUG: CVideoPlayer::SetCaching - caching state 2
21:54:30.419 T:123145310429184   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
21:54:30.419 T:123145310429184   DEBUG: demuxer seek to: 320691.000000
21:54:30.419 T:123145310429184   DEBUG: AddOnLog: PVR WMC Client: Socket::GetVector> Send request "StreamFileSize|0"
21:54:30.432 T:123145323921408   DEBUG: CDVDAudio::Pause - pausing audio stream
21:54:30.446 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] SPS unavailable in decode_picture_timing
21:54:30.446 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] non-existing PPS 0 referenced
21:54:30.446 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] SPS unavailable in decode_picture_timing
21:54:30.446 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] non-existing PPS 0 referenced
21:54:30.446 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] SPS unavailable in decode_picture_timing
21:54:30.446 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] non-existing PPS 0 referenced
21:54:30.446 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] SPS unavailable in decode_picture_timing
21:54:30.446 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] non-existing PPS 0 referenced
21:54:30.453 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] SPS unavailable in decode_picture_timing
21:54:30.453 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] non-existing PPS 0 referenced
21:54:30.453 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] SPS unavailable in decode_picture_timing
21:54:30.453 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] non-existing PPS 0 referenced
21:54:30.453 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] SPS unavailable in decode_picture_timing
21:54:30.453 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] non-existing PPS 0 referenced
21:54:30.453 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] SPS unavailable in decode_picture_timing
21:54:30.453 T:123145310429184   ERROR: ffmpeg[7000007BE000]: [NULL] non-existing PPS 0 referenced
21:54:30.454 T:123145310429184   DEBUG: SeekTime - seek ended up on time 294240
21:54:30.454 T:123145310429184   DEBUG: demuxer seek to: 320691.000000, success
21:54:30.454 T:123145310429184   DEBUG: CVideoPlayer::FlushBuffers - flushing buffers
21:54:30.463 T:123145323921408   DEBUG: CDVDAudio::Flush - flush audio stream
21:54:30.464 T:123145323921408   DEBUG: CDVDAudio::Pause - pausing audio stream
21:54:30.468 T:123145317482496   DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
21:54:30.468 T:123145323921408   DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE

Here is a portion of the log when a big step forward is requested while watching the same program being played back as a video. This seek really was successful, even though it says "unknown position after seek."

Code:

22:06:04.675 T:140735132622848   DEBUG: Keyboard: scancode: 0x7e, sym: 0x0111, unicode: 0xf700, modifier: 0x0
22:06:04.742 T:140735132622848   DEBUG: OnKey: up (0xf080) pressed, action is ChapterOrBigStepForward
22:06:04.746 T:123145307746304   DEBUG: CVideoPlayer::SetCaching - caching state 2
22:06:04.746 T:123145307746304   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
22:06:04.746 T:123145307746304   DEBUG: demuxer seek to: 301420.000000
22:06:04.746 T:123145307746304   DEBUG: SeekTime - unknown position after seek
22:06:04.746 T:123145307746304   DEBUG: demuxer seek to: 301420.000000, success
22:06:04.746 T:123145307746304   DEBUG: CVideoPlayer::FlushBuffers - flushing buffers
22:06:04.757 T:123145334480896   DEBUG: CDVDAudio::Pause - pausing audio stream
22:06:04.768 T:123145334480896   DEBUG: CDVDAudio::Flush - flush audio stream
22:06:04.768 T:123145334480896   DEBUG: CDVDAudio::Pause - pausing audio stream
22:06:04.797 T:123145324994560   DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
22:06:04.797 T:123145334480896   DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE

Any ideas about what is going on here?

[krustyreturns]

You are watching a recorded tv program with the wmc addon when you see this? So when you say: "same program being played back as a video" you mean adding the same wtv file to the video section of kodi and playing back that way, right?

When you reply include a link to your serverwmc log file (really just the beginning part) so that I can see how you have it configured.

[dkclifton]

Yes, I am watching the video from the video section of Kodi, which is getting it directly from the Recorded TV folder on my WMC server.

Here is a link to the startup section of my serverwmc log.

[krustyreturns]

In the serverwmc settings file, put this setting back to its default value, then I'm pretty sure the problem will go away:
Debug_RemuxAllRecordings: True >>Default: False

somewhat unrelated, but I would put this setting back to its default too:
RemuxActiveRecordings: False >>Default: True

[dkclifton]

Setting Debug_RemuxAllRecordings to False did it!

Thanks so much Krusty!

[michaeljc70]

I seem to be having a similar problem of skipping is erratic watching a recording that hasn't finished. Even though it said +3.00 it would sometimes go forward 14 minutes. When trying to go back, sometimes it would go forward a seemingly random amount. I looked at those settings and mine match the default. Is there anything else obvious I can check before I post my config/log in a new thread? I am running Kodi 15.2.

[krustyreturns]

Recordings that haven't finished require remuxing if they are played, otherwise they will stop prematurely, When I start watching something that is currently recording, I don't issue any skip forward or backward commands for a minute or two to give the remuxer time to get way ahead of the current watch point, then skip forward and backward behave as expected.

This behavior is on by default, but can be turned off. Change to this setting:
<RemuxActiveRecordings>false</RemuxActiveRecordings>
but like I said, the playback will stop before the actual end of the recording because kodi can't hand a file that is actively growing.

[michaeljc70]

Recordings that haven't finished require remuxing if they are played, otherwise they will stop prematurely, When I start watching something that is currently recording, I don't issue any skip forward or backward commands for a minute or two to give the remuxer time to get way ahead of the current watch point, then skip forward and backward behave as expected.

This behavior is on by default, but can be turned off. Change to this setting:
<RemuxActiveRecordings>false</RemuxActiveRecordings>
but like I said, the playback will stop before the actual end of the recording because kodi can't hand a file that is actively growing.

I get that, but what I am seeing is I am recording a 3 hour show. 1 hour into the recording, I start to play it. If I try to skip the first commercial, it acts erratic. Even if I restarted playing it and waited a while, even like 40 minutes into the recording (which 1hr 40 min has been recorded by now), I experienced erratic skipping. I will say I haven't noticed all the time and frequently do this.