Like a couple other folks, I’m experiencing a random freeze. The video seems to pause, skip, then I see buffer 100% (even though what I see on screen shows plenty of pre-buffer available). Unit becomes unresponsive. SSH is super delayed as kswapd0 is pegging at 100%. Unplugging power is the only way to reset it. I don’t use my unit everyday but it happens every time I try to use it, usually about 20 or so minutes into a video, and sometimes twice in the same day.
I don’t think I have any rogue add-ons but I have tweaked a bit trying to get skins to run. So many issues with dependencies and versions of helper programs that are required, but don’t actually work (different subject).
I did have some issues getting the latest version/update installed. And I see in the logs it says “OSMC Build Information error”, not sure if that’s normal.
I see I need to clean my library, lots of missing folders (deleted or moved).
Anyway, I was able to grab logs. https://paste.osmc.tv/ruyamolete
I think I’ll try to move/reset my .kodi directory to start over and get rid of those skins and helper add-ons…something isn’t right. The last time I messed with the skins/dependencies was about a month ago and the freezing just started a week ago, not aware of any changes I made around that time.
Hi,
This is fine. I added some information so we can see when a filesystem was built about a year ago. This means that we can tell what version of OSMC a user initially installed; which isn’t always clear through logs. Older versions don’t have this timestamp file, so show this error.
Your logs show a memory allocation issue:
[433944.811380] Call trace:
[433944.811387] [ffffff80203332b0+ 112][<ffffff800908a5b0>] dump_backtrace+0x0/0x214
[433944.811393] [ffffff8020333320+ 32][<ffffff800908a844>] show_stack+0x24/0x30
[433944.811399] [ffffff8020333340+ 48][<ffffff80093d0e58>] dump_stack+0x98/0xc0
[433944.811404] [ffffff8020333370+ 144][<ffffff8009192560>] warn_alloc+0xfc/0x118
[433944.811409] [ffffff8020333400+ 320][<ffffff80091930ec>] __alloc_pages_nodemask+0xb00/0xc0c
[433944.811414] [ffffff8020333540+ 128][<ffffff80091daa58>] new_slab+0x1d8/0x4e0
[433944.811418] [ffffff80203335c0+ 224][<ffffff80091dc520>] ___slab_alloc.constprop.27+0x258/0x350
[433944.811423] [ffffff80203336a0+ 48][<ffffff80091dc660>] __slab_alloc.isra.21.constprop.26+0x48/0x5c
[433944.811428] [ffffff80203336d0+ 80][<ffffff80091dc73c>] kmem_cache_alloc+0xc8/0x250
[433944.811433] [ffffff8020333720+ 80][<ffffff80093c7ff4>] bfq_get_queue+0xdc/0x244
[433944.811439] [ffffff8020333770+ 112][<ffffff80093c825c>] bfq_set_request+0x100/0x4c4
[433944.811446] [ffffff80203337e0+ 48][<ffffff80093a2d44>] elv_set_request+0x4c/0x64
[433944.811451] [ffffff8020333810+ 224][<ffffff80093a7468>] get_request+0x440/0x6a4
[433944.811456] [ffffff80203338f0+ 80][<ffffff80093aa020>] blk_queue_bio+0x8c/0x360
[433944.811460] [ffffff8020333940+ 80][<ffffff80093a7fc0>] generic_make_request+0xc4/0x1e0
[433944.811465] [ffffff8020333990+ 96][<ffffff80093a820c>] submit_bio+0x130/0x17c
[433944.811472] [ffffff80203339f0+ 32][<ffffff80092ca0a8>] ext4_submit_bio_read+0x4c/0x58
[433944.811477] [ffffff8020333a10+ 256][<ffffff80092ca530>] ext4_mpage_readpages+0x47c/0x600
[433944.811483] [ffffff8020333b10+ 48][<ffffff8009284e18>] ext4_readpages+0x50/0x68
[433944.811488] [ffffff8020333b40+ 208][<ffffff80091987e4>] __do_page_cache_readahead+0xec/0x240
[433944.811493] [ffffff8020333c10+ 112][<ffffff800918bd18>] filemap_fault+0x220/0x528
[433944.811499] [ffffff8020333c80+ 48][<ffffff800928e6fc>] ext4_filemap_fault+0x40/0x60
[433944.811505] [ffffff8020333cb0+ 112][<ffffff80091b9c9c>] __do_fault+0x74/0xec
[433944.811510] [ffffff8020333d20+ 160][<ffffff80091be070>] handle_mm_fault+0x5dc/0xbf4
[433944.811515] [ffffff8020333dc0+ 112][<ffffff8009099570>] do_page_fault+0x1fc/0x338
[433944.811520] [ffffff8020333e30+ 48][<ffffff8009099700>] do_translation_fault+0x54/0x70
[433944.811524] [ffffff8020333e60+ 48][<ffffff80090812a8>] do_mem_abort+0x54/0x94
[433944.811527] Exception stack(0xffffff8020333e70 to 0xffffff8020333fa0)
[433944.811531] 3e60: 00000000f6c7dca0 0000000082000007
[433944.811535] 3e80: ffffff8020333ec0 00000000f6c7dca0 0000000000000000 ffffff800908350c
[433944.811539] 3ea0: 0000000000400000 000000406a838000 ffffffffffffffff 0000000000077fb1
[433944.811543] 3ec0: 000000000000000e 0000000000000001 0000000000000770 0000000000000000
[433944.811547] 3ee0: 0000000000000000 0000000000000017 0000000000000000 000000000000008e
[433944.811551] 3f00: 0000000000000000 00000000ab0d456c 00000000ffc6d52c 00000000ab0d456c
[433944.811555] 3f20: 000000000000008e 00000000ffc6d1e0 00000000f6c7dca1 0000000000000000
[433944.811559] 3f40: 0000000000000000 0000000000000000 0000000000000000 0000000000000000
[433944.811562] 3f60: 0000000000000000 0000000000000000 0000000000000000 0000000000000000
[433944.811566] 3f80: 0000000000000000 0000000000000000 0000000000000000 0000000000000000
[433944.811570] [ffffff8020333e90+ 0][<ffffff8009081340>] do_el0_ia_bp_hardening+0x40/0x50
[433944.811573] Exception stack(0xffffff8020333ea0 to 0xffffff8020333fd0)
[433944.811577] 3ea0: 0000000000400000 000000406a838000 ffffffffffffffff 0000000000077fb1
[433944.811581] 3ec0: 000000000000000e 0000000000000001 0000000000000770 0000000000000000
[433944.811584] 3ee0: 0000000000000000 0000000000000017 0000000000000000 000000000000008e
[433944.811588] 3f00: 0000000000000000 00000000ab0d456c 00000000ffc6d52c 00000000ab0d456c
[433944.811592] 3f20: 000000000000008e 00000000ffc6d1e0 00000000f6c7dca1 0000000000000000
[433944.811596] 3f40: 0000000000000000 0000000000000000 0000000000000000 0000000000000000
[433944.811599] 3f60: 0000000000000000 0000000000000000 0000000000000000 0000000000000000
[433944.811603] 3f80: 0000000000000000 0000000000000000 0000000000000000 0000000000000000
[433944.811606] 3fa0: 0000000000000000 0000000000000000 0000000000000000 0000000000000000
[433944.811609] 3fc0: 00000000f6c7dca0 0000000080000030
[433944.811614] [0000000000000000+ 0][<ffffff800908350c>] el0_ia+0x18/0x1c
In this case, even ntpd (lightweight time daemon) could not get enough memory to operate:
[433944.810864] ntpd: page allocation failure: order:0, mode:0x2204000(GFP_NOWAIT|__GFP_COMP|__GFP_NOTRACK)
If you boot Kodi and go to System Information, how much memory have you got free, and does it creep up quickly?
I’d suspect either a very heavy skin or background services hogging RAM.
Sam
After a warm boot I start with 20% used and within a minute it goes to 25 and stays there. After browsing a few movies it goes to 40 but then comes back down to 30 and sits there. And that’s repeatable. But before I booted I had about 60% used, and the 4k sat overnight with no usage. It can sit for days “just fine”, but obviously something is eating memory as I wouldn’t think sitting on the main menu for a day would warrant a constant 60%. I’ll keep playing and see if I can get it to creep up.
Recently started locking up again. I was able to pause and grab logs
https://paste.osmc.tv/avilabodew
Then it crashed (sad face), and I grabbed logs again in case it found something else…
https://paste.osmc.tv/uhubovuzig
I also keep having issues with one my Kodi rf remote not registering a bunch of keypresses. Tried resync numerous times. Works a couple presses then doesn’t for several presses, then works and stops, etc. changed batteries and checked voltage. I think the receiver keeps dropping off, keep seeing new device messages in the log when it doesn’t work…
type or paste code here Keyboard: scancode: 0x69, sym: 0x276, unicode: 0x0000, modifier: 0x0
2022-06-03 21:50:17.304 T:2783 DEBUG <general>: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 50ms
2022-06-03 21:50:17.305 T:3412 DEBUG <general>: Thread Timer start, auto delete: false
2022-06-03 21:50:17.319 T:2744 DEBUG <general>: Keyboard: scancode: 0x69, sym: 0x276, unicode: 0x0000, modifier: 0x0
2022-06-03 21:50:17.319 T:2744 DEBUG <general>: HandleKey: left (0xf082) pressed, action is Left
2022-06-03 21:50:17.369 T:3412 DEBUG <general>: Thread Timer 3510628544 terminating
2022-06-03 21:50:17.380 T:2744 DEBUG <general>: Keyboard: scancode: 0x69, sym: 0x276, unicode: 0x0000, modifier: 0x0
2022-06-03 21:50:18.681 T:2783 DEBUG <general>: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 50ms
2022-06-03 21:50:18.681 T:3421 DEBUG <general>: Thread Timer start, auto delete: false
2022-06-03 21:50:18.698 T:2744 DEBUG <general>: Keyboard: scancode: 0x69, sym: 0x276, unicode: 0x0000, modifier: 0x0
2022-06-03 21:50:18.699 T:2744 DEBUG <general>: HandleKey: left (0xf082) pressed, action is Left
2022-06-03 21:50:18.729 T:3421 DEBUG <general>: Thread Timer 3510628544 terminating
2022-06-03 21:50:18.733 T:2744 DEBUG <general>: Keyboard: scancode: 0x69, sym: 0x276, unicode: 0x0000, modifier: 0x0
2022-06-03 21:50:20.153 T:2783 DEBUG <general>: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 50ms
2022-06-03 21:50:20.153 T:3431 DEBUG <general>: Thread Timer start, auto delete: false
2022-06-03 21:50:20.175 T:2744 DEBUG <general>: Keyboard: scancode: 0x69, sym: 0x276, unicode: 0x0000, modifier: 0x0
2022-06-03 21:50:20.175 T:2744 DEBUG <general>: HandleKey: left (0xf082) pressed, action is Left
2022-06-03 21:50:20.193 T:3431 DEBUG <general>: Thread Timer 3510628544 terminating
2022-06-03 21:50:20.195 T:2744 DEBUG <general>: Keyboard: scancode: 0x69, sym: 0x276, unicode: 0x0000, modifier: 0x0
2022-06-03 21:50:21.449 T:2783 DEBUG <general>: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 50ms
2022-06-03 21:50:21.449 T:3440 DEBUG <general>: Thread Timer start, auto delete: false
2022-06-03 21:50:21.459 T:2744 DEBUG <general>: Keyboard: scancode: 0x69, sym: 0x276, unicode: 0x0000, modifier: 0x0
2022-06-03 21:50:21.459 T:2744 DEBUG <general>: HandleKey: left (0xf082) pressed, action is Left
2022-06-03 21:50:21.489 T:3440 DEBUG <general>: Thread Timer 3510628544 terminating
2022-06-03 21:50:21.489 T:2744 DEBUG <general>: Keyboard: scancode: 0x69, sym: 0x276, unicode: 0x0000, modifier: 0x0
2022-06-03 21:50:22.658 T:2783 DEBUG <general>: CLibInputHandler::DeviceRemoved - keyboard type device removed: OSMC Remote Controller USB Keyboard Mouse (event5)
2022-06-03 21:50:22.808 T:2783 DEBUG <general>: CLibInputHandler::DeviceRemoved - pointer type device removed: OSMC Remote Controller USB Keyboard Mouse (event6)
2022-06-03 21:50:22.808 T:2783 DEBUG <general>: CLibInputHandler::DeviceRemoved - keyboard type device removed: OSMC Remote Controller USB Keyboard Mouse (event6)
2022-06-03 21:50:22.984 T:2796 INFO <general>: UnregisterRemovedDevices - device removed from hid//sys/devices/platform/c9000000.dwc3/xhci-hcd.0.auto/usb1/1-2: OSMC RF Remote (2017:1688)
2022-06-03 21:50:22.984 T:2796 DEBUG <general>: ~CPeripheralHID - switching active keymapping to: default
2022-06-03 21:50:22.991 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/appcommand.xml
2022-06-03 21:50:22.991 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml
2022-06-03 21:50:22.994 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml
2022-06-03 21:50:22.998 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/customcontroller.SiriRemote.xml
2022-06-03 21:50:23.000 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/gamepad.xml
2022-06-03 21:50:23.003 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/hama_mce.xml
2022-06-03 21:50:23.003 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/joystick.xml
2022-06-03 21:50:23.007 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/keyboard.xml
2022-06-03 21:50:23.015 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/mouse.xml
2022-06-03 21:50:23.016 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/osmc_classic.xml
2022-06-03 21:50:23.018 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/remote.xml
2022-06-03 21:50:23.024 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/touchscreen.xml
2022-06-03 21:50:24.046 T:2783 DEBUG <general>: CLibInputHandler::DeviceAdded - keyboard type device added: OSMC Remote Controller USB Keyboard Mouse (event5)
2022-06-03 21:50:24.047 T:2783 DEBUG <general>: CLibInputKeyboard::GetRepeat - delay: 500ms repeat: 50ms for OSMC Remote Controller USB Keyboard Mouse (event5)
2022-06-03 21:50:24.091 T:2796 DEBUG <general>: GetMappingForDevice - device (2017:1688) mapped to OSMC RF Remote (type = hid)
2022-06-03 21:50:24.092 T:2796 DEBUG <general>: InitialiseFeature - adding keymapping for: osmc
2022-06-03 21:50:24.101 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/appcommand.xml
2022-06-03 21:50:24.102 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml
2022-06-03 21:50:24.104 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml
2022-06-03 21:50:24.108 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/customcontroller.SiriRemote.xml
2022-06-03 21:50:24.110 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/gamepad.xml
2022-06-03 21:50:24.113 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/hama_mce.xml
2022-06-03 21:50:24.114 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/joystick.xml
2022-06-03 21:50:24.119 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/keyboard.xml
2022-06-03 21:50:24.127 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/mouse.xml
2022-06-03 21:50:24.128 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/osmc_classic.xml
2022-06-03 21:50:24.130 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/remote.xml
2022-06-03 21:50:24.135 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/touchscreen.xml
2022-06-03 21:50:24.138 T:2796 INFO <general>: Loading special://xbmc/system/keymaps/osmc/osmc_remote.xml
2022-06-03 21:50:24.146 T:2783 DEBUG <general>: CLibInputHandler::DeviceAdded - pointer type device added: OSMC Remote Controller USB Keyboard Mouse (event6)
2022-06-03 21:50:24.146 T:2783 DEBUG <general>: CLibInputHandler::DeviceAdded - keyboard type device added: OSMC Remote Controller USB Keyboard Mouse (event6)
2022-06-03 21:50:24.146 T:2783 DEBUG <general>: CLibInputKeyboard::GetRepeat - could not get key repeat for event6 (Function not implemented)
2022-06-03 21:50:24.147 T:2783 DEBUG <general>: CLibInputKeyboard::GetRepeat - delay: 400ms repeat: 80ms for OSMC Remote Controller USB Keyboard Mouse (event6)
2022-06-03 21:50:24.147 T:2796 DEBUG <general>: InitialiseFeature - initialised HID device (2017:1688)
2022-06-03 21:50:24.147 T:2796 DEBUG <general>: Initialise - initialised peripheral on '/sys/devices/platform/c9000000.dwc3/xhci-hcd.0.auto/usb1/1-2' with 1 features and 0 sub devices
2022-06-03 21:50:24.147 T:2796 INFO <general>: Register - new hid device registered on usb->/sys/devices/platform/c9000000.dwc3/xhci-hcd.0.auto/usb1/1-2: OSMC RF Remote (2017:1688)
2022-06-03 21:50:41.718 T:3242 DEBUG <general>: Thread JobWorker 3229593792 terminating (autodelete)
2022-06-03 21:50:41.758 T:3233 DEBUG <general>: Thread JobWorker 3851542720 terminating (autodelete)
And once more but this time with debug logging enabled. https://paste.osmc.tv/otakevapay