4k+ crashing while browsing movies

When I browse my movies after about 20 seconds I get a sad face. Initially I didnt see anything in the logs but then I caught this in dmesg:

[1727439.528118] kthreadd invoked oom-killer: gfp_mask=0x27080c2(GFP_KERNEL_ACCOUNT|__GFP_HIGHMEM|__GFP_ZERO|__GFP_NOTRACK), nodemask=0, order=0, oom_score_adj=0
[1727439.528125] kthreadd cpuset=/ mems_allowed=0
[1727439.528137] CPU: 1 PID: 2 Comm: kthreadd Tainted: G           O    4.9.269-56-osmc #1
[1727439.528139] Hardware name: Vero4KPlus (DT)
[1727439.528142] Call trace:
[1727439.528156] [ffffff80200079c0+ 112][<ffffff800908a51c>] dump_backtrace+0x0/0x210
[1727439.528164] [ffffff8020007a30+  32][<ffffff800908a7b8>] show_stack+0x28/0x34
[1727439.528171] [ffffff8020007a50+  80][<ffffff8009bb07bc>] dump_stack+0x98/0xc0
[1727439.528177] [ffffff8020007aa0+  80][<ffffff8009bad61c>] dump_header+0x70/0x1bc
[1727439.528184] [ffffff8020007af0+  96][<ffffff8009192864>] oom_kill_process+0xc4/0x44c
[1727439.528190] [ffffff8020007b50+  64][<ffffff8009193024>] out_of_memory+0x280/0x2a0
[1727439.528196] [ffffff8020007b90+ 320][<ffffff80091987e8>] __alloc_pages_nodemask+0xa28/0xbdc
[1727439.528203] [ffffff8020007cd0+  48][<ffffff8009946d40>] aml_stack_alloc+0xe4/0x15c
[1727439.528211] [ffffff8020007d00+ 240][<ffffff800909c494>] copy_process.part.0+0xe8/0x1394
[1727439.528217] [ffffff8020007df0+  96][<ffffff800909d8dc>] _do_fork+0xcc/0x3b4
[1727439.528222] [ffffff8020007e50+  48][<ffffff800909dc74>] kernel_thread+0x4c/0x5c
[1727439.528229] [ffffff8020007e80+   0][<ffffff80090c0e8c>] kthreadd+0x14c/0x190
[1727439.528235] [0000000000000000+   0][<ffffff8009083ad0>] ret_from_fork+0x10/0x40
[1727439.528237] Mem-Info:
[1727439.528252] active_anon:327824 inactive_anon:9652 isolated_anon:0
                  active_file:1070 inactive_file:1676 isolated_file:0
                  unevictable:0 dirty:0 writeback:0 unstable:0
                  slab_reclaimable:6630 slab_unreclaimable:8635
                  mapped:3450 shmem:10560 pagetables:1069 bounce:0
                  [cma] driver:29660 anon:28368 file:657 isolate:0 total:161792
                  free:108758 free_pcp:0 free_cma:102952
[1727439.528261] Node 0 active_anon:1311296kB inactive_anon:38608kB active_file:4280kB inactive_file:6704kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:13800kB dirty:0kB writeback:0kB shmem:42240kB writeback_tmp:0kB unstable:0kB pages_scanned:12 all_unreclaimable? no
[1727439.528275] DMA free:435032kB min:32768kB low:40960kB high:49152kB active_anon:1311296kB inactive_anon:38608kB active_file:4280kB inactive_file:6704kB unevictable:0kB writepending:0kB present:2096128kB managed:2035888kB mlocked:0kB slab_reclaimable:26520kB slab_unreclaimable:34540kB kernel_stack:3552kB pagetables:4276kB bounce:0kB free_pcp:0kB local_pcp:0kB free_unmovable:15812kB free_movable:892kB free_reclaimable:4772kB free_highatomic:1968kB free_isolate:0kB free_cma:411808kB
[1727439.528276] lowmem_reserve[]: 0 0 0
[1727439.528282] DMA: 1043*4kB (UMEC) 939*8kB (UMEC) 1105*16kB (UMEHC) 672*32kB (UMEHC) 436*64kB (UMEHC) 237*128kB (MHC) 84*256kB (HC) 33*512kB (HC) 71*1024kB (C) 27*2048kB (C) 39*4096kB (C) = 435252kB
[1727439.528315] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
[1727439.528316] 13471 total pagecache pages
[1727439.528321] 0 pages in swap cache
[1727439.528324] Swap cache stats: add 0, delete 0, find 0/0
[1727439.528325] Free swap  = 0kB
[1727439.528327] Total swap = 0kB
[1727439.528328] 524032 pages RAM
[1727439.528330] 0 pages HighMem/MovableOnly
[1727439.528331] 15060 pages reserved
[1727439.528333] 161792 pages cma reserved
[1727439.528335] [ pid ]   uid  tgid total_vm      rss nr_ptes nr_pmds swapents oom_score_adj name
[1727439.528373] [ 2327]     0  2327    10818     3201      18       2        0          -250 systemd-journal
[1727439.528381] [ 2355]   104  2355     1533       84       6       2        0             0 rpcbind
[1727439.528388] [ 2360]     0  2360     4233      207       8       2        0         -1000 systemd-udevd
[1727439.528395] [ 2489]     0  2489     2737       25       6       2        0             0 apploader
[1727439.528457] [ 2490]   108  2490     1399      128       6       2        0             0 avahi-daemon
[1727439.528465] [ 2502]   106  2502     1603      171       8       2        0          -900 dbus-daemon
[1727439.528471] [ 2509]   108  2509     1342       65       6       2        0             0 avahi-daemon
[1727439.528477] [ 2514]     0  2514     4677      172      10       2        0             0 systemd-logind
[1727439.528484] [ 2517]     0  2517     2378      107       9       2        0             0 wpa_supplicant
[1727439.528491] [ 2524]     0  2524      448       47       5       2        0             0 eventlircd
[1727439.528497] [ 2544]     0  2544     1023       58       6       2        0             0 lircd
[1727439.528504] [ 2564]     0  2564     1727      122       7       2        0             0 bluetoothd
[1727439.528510] [ 2565]     0  2565     3024      161      10       2        0             0 connmand
[1727439.528517] [ 2571]  1000  2571     2374      133       9       2        0             0 udisks-glue
[1727439.528523] [ 2575]     0  2575     1663       75       7       2        0             0 mediacenter
[1727439.528529] [ 2643]     0  2643     2539      162       8       2        0         -1000 sshd
[1727439.528536] [ 2671]     0  2671     6627      103      10       2        0             0 bluealsa
[1727439.528542] [ 2672]     0  2672     1373       23       8       2        0             0 agetty
[1727439.528548] [ 2677]     0  2677     7165      196      13       2        0             0 udisks-daemon
[1727439.528555] [ 2685]     0  2685     2484       95       9       2        0             0 udisks-daemon
[1727439.528561] [ 2695]     0  2695     9338      235      15       2        0             0 polkitd
[1727439.528567] [ 2893]     0  2893     1432       48       6       2        0             0 bluealsa-aplay
[1727439.528575] [ 2917]     0  2917      390       20       4       2        0             0 hciattach
[1727439.528581] [ 2936]   105  2936     1802      137       8       2        0             0 ntpd
[1727439.528595] [ 7243]     0  7243     3016      241       9       2        0             0 sshd
[1727439.528601] [ 7246]  1000  7246     2942      257       9       2        0             0 systemd
[1727439.528607] [ 7247]  1000  7247     8219      488      13       2        0             0 (sd-pam)
[1727439.528614] [ 7265]  1000  7265     3016      241       9       2        0             0 sshd
[1727439.528620] [ 7266]  1000  7266     1861      112       8       2        0             0 bash
[1727439.528627] [ 7343]     0  7343     2857      142      10       2        0             0 sudo
[1727439.528634] [ 7344]  1000  7344   537361   322640     798       3        0             0 kodi.bin
[1727439.528641] Out of memory: Kill process 7344 (kodi.bin) score 635 or sacrifice child
[1727439.528874] Killed process 7344 (kodi.bin) total-vm:2149444kB, anon-rss:1290560kB, file-rss:0kB, shmem-rss:0kB
[1727439.911360] oom_reaper: reaped process 7344 (kodi.bin), now anon-rss:0kB, file-rss:0kB, shmem-rss:0kB
[1727439.937563] fb: osd_release now.index=0,open_count=1
[1727440.262650] vout: setting vmode to 1080p60hz
[1727440.262662] vout: don't set the same mode as current, exit
[1727440.295636] Console: switching to colour frame buffer device 240x67
[1727440.326037] fb: osd[0] canvas.idx =0x40
[1727440.326041] fb: osd[0] canvas.addr=0x75c00000
[1727440.326043] fb: osd[0] canvas.width=7680
[1727440.326045] fb: osd[0] canvas.height=2160
[1727440.326047] fb: osd[0] frame.width=1920
[1727440.326049] fb: osd[0] frame.height=1080
[1727440.326051] fb: osd[0] out_addr_id =0x0

Hi,

thx for this info but we need always a full log set.
The best way to get this information is for you to upload logs that demonstrate your problem. You can learn more about how to submit a useful support request here.

Depending on the used skin you have to set the settings-level to standard or higher, in summary:

  • enable debug logging at settings->system->logging

  • reboot the OSMC device twice(!)

  • reproduce the issue

  • upload the log set (all configs and logs!) either using the Log Uploader method within the My OSMC menu in the GUI or the ssh method invoking command grab-logs -A

  • publish the provided URL from the log set upload, here

Thanks for your understanding. We hope that we can help you get up and running again shortly.

OSMC skin screenshot:

Thanks @JimKnopf - After the latest update, I cannot reproduce it. I turned on the debugging and tried to get it to crash again and it’s not. So perhaps the database update between versions made it happy.