-- Logs begin at Wed 2025-07-16 11:17:01 UTC, end at Wed 2025-07-16 12:28:23 UTC. -- Jul 16 12:28:14 qi63 kernel: INFO: task kworker/3:0:2664 blocked for more than 120 seconds. Jul 16 12:28:14 qi63 kernel: Tainted: G C 4.19.118-v7+ #1311 Jul 16 12:28:14 qi63 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jul 16 12:28:14 qi63 kernel: kworker/3:0 D 0 2664 2 0x00000000 Jul 16 12:28:14 qi63 kernel: Workqueue: events_freezable mmc_rescan Jul 16 12:28:14 qi63 kernel: [<8086e56c>] (__schedule) from [<8086ebdc>] (schedule+0x50/0xa8) Jul 16 12:28:14 qi63 kernel: [<8086ebdc>] (schedule) from [<806c1ed8>] (__mmc_claim_host+0x120/0x228) Jul 16 12:28:14 qi63 kernel: [<806c1ed8>] (__mmc_claim_host) from [<806c2018>] (mmc_get_card+0x38/0x3c) Jul 16 12:28:14 qi63 kernel: [<806c2018>] (mmc_get_card) from [<806cb0c0>] (mmc_sd_detect+0x24/0x7c) Jul 16 12:28:14 qi63 kernel: [<806cb0c0>] (mmc_sd_detect) from [<806c465c>] (mmc_rescan+0x1cc/0x39c) Jul 16 12:28:14 qi63 kernel: [<806c465c>] (mmc_rescan) from [<8013c498>] (process_one_work+0x170/0x458) Jul 16 12:28:14 qi63 kernel: [<8013c498>] (process_one_work) from [<8013c7dc>] (worker_thread+0x5c/0x5a4) Jul 16 12:28:14 qi63 kernel: [<8013c7dc>] (worker_thread) from [<80142b10>] (kthread+0x138/0x168) Jul 16 12:28:14 qi63 kernel: [<80142b10>] (kthread) from [<801010ac>] (ret_from_fork+0x14/0x28) Jul 16 12:28:14 qi63 kernel: Exception stack(0x9ee1dfb0 to 0x9ee1dff8) Jul 16 12:28:14 qi63 kernel: dfa0: 00000000 00000000 00000000 00000000 Jul 16 12:28:14 qi63 kernel: dfc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Jul 16 12:28:14 qi63 kernel: dfe0: 00000000 00000000 00000000 00000000 00000013 00000000 Jul 16 12:28:14 qi63 kernel: cron invoked oom-killer: gfp_mask=0x7080c0(GFP_KERNEL_ACCOUNT|__GFP_ZERO), nodemask=(null), order=1, oom_score_adj=0 Jul 16 12:28:14 qi63 kernel: cron cpuset=/ mems_allowed=0 Jul 16 12:28:14 qi63 kernel: CPU: 2 PID: 705 Comm: cron Tainted: G C 4.19.118-v7+ #1311 Jul 16 12:28:14 qi63 kernel: Hardware name: BCM2835 Jul 16 12:28:14 qi63 kernel: [<801120c8>] (unwind_backtrace) from [<8010d5fc>] (show_stack+0x20/0x24) Jul 16 12:28:14 qi63 kernel: [<8010d5fc>] (show_stack) from [<80856da8>] (dump_stack+0xe0/0x124) Jul 16 12:28:14 qi63 kernel: [<80856da8>] (dump_stack) from [<80261dd8>] (dump_header+0x80/0x250) Jul 16 12:28:14 qi63 kernel: [<80261dd8>] (dump_header) from [<80261140>] (oom_kill_process+0x354/0x3a4) Jul 16 12:28:14 qi63 kernel: [<80261140>] (oom_kill_process) from [<80261a70>] (out_of_memory+0x134/0x37c) Jul 16 12:28:14 qi63 kernel: [<80261a70>] (out_of_memory) from [<80267ed8>] (__alloc_pages_nodemask+0x1020/0x1174) Jul 16 12:28:14 qi63 kernel: [<80267ed8>] (__alloc_pages_nodemask) from [<8011dfd8>] (copy_process.part.5+0x1f8/0x1b14) Jul 16 12:28:14 qi63 kernel: [<8011dfd8>] (copy_process.part.5) from [<8011fabc>] (_do_fork+0xd8/0x434) Jul 16 12:28:14 qi63 kernel: [<8011fabc>] (_do_fork) from [<8011ff3c>] (sys_clone+0x34/0x3c) Jul 16 12:28:14 qi63 kernel: [<8011ff3c>] (sys_clone) from [<80101000>] (ret_fast_syscall+0x0/0x28) Jul 16 12:28:14 qi63 kernel: Exception stack(0xb33f7fa8 to 0xb33f7ff0) Jul 16 12:28:14 qi63 kernel: 7fa0: 76f41068 7eaa6cb8 01200011 00000000 00000000 00000000 Jul 16 12:28:14 qi63 kernel: 7fc0: 76f41068 7eaa6cb8 00000000 00000078 00000000 76eb4000 00000000 7eaa6cf4 Jul 16 12:28:14 qi63 kernel: 7fe0: 76f41000 7eaa6cb8 00000000 76e15178 Jul 16 12:28:14 qi63 kernel: Mem-Info: Jul 16 12:28:14 qi63 kernel: active_anon:191384 inactive_anon:12594 isolated_anon:0 active_file:227 inactive_file:237 isolated_file:0 unevictable:0 dirty:0 writeback:0 unstable:0 slab_reclaimable:3200 slab_unreclaimable:4427 mapped:12116 shmem:13177 pagetables:1919 bounce:0 free:4485 free_pcp:150 free_cma:0 Jul 16 12:28:14 qi63 kernel: Node 0 active_anon:765536kB inactive_anon:50376kB active_file:908kB inactive_file:948kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:48464kB dirty:0kB writeback:0kB shmem:52708kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no Jul 16 12:28:14 qi63 kernel: Normal free:17940kB min:16384kB low:20480kB high:24576kB active_anon:765536kB inactive_anon:50376kB active_file:1064kB inactive_file:1048kB unevictable:0kB writepending:0kB present:917504kB managed:895500kB mlocked:0kB kernel_stack:2584kB pagetables:7676kB bounce:0kB free_pcp:600kB local_pcp:0kB free_cma:0kB Jul 16 12:28:14 qi63 kernel: lowmem_reserve[]: 0 0 Jul 16 12:28:14 qi63 kernel: Normal: 854*4kB (UMEH) 501*8kB (UMEH) 258*16kB (UMEH) 51*32kB (UMEH) 18*64kB (MEH) 14*128kB (UMEH) 0*256kB 0*512kB 0*1024kB 1*2048kB (H) 0*4096kB = 18176kB Jul 16 12:28:14 qi63 kernel: 13672 total pagecache pages Jul 16 12:28:14 qi63 kernel: 0 pages in swap cache Jul 16 12:28:14 qi63 kernel: Swap cache stats: add 0, delete 0, find 0/0 Jul 16 12:28:14 qi63 kernel: Free swap = 0kB Jul 16 12:28:14 qi63 kernel: Total swap = 0kB Jul 16 12:28:14 qi63 kernel: 229376 pages RAM Jul 16 12:28:14 qi63 kernel: 0 pages HighMem/MovableOnly Jul 16 12:28:14 qi63 kernel: 5501 pages reserved Jul 16 12:28:14 qi63 kernel: 2048 pages cma reserved Jul 16 12:28:14 qi63 kernel: Tasks state (memory values in pages): Jul 16 12:28:14 qi63 kernel: [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name Jul 16 12:28:14 qi63 kernel: [ 182] 0 182 2060 497 14336 0 0 systemd-journal Jul 16 12:28:14 qi63 kernel: [ 207] 0 207 2966 180 16384 0 -1000 systemd-udevd Jul 16 12:28:14 qi63 kernel: [ 604] 0 604 527 45 12288 0 0 dhcpcd Jul 16 12:28:14 qi63 kernel: [ 663] 0 663 1093 75 12288 0 0 rpcbind Jul 16 12:28:14 qi63 kernel: [ 673] 103 673 1140 115 14336 0 0 rpc.statd Jul 16 12:28:14 qi63 kernel: [ 690] 0 690 716 40 10240 0 0 rpc.idmapd Jul 16 12:28:14 qi63 kernel: [ 692] 0 692 1887 764 16384 0 0 haveged Jul 16 12:28:14 qi63 kernel: [ 695] 1000 695 2017 83 18432 0 0 udisks-glue Jul 16 12:28:14 qi63 kernel: [ 700] 1000 700 8034 174 26624 0 0 volumio-remote- Jul 16 12:28:14 qi63 kernel: [ 701] 0 701 732 39 12288 0 0 volumiologrotat Jul 16 12:28:14 qi63 kernel: [ 705] 0 705 853 49 10240 0 0 cron Jul 16 12:28:14 qi63 kernel: [ 713] 114 713 11146 89 20480 0 0 memcached Jul 16 12:28:14 qi63 kernel: [ 715] 0 715 826 50 10240 0 0 systemd-logind Jul 16 12:28:14 qi63 kernel: [ 752] 104 752 1379 84 14336 0 0 avahi-daemon Jul 16 12:28:14 qi63 kernel: [ 756] 110 756 30732 862 83968 0 0 mpd Jul 16 12:28:14 qi63 kernel: [ 764] 102 764 1541 138 18432 0 -900 dbus-daemon Jul 16 12:28:14 qi63 kernel: [ 833] 0 833 447 19 10240 0 0 ifplugd Jul 16 12:28:14 qi63 kernel: [ 834] 65534 834 552 28 10240 0 0 thd Jul 16 12:28:14 qi63 kernel: [ 892] 104 892 1353 67 12288 0 0 avahi-daemon Jul 16 12:28:14 qi63 kernel: [ 895] 100 895 1416 101 14336 0 0 ntpd Jul 16 12:28:14 qi63 kernel: [ 942] 0 942 4507 135 20480 0 0 udisks-daemon Jul 16 12:28:14 qi63 kernel: [ 990] 0 990 1947 105 16384 0 -1000 sshd Jul 16 12:28:14 qi63 kernel: [ 995] 0 995 2140 76 16384 0 0 udisks-daemon Jul 16 12:28:14 qi63 kernel: [ 1003] 0 1003 1020 26 14336 0 0 agetty Jul 16 12:28:14 qi63 kernel: [ 1004] 0 1004 553 26 12288 0 0 agetty Jul 16 12:28:14 qi63 kernel: [ 1040] 0 1040 9130 196 24576 0 0 polkitd Jul 16 12:28:14 qi63 kernel: [ 1176] 1000 1176 50082 15603 299008 0 0 node Jul 16 12:28:14 qi63 kernel: [ 1191] 0 1191 5351 305 28672 0 0 nmbd Jul 16 12:28:14 qi63 kernel: [ 1192] 0 1192 5208 289 28672 0 0 nmbd Jul 16 12:28:14 qi63 kernel: [ 1194] 0 1194 7143 364 36864 0 0 winbindd Jul 16 12:28:14 qi63 kernel: [ 1201] 0 1201 7141 360 36864 0 0 winbindd Jul 16 12:28:14 qi63 kernel: [ 1208] 0 1208 8886 463 43008 0 0 smbd Jul 16 12:28:14 qi63 kernel: [ 1214] 0 1214 7143 364 36864 0 0 winbindd Jul 16 12:28:14 qi63 kernel: [ 1215] 0 1215 7142 359 34816 0 0 winbindd Jul 16 12:28:14 qi63 kernel: [ 1216] 0 1216 8886 431 40960 0 0 smbd Jul 16 12:28:14 qi63 kernel: [ 1259] 1000 1259 18279 1615 88064 0 0 node Jul 16 12:28:14 qi63 kernel: [ 1265] 1000 1265 28908 3271 135168 0 0 node Jul 16 12:28:14 qi63 kernel: [ 1266] 1000 1266 28908 3256 133120 0 0 node Jul 16 12:28:14 qi63 kernel: [ 1271] 1000 1271 28836 3176 135168 0 0 node Jul 16 12:28:14 qi63 kernel: [ 1342] 0 1342 453 11 10240 0 0 start.sh Jul 16 12:28:14 qi63 kernel: [ 1348] 0 1348 19816 3725 67584 0 0 mono-sgen Jul 16 12:28:14 qi63 kernel: [ 1362] 1000 1362 728 19 12288 0 0 bash Jul 16 12:28:14 qi63 kernel: [ 1366] 1000 1366 2701 102 18432 0 0 vollibrespot Jul 16 12:28:14 qi63 kernel: [ 1387] 0 1387 22357 3391 71680 0 0 mono-sgen Jul 16 12:28:14 qi63 kernel: [ 1393] 0 1393 521 12 10240 0 0 processreaper Jul 16 12:28:14 qi63 kernel: [ 1395] 0 1395 25583 1915 75776 0 0 mono-sgen Jul 16 12:28:14 qi63 kernel: [ 1458] 1000 1458 453 19 10240 0 0 startx Jul 16 12:28:14 qi63 kernel: [ 1482] 1000 1482 796 23 12288 0 0 xinit Jul 16 12:28:14 qi63 kernel: [ 1483] 1000 1483 30740 5603 106496 0 0 Xorg Jul 16 12:28:14 qi63 kernel: [ 1518] 999 1518 38697 2020 69632 0 0 shairport-sync Jul 16 12:28:14 qi63 kernel: [ 1525] 1000 1525 27919 240 51200 0 0 upmpdcli Jul 16 12:28:14 qi63 kernel: [ 1574] 1000 1574 731 38 12288 0 0 volumiokiosk.sh Jul 16 12:28:14 qi63 kernel: [ 1599] 1000 1599 901 48 10240 0 0 ssh-agent Jul 16 12:28:14 qi63 kernel: [ 1607] 1000 1607 4920 394 24576 0 0 openbox Jul 16 12:28:14 qi63 kernel: [ 1609] 1000 1609 136889 7025 294912 0 0 chromium-browse Jul 16 12:28:14 qi63 kernel: [ 1626] 1000 1626 217766 281 45056 0 0 streaming-daemo Jul 16 12:28:14 qi63 kernel: [ 1667] 1000 1667 22364 250 30720 0 0 pulseaudio Jul 16 12:28:14 qi63 kernel: [ 1670] 113 1670 5748 57 20480 0 0 rtkit-daemon Jul 16 12:28:14 qi63 kernel: [ 1691] 1000 1691 42652 1047 131072 0 0 chromium-browse Jul 16 12:28:14 qi63 kernel: [ 1701] 0 1701 1562 70 16384 0 0 bluetoothd Jul 16 12:28:14 qi63 kernel: [ 1713] 1000 1713 42652 1055 65536 0 0 chromium-browse Jul 16 12:28:14 qi63 kernel: [ 1716] 1000 1716 453 15 10240 0 0 start-pulseaudi Jul 16 12:28:14 qi63 kernel: [ 1717] 1000 1717 1044 45 12288 0 0 xprop Jul 16 12:28:14 qi63 kernel: [ 1760] 1000 1760 112039 20150 421888 0 300 chromium-browse Jul 16 12:28:14 qi63 kernel: [ 1824] 0 1824 1202 79 12288 0 0 cron Jul 16 12:28:14 qi63 kernel: [ 1828] 1000 1828 453 11 12288 0 0 sh Jul 16 12:28:14 qi63 kernel: [ 1829] 1000 1829 727 36 12288 0 0 run_peppymeter. Jul 16 12:28:14 qi63 kernel: [ 1831] 1000 1831 167912 126935 595968 0 0 python3 Jul 16 12:28:14 qi63 kernel: [ 4796] 1000 4796 720 21 10240 0 0 getvolume Jul 16 12:28:14 qi63 kernel: [ 4799] 0 4799 1182 68 12288 0 0 cron Jul 16 12:28:14 qi63 kernel: [ 4805] 0 4805 1032 61 12288 0 0 cron Jul 16 12:28:14 qi63 kernel: [ 4807] 0 4807 7143 359 30720 0 0 winbindd Jul 16 12:28:14 qi63 kernel: [ 4811] 0 4811 977 53 12288 0 0 cron Jul 16 12:28:14 qi63 kernel: [ 4813] 0 4813 977 53 12288 0 0 cron Jul 16 12:28:14 qi63 kernel: [ 4816] 0 4816 977 56 12288 0 0 cron Jul 16 12:28:14 qi63 kernel: [ 4819] 0 4819 977 53 12288 0 0 cron Jul 16 12:28:14 qi63 kernel: [ 4821] 0 4821 894 50 12288 0 0 cron Jul 16 12:28:14 qi63 kernel: Out of memory: Kill process 1831 (python3) score 567 or sacrifice child Jul 16 12:28:14 qi63 kernel: Killed process 1831 (python3) total-vm:671648kB, anon-rss:504140kB, file-rss:0kB, shmem-rss:3600kB Jul 16 12:28:14 qi63 kernel: oom_reaper: reaped process 1831 (python3), now anon-rss:0kB, file-rss:0kB, shmem-rss:3600kB Jul 16 12:26:03 qi63 shairport-sync[1518]: an unrecoverable error, "unable_to_cancel_play_session", has been detected. Jul 16 12:28:17 qi63 systemd[1]: systemd-journald.service watchdog timeout (limit 1min)! Jul 16 12:28:17 qi63 systemd-journal[182]: Journal stopped Jul 16 12:28:18 qi63 systemd-journal[4870]: Runtime journal is using 4.0M (max allowed 30.0M, trying to leave 65.5M free of 432.6M available → current limit 30.0M). Jul 16 12:28:18 qi63 systemd-journald[182]: Received SIGTERM from PID 1 (systemd). Jul 16 12:28:18 qi63 systemd[1]: Unit systemd-journald.service entered failed state. Jul 16 12:28:18 qi63 systemd[1]: systemd-journald.service has no holdoff time, scheduling restart. Jul 16 12:28:18 qi63 systemd[1]: Stopping Journal Service... Jul 16 12:28:18 qi63 systemd[1]: Starting Journal Service... Jul 16 12:28:18 qi63 systemd[1]: Started Journal Service. Jul 16 12:28:18 qi63 systemd-journal[4870]: Journal started Jul 16 12:28:17 qi63 CRON[1824]: pam_unix(cron:session): session closed for user volumio Jul 16 12:28:17 qi63 systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Jul 16 12:28:18 qi63 CRON[4821]: pam_unix(cron:session): session opened for user volumio by (uid=0) Jul 16 12:28:18 qi63 CRON[4805]: pam_unix(cron:session): session opened for user volumio by (uid=0) Jul 16 12:28:18 qi63 CRON[4799]: pam_unix(cron:session): session opened for user volumio by (uid=0) Jul 16 12:28:18 qi63 CRON[4813]: pam_unix(cron:session): session opened for user volumio by (uid=0) Jul 16 12:28:18 qi63 CRON[4886]: (volumio) CMD (/home/volumio/PeppyMeter/run_peppymeter.sh > /dev/null 2>&1) Jul 16 12:28:18 qi63 CRON[4885]: (volumio) CMD (/home/volumio/PeppyMeter/run_peppymeter.sh > /dev/null 2>&1) Jul 16 12:28:18 qi63 CRON[4887]: (volumio) CMD (/home/volumio/PeppyMeter/run_peppymeter.sh > /dev/null 2>&1) Jul 16 12:28:18 qi63 CRON[4884]: (volumio) CMD (/home/volumio/PeppyMeter/run_peppymeter.sh > /dev/null 2>&1) Jul 16 12:28:18 qi63 CRON[4811]: pam_unix(cron:session): session opened for user volumio by (uid=0) Jul 16 12:28:18 qi63 CRON[4819]: pam_unix(cron:session): session opened for user volumio by (uid=0) Jul 16 12:28:18 qi63 CRON[4900]: (volumio) CMD (/home/volumio/PeppyMeter/run_peppymeter.sh > /dev/null 2>&1) Jul 16 12:28:18 qi63 CRON[4901]: (volumio) CMD (/home/volumio/PeppyMeter/run_peppymeter.sh > /dev/null 2>&1) Jul 16 12:28:18 qi63 CRON[4816]: pam_unix(cron:session): session opened for user volumio by (uid=0) Jul 16 12:28:18 qi63 CRON[4908]: (volumio) CMD (/home/volumio/PeppyMeter/run_peppymeter.sh > /dev/null 2>&1) Jul 16 12:28:18 qi63 systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Jul 16 12:28:18 qi63 CRON[4822]: pam_unix(cron:session): session opened for user volumio by (uid=0) Jul 16 12:28:18 qi63 CRON[4922]: (volumio) CMD (/home/volumio/PeppyMeter/run_peppymeter.sh > /dev/null 2>&1) Jul 16 12:28:18 qi63 CRON[4822]: pam_unix(cron:session): session closed for user volumio Jul 16 12:28:23 qi63 sudo[4937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-16 12:27 Jul 16 12:28:23 qi63 sudo[4937]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e81b2037a65d8f554cb0c857a1007d659ad7f838" VOLUMIO_FE_VERSION="e489037accd8e0b2dcbd6e0b054400d8cd36d4e2" VOLUMIO_BE_VERSION="25875b197c75cd1ac7eb5664d94cdd19afb06985" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Feb 19 17:39:10 CET 2021" VOLUMIO_VERSION="2.873" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="781d4c9fbf86d562939968306a6a26f4"