LE8 on WeTeK OpenELEC: Freeze because of memory leak?

**Sepp** · February 27, 2017 at 8:08 PM

Hi,

last week I installed the new LibreELEC 8.0.0 release on one of my WeTeK OpenELEC boxes.

To narrow things down and to be sure I wiped the complete box and the *only* plugin I installed is the "Tvheadend HTSP client 3.4.18.1".

The Tvheadend server is *not* running on the box, but I'm streaming from a Tvheadend server on a RPi in the network.

After several hours, it seems that Kodi is using up all the memory and the box either locks up or suffers from severe swapping with a load going up to 18 and above.

To reproduce, one just has to boot up the box (using the default skin), start LiveTV and wait for some hours. No switching/GUI usage required to crash the system.

Attached see two "top" screenshots - one with severe swapping and one with a died box - as well as a "journalctl -f" trace of a died box.

I will add more logs if required/later.

TIA,
Sepp

**Sepp** · log-2017-02-28-10.21.15.zip

Hi,

so I *tried* to make a more decent set of logs.

Problem is, that when things finally go wrong, things a quite screwed up and one can't just use the samba logfile feature.

So here is what I did:
1) Rebooted
2) Switched on LiveTV
3) opened one SSH terminal with "journalctl -f"
4) opened second SSH for "top" and later control
5) waited for things to screw up
6) when system was finally total stuck, I used the second terminal to kill kodi with "killall -9 kodi.bin". This took about 5 minutes just to accept the keystrokes.
7) Tried to create the logfiles, but they were to big to be processed on the available "disk space"
copied away "kodi.old.log" (nearly 1 GB!) and deleted it
9) executed "createlog"
10) found out, that in the created ZIP file also data from journalctl was lost.

So here is what you get now:
- a full logfile ZIP-ball created after things screwed up and KODI was manually killed, with "kodi.old.log" missing and crippled journalctl data
- a separate zip-file with "kodi.old.log" -> ZIPPED 70 MB, TOO BIG TO UPLOAD
- a separate zip-file with the trace of "journalctl -f" followed on a remote ssh terminal

If you need more, please tell me.

Sepp

EDIT: Ok, I uploaded the big "kodi.old.log" to a one-click-hoster. Please find the file here:

kodi.old.log.zip | Uloz.to

**Sepp** · March 4, 2017 at 11:36 AM

Hello,

did some more investigations and wrote a script to log the memory usage of the "kodi.bin" process.

I did two runs now, and interesting enough, memory usage is always constant for a long time. But then, always after 400 minutes, memory usage starts to increase over some minutes until all memory is used up.

Test procedure was: Reboot -> start monitoring script -> go to live TV -> watch first channel in fullscreen -> don't touch anymore

Attached you find the results. One plot over the full time and one detailed plot for the "crawl up time" for each run.

Any ideas?

Cheers,
Sepp

Bohemi · March 5, 2017 at 7:38 AM

I have the same issue with LibreELEC 8.0.0 on the Wetek Core. After a while the GUI is extremely slow and mosthly a SSH reboot is the only option.

LibreELEC devs, I see several threads related to this topic, does it make sense to still share bug reports or is there enough information for you to investigate?

chears

**codesnake** · March 5, 2017 at 5:10 PM

Sepp I will try to reproduce your issue.

Bohemi We are aware of the slowness after some time of inactivity issue on WeTek Core and working to fix it. It is not related to the issue described by Sepp.

**Sepp** · March 8, 2017 at 6:20 PM

Any news?

On my side I did some more tests:

First I installed the TVHeadend server add-on on the WeTek and changed the configuration of the TVHeadend client, so that I see the local TV stream and not the one of the remote server.
Result: Same thing. Approx. 400 minutes everything works well, and then memory usage goes up until everything is too late.

Then I installed the YouTube plugin and started a video 10 hours long (Cantina Band: Play that same song! ).
Result: Kodi again freezes, but this time without memory usage increasing! The freeze also _seems_ to take place after approx. 400 minutes. Unfortunately, again all useful logs were lost due to the powercycle and/or the freeze. I will try to reproduce and somehow produce useful logs.

Any ideas? Any advice?

Cheers,
Sepp

**codesnake** · March 9, 2017 at 9:03 PM

Sepp I managed to reproduce your issue. Now I'm trying to find a solution for it.

**Sepp** · March 10, 2017 at 1:04 AM

codesnake: Good!

As promised, I tried to produce useful logs. Doing so, I realized that the freeze always seems to occure around the overflow of dts_in/pts_in in CAMLCodec:: Decode. There is this 32 signed int value, and when it exceeds 0x7FFFFFFF things go wrong.

Here the log for watching PVR with tvheadend client when the memory increase happens:

Code

06:40:18.515 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[7FFFCF00], pts_in: 18442240474082.1797[7FFFD608], adj:0, ptsOut:23858.4902, amlpts:2147264104, idx:1192845, timesize:1.9800
06:40:18.515 T:2639074208   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
06:40:18.516 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 4, sz: 16400, dts_in: 23860.8100[7FFFD608], pts_in: 23860.8300[7FFFDD10], adj:0, ptsOut:23858.5098, amlpts:2147265904, idx:1192846, timesize:1.9800
06:40:18.526 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[7FFFD608], pts_in: 18442240474082.1797[7FFFDD10], adj:0, ptsOut:23858.5098, amlpts:2147265904, idx:1192846, timesize:2.0000
06:40:18.532 T:3035994896   DEBUG: CAMLCodec::ReleaseFrame idx:1192846
06:40:18.537 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[7FFFD608], pts_in: 18442240474082.1797[7FFFDD10], adj:0, ptsOut:23858.5098, amlpts:2147265904, idx:1192846, timesize:1.9800
06:40:18.537 T:2639074208   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
06:40:18.538 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 4, sz: 13754, dts_in: 23860.8300[7FFFDD10], pts_in: 23860.8500[7FFFE418], adj:0, ptsOut:23858.5293, amlpts:2147267704, idx:1192847, timesize:1.9800
06:40:18.549 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[7FFFDD10], pts_in: 18442240474082.1797[7FFFE418], adj:0, ptsOut:23858.5293, amlpts:2147267704, idx:1192847, timesize:2.0000
06:40:18.551 T:3035994896   DEBUG: CAMLCodec::ReleaseFrame idx:1192847
06:40:18.560 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[7FFFDD10], pts_in: 18442240474082.1797[7FFFE418], adj:0, ptsOut:23858.5293, amlpts:2147267704, idx:1192847, timesize:1.9800
06:40:18.561 T:2639074208   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 0
06:40:18.563 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 4, sz: 118016, dts_in: 23860.8500[FFFFFFFFFFFFE418], pts_in: 23861.0300[2360], adj:2147483648, ptsOut:23858.5508, amlpts:2147269504, idx:1192848, timesize:1.9600
06:40:18.564 T:2639074208   DEBUG: CPullupCorrection: pattern lost on diff 23860949422.222221, number of losses 1
06:40:18.575 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[FFFFFFFFFFFFE418], pts_in: 18442240474082.1797[2360], adj:2147483648, ptsOut:23858.5508, amlpts:2147269504, idx:1192848, timesize:1.9800
06:40:18.575 T:2639074208   DEBUG: CVideoPlayerVideo::CalcDropRequirement - hurry: 1
06:40:18.577 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 4, sz: 60842, dts_in: 23860.8700[FFFFFFFFFFFFEB20], pts_in: 23860.9500[740], adj:2147483648, ptsOut:23858.5703, amlpts:2147271304, idx:1192849, timesize:1.9800
06:40:18.587 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[FFFFFFFFFFFFEB20], pts_in: 18442240474082.1797[740], adj:2147483648, ptsOut:23858.5703, amlpts:2147271304, idx:1192849, timesize:2.0000
06:40:18.598 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[FFFFFFFFFFFFEB20], pts_in: 18442240474082.1797[740], adj:2147483648, ptsOut:23858.5703, amlpts:2147271304, idx:1192849, timesize:1.9800
06:40:18.599 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 4, sz: 15495, dts_in: 23860.8900[FFFFFFFFFFFFF228], pts_in: 23860.8900[FFFFFFFFFFFFF228], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:1.9800
06:40:18.609 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[FFFFFFFFFFFFF228], pts_in: 18442240474082.1797[FFFFFFFFFFFFF228], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:2.0000
06:40:18.620 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[FFFFFFFFFFFFF228], pts_in: 18442240474082.1797[FFFFFFFFFFFFF228], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:1.9800
06:40:18.630 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 2, sz: 18120, dts_in: 23860.9100[FFFFFFFFFFFFF930], pts_in: 23860.9100[FFFFFFFFFFFFF930], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:1.9800
06:40:18.641 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 11810, dts_in: 23860.9300[38], pts_in: 23860.9300[38], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:2.0000
06:40:18.651 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[38], pts_in: 18442240474082.1797[38], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:2.0200
06:40:26.437 T:2648699808   DEBUG: Previous line repeats 752 times.
06:40:26.437 T:2648699808   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:-0.050000
06:40:26.442 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[38], pts_in: 18442240474082.1797[38], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:2.0200
06:40:27.190 T:2630685600   DEBUG: Previous line repeats 72 times.
06:40:27.191 T:2630685600  NOTICE: CVideoPlayerAudio::Process - stream stalled
06:40:27.194 T:2648699808   DEBUG: Stream stalled, start buffering. Audio: 0 - Video: 100
06:40:27.194 T:2648699808   DEBUG: CVideoPlayer::FlushBuffers - flushing buffers
06:40:27.195 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[38], pts_in: 18442240474082.1797[38], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:2.0200
06:40:27.243 T:2630685600   DEBUG: Previous line repeats 4 times.
06:40:27.243 T:2630685600   DEBUG: CDVDAudio::Flush - flush audio stream
06:40:27.243 T:2630685600   DEBUG: CDVDAudio::Pause - pausing audio stream
06:40:27.247 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[38], pts_in: 18442240474082.1797[38], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:2.0200
06:40:28.196 T:2630685600   DEBUG: Previous line repeats 92 times.
06:40:28.196 T:2630685600   DEBUG: CDVDMsgGeneralSynchronize - global timeout
06:40:28.196 T:2630685600   DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
06:40:28.197 T:2648699808   DEBUG: CDVDMsgGeneralSynchronize - global timeout
06:40:28.197 T:2648699808   DEBUG: CVideoPlayer::SetCaching - caching state 2
06:40:28.197 T:2648699808   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
06:40:28.205 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[38], pts_in: 18442240474082.1797[38], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:2.0200
06:40:28.207 T:2630685600   DEBUG: CDVDAudio::Pause - pausing audio stream
06:40:28.216 T:2648699808   DEBUG: CVideoPlayer::HandleMessages - player started 1
06:40:28.223 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[38], pts_in: 18442240474082.1797[38], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:2.0200
06:40:33.198 T:2648699808   DEBUG: Previous line repeats 482 times.
06:40:33.199 T:2648699808   DEBUG: CVideoPlayer::SetCaching - caching state 0
06:40:33.199 T:2648699808   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
06:40:33.202 T:2639074208   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[38], pts_in: 18442240474082.1797[38], adj:2147483648, ptsOut:23858.5898, amlpts:2147273104, idx:1192850, timesize:2.0200

Display More

And here with the YouTube plugin:

Code

07:46:08.465 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 2185, dts_in: 23860.7667[7FFFC6C8], pts_in: 23860.7667[7FFFC6C8], adj:0, ptsOut:23857.9004, amlpts:2147211000, idx:715737, timesize:2.0019
07:46:08.466 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 4, sz: 0, dts_in: 18442240474082.1797[7FFFC6C8], pts_in: 18442240474082.1797[7FFFC6C8], adj:0, ptsOut:23857.9336, amlpts:2147214000, idx:715738, timesize:2.0352
07:46:08.476 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[7FFFC6C8], pts_in: 18442240474082.1797[7FFFC6C8], adj:0, ptsOut:23857.9336, amlpts:2147214000, idx:715738, timesize:2.0352
07:46:08.481 T:3035712272   DEBUG: CAMLCodec::ReleaseFrame idx:715736
07:46:08.487 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[7FFFC6C8], pts_in: 18442240474082.1797[7FFFC6C8], adj:0, ptsOut:23857.9336, amlpts:2147214000, idx:715738, timesize:2.0019
07:46:08.488 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 4, sz: 0, dts_in: 18442240474082.1797[7FFFC6C8], pts_in: 18442240474082.1797[7FFFC6C8], adj:0, ptsOut:23857.9668, amlpts:2147217000, idx:715739, timesize:2.0019
07:46:08.498 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[7FFFC6C8], pts_in: 18442240474082.1797[7FFFC6C8], adj:0, ptsOut:23857.9668, amlpts:2147217000, idx:715739, timesize:2.0019
07:46:08.508 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[7FFFC6C8], pts_in: 18442240474082.1797[7FFFC6C8], adj:0, ptsOut:23857.9668, amlpts:2147217000, idx:715739, timesize:1.9351
07:46:08.519 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 2, sz: 3852, dts_in: 23860.8000[7FFFD280], pts_in: 23860.8000[7FFFD280], adj:0, ptsOut:23857.9668, amlpts:2147217000, idx:715739, timesize:1.9351
07:46:08.520 T:3035712272   DEBUG: CAMLCodec::ReleaseFrame idx:715737
07:46:08.529 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 2, sz: 334, dts_in: 23860.8333[7FFFDE38], pts_in: 23860.8333[7FFFDE38], adj:0, ptsOut:23857.9668, amlpts:2147217000, idx:715739, timesize:1.9685
07:46:08.529 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 4, sz: 102, dts_in: 23860.8667[7FFFE9F0], pts_in: 23860.8667[7FFFE9F0], adj:0, ptsOut:23858.0000, amlpts:2147220000, idx:715740, timesize:1.9685
07:46:08.540 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[7FFFE9F0], pts_in: 18442240474082.1797[7FFFE9F0], adj:0, ptsOut:23858.0000, amlpts:2147220000, idx:715740, timesize:2.0019
07:46:08.540 T:3035712272   DEBUG: CAMLCodec::ReleaseFrame idx:715738
07:46:08.550 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[7FFFE9F0], pts_in: 18442240474082.1797[7FFFE9F0], adj:0, ptsOut:23858.0000, amlpts:2147220000, idx:715740, timesize:2.0019
07:46:08.560 T:2547315616   DEBUG: Previous line repeats 1 times.
07:46:08.561 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 4, sz: 0, dts_in: 18442240474082.1797[7FFFE9F0], pts_in: 18442240474082.1797[7FFFE9F0], adj:0, ptsOut:23858.0332, amlpts:2147223000, idx:715741, timesize:2.0019
07:46:08.571 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[7FFFE9F0], pts_in: 18442240474082.1797[7FFFE9F0], adj:0, ptsOut:23858.0332, amlpts:2147223000, idx:715741, timesize:2.0019
07:46:08.582 T:2547315616   DEBUG: Previous line repeats 1 times.
07:46:08.582 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 4, sz: 0, dts_in: 18442240474082.1797[7FFFE9F0], pts_in: 18442240474082.1797[7FFFE9F0], adj:0, ptsOut:23858.0664, amlpts:2147226000, idx:715742, timesize:2.0019
07:46:08.582 T:3035712272   DEBUG: CAMLCodec::ReleaseFrame idx:715739
07:46:08.592 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[7FFFE9F0], pts_in: 18442240474082.1797[7FFFE9F0], adj:0, ptsOut:23858.0664, amlpts:2147226000, idx:715742, timesize:2.0019
07:46:08.603 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[7FFFE9F0], pts_in: 18442240474082.1797[7FFFE9F0], adj:0, ptsOut:23858.0664, amlpts:2147226000, idx:715742, timesize:1.9351
07:46:08.614 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 2, sz: 258, dts_in: 23860.9000[7FFFF5A8], pts_in: 23860.9000[7FFFF5A8], adj:0, ptsOut:23858.0664, amlpts:2147226000, idx:715742, timesize:1.9351
07:46:08.622 T:3035712272   DEBUG: CAMLCodec::ReleaseFrame idx:715740
07:46:08.624 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 2, sz: 439, dts_in: 23860.9333[160], pts_in: 23860.9333[160], adj:2147483648, ptsOut:23858.0664, amlpts:2147226000, idx:715742, timesize:1.9685
07:46:08.625 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 4, sz: 309, dts_in: 23860.9667[D18], pts_in: 23860.9667[D18], adj:2147483648, ptsOut:23858.1016, amlpts:2147229000, idx:715743, timesize:2.0019
07:46:08.625 T:2547315616   DEBUG: CPullupCorrection: pattern lost on diff 23860962755.555557, number of losses 1
07:46:08.636 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[D18], pts_in: 18442240474082.1797[D18], adj:2147483648, ptsOut:23858.1016, amlpts:2147229000, idx:715743, timesize:2.0352
07:46:08.661 T:3035712272   DEBUG: Previous line repeats 2 times.
07:46:08.661 T:3035712272   DEBUG: CAMLCodec::ReleaseFrame idx:715741
07:46:08.667 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[D18], pts_in: 18442240474082.1797[D18], adj:2147483648, ptsOut:23858.1016, amlpts:2147229000, idx:715743, timesize:2.0352
07:46:08.668 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 4, sz: 0, dts_in: 18442240474082.1797[D18], pts_in: 18442240474082.1797[D18], adj:2147483648, ptsOut:23858.1328, amlpts:2147232000, idx:715744, timesize:2.0352
07:46:08.678 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[D18], pts_in: 18442240474082.1797[D18], adj:2147483648, ptsOut:23858.1328, amlpts:2147232000, idx:715744, timesize:2.0352
07:46:08.686 T:3035712272   DEBUG: CAMLCodec::ReleaseFrame idx:715742
07:46:08.688 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[D18], pts_in: 18442240474082.1797[D18], adj:2147483648, ptsOut:23858.1328, amlpts:2147232000, idx:715744, timesize:2.0019
07:46:08.709 T:2547315616   DEBUG: Previous line repeats 2 times.
07:46:08.709 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 4, sz: 0, dts_in: 18442240474082.1797[D18], pts_in: 18442240474082.1797[D18], adj:2147483648, ptsOut:23858.1660, amlpts:2147235000, idx:715745, timesize:1.9685
07:46:08.720 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[D18], pts_in: 18442240474082.1797[D18], adj:2147483648, ptsOut:23858.1660, amlpts:2147235000, idx:715745, timesize:1.9685
07:46:08.721 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 4, sz: 1257, dts_in: 23861.0000[18D0], pts_in: 23861.0000[18D0], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:1.9685
07:46:09.239 T:2547315616 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
07:46:09.250 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 2, sz: 0, dts_in: 18442240474082.1797[18D0], pts_in: 18442240474082.1797[18D0], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:1.9685
07:46:09.261 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 2, sz: 403, dts_in: 23861.0333[2488], pts_in: 23861.0333[2488], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:1.9685
07:46:09.272 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 789, dts_in: 23861.0667[3040], pts_in: 23861.0667[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0019
07:46:09.282 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[3040], pts_in: 18442240474082.1797[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0352
07:46:19.062 T:2528437152   DEBUG: Previous line repeats 951 times.
07:46:19.063 T:2528437152  NOTICE: CVideoPlayerAudio::Process - stream stalled
07:46:19.064 T:2881479584   DEBUG: CVideoPlayer::HandlePlaySpeed - audio stream stalled, triggering re-sync
07:46:19.064 T:2881479584   DEBUG: CVideoPlayer::FlushBuffers - flushing buffers
07:46:19.068 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[3040], pts_in: 18442240474082.1797[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0352
07:46:19.088 T:2528437152   DEBUG: Previous line repeats 1 times.
07:46:19.088 T:2528437152   DEBUG: CDVDAudio::Flush - flush audio stream
07:46:19.088 T:2528437152   DEBUG: CDVDAudio::Pause - pausing audio stream
07:46:19.088 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[3040], pts_in: 18442240474082.1797[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0352
07:46:20.065 T:2528437152   DEBUG: Previous line repeats 94 times.
07:46:20.065 T:2528437152   DEBUG: CDVDMsgGeneralSynchronize - global timeout
07:46:20.065 T:2528437152   DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
07:46:20.065 T:2881479584   DEBUG: CDVDMsgGeneralSynchronize - global timeout
07:46:20.066 T:2881479584   DEBUG: CVideoPlayer::SetCaching - caching state 1
07:46:20.066 T:2881479584   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
07:46:20.066 T:2881479584   DEBUG: demuxer seek to: 23869403.000000
07:46:20.067 T:2881479584   DEBUG: SeekTime - unknown position after seek
07:46:20.067 T:2881479584   DEBUG: demuxer seek to: 23869403.000000, success
07:46:20.067 T:2881479584   DEBUG: CVideoPlayer::FlushBuffers - flushing buffers
07:46:20.068 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[3040], pts_in: 18442240474082.1797[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0352
07:46:20.076 T:2528437152   DEBUG: CDVDAudio::Pause - pausing audio stream
07:46:20.076 T:2528437152   DEBUG: CDVDAudio::Flush - flush audio stream
07:46:20.076 T:2528437152   DEBUG: CDVDAudio::Pause - pausing audio stream
07:46:20.078 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[3040], pts_in: 18442240474082.1797[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0352
07:46:20.080 T:3035712272   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
07:46:20.085 T:3035712272   DEBUG: ------ Window Init (Custom_1109_TopBarOverlay.xml) ------
07:46:20.085 T:3035712272    INFO: Loading skin file: Custom_1109_TopBarOverlay.xml, load type: KEEP_IN_MEMORY
07:46:20.089 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[3040], pts_in: 18442240474082.1797[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0352
07:46:21.067 T:2528437152   DEBUG: Previous line repeats 94 times.
07:46:21.068 T:2528437152   DEBUG: CDVDMsgGeneralSynchronize - global timeout
07:46:21.068 T:2528437152   DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
07:46:21.068 T:2881479584   DEBUG: CDVDMsgGeneralSynchronize - global timeout
07:46:21.076 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[3040], pts_in: 18442240474082.1797[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0352
07:46:21.081 T:2881479584   DEBUG: CVideoPlayer::HandleMessages - player started 1
07:46:21.086 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[3040], pts_in: 18442240474082.1797[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0352
07:46:23.869 T:3035712272   DEBUG: Previous line repeats 270 times.
07:46:23.869 T:3035712272   DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
07:46:23.869 T:3035712272   DEBUG: ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------
07:46:23.872 T:2547315616   DEBUG: CAMLCodec::Decode: ret: 0, sz: 0, dts_in: 18442240474082.1797[3040], pts_in: 18442240474082.1797[3040], adj:2147483648, ptsOut:23858.1992, amlpts:2147238000, idx:715746, timesize:2.0352

Display More

I've also seen that the code in AMLCodec.cpp which should handle this overflow gracefully was changed between Jarvis and Krypton.

Maybe it's here to search?