2月 12 13:31:18 raspi volumio[1207]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri 2月 12 13:31:18 raspi volumio[1207]: info: CURURI: music-library 2月 12 13:31:18 raspi volumio[1207]: info: Preload queue cleared 2月 12 13:31:19 raspi volumio[1207]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri 2月 12 13:31:19 raspi volumio[1207]: info: CURURI: music-library/USB 2月 12 13:31:19 raspi volumio[1207]: info: Preload queue cleared 2月 12 13:31:20 raspi volumio[1207]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri 2月 12 13:31:20 raspi volumio[1207]: info: CURURI: music-library/USB/Music 2月 12 13:31:20 raspi volumio[1207]: info: Preload queue cleared 2月 12 13:31:49 raspi kernel: mount.ntfs invoked oom-killer: gfp_mask=0x140cc0(GFP_USER|__GFP_COMP), order=0, oom_score_adj=0 2月 12 13:31:49 raspi kernel: CPU: 3 UID: 0 PID: 1348 Comm: mount.ntfs Tainted: G C 6.12.47-v7l+ #1904 2月 12 13:31:49 raspi kernel: Tainted: [C]=CRAP 2月 12 13:31:49 raspi kernel: Hardware name: BCM2711 2月 12 13:31:49 raspi kernel: Call trace: 2月 12 13:31:49 raspi kernel: unwind_backtrace from show_stack+0x18/0x1c 2月 12 13:31:49 raspi kernel: show_stack from dump_stack_lvl+0x5c/0x80 2月 12 13:31:49 raspi kernel: dump_stack_lvl from dump_header+0x50/0x180 2月 12 13:31:49 raspi kernel: dump_header from oom_kill_process+0x230/0x2a0 2月 12 13:31:49 raspi kernel: oom_kill_process from out_of_memory+0x104/0x34c 2月 12 13:31:49 raspi kernel: out_of_memory from __alloc_pages_noprof+0xa60/0x1008 2月 12 13:31:49 raspi kernel: __alloc_pages_noprof from __folio_alloc_noprof+0x14/0x20 2月 12 13:31:49 raspi kernel: __folio_alloc_noprof from filemap_get_pages+0x1a4/0x7ac 2月 12 13:31:49 raspi kernel: filemap_get_pages from filemap_read+0x104/0x4a0 2月 12 13:31:49 raspi kernel: filemap_read from blkdev_read_iter+0x8c/0x190 2月 12 13:31:49 raspi kernel: blkdev_read_iter from vfs_read+0x20c/0x310 2月 12 13:31:49 raspi kernel: vfs_read from sys_pread64+0xa0/0xd0 2月 12 13:31:49 raspi kernel: sys_pread64 from ret_fast_syscall+0x0/0x5c 2月 12 13:31:49 raspi kernel: Exception stack(0xf0eb9fa8 to 0xf0eb9ff0) 2月 12 13:31:49 raspi kernel: 9fa0: c63ba000 00000024 00000003 018c3ed8 00020000 00000000 2月 12 13:31:49 raspi kernel: 9fc0: c63ba000 00000024 04733000 000000b4 0001c374 00000001 b6ee8268 beb0b6cc 2月 12 13:31:49 raspi kernel: 9fe0: b6ef31f4 beb0b688 b6ee82a4 b6dd87c4 2月 12 13:31:49 raspi kernel: Mem-Info: 2月 12 13:31:49 raspi kernel: active_anon:554 inactive_anon:39952 isolated_anon:0 active_file:26480 inactive_file:97358 isolated_file:0 unevictable:4 dirty:3676 writeback:0 slab_reclaimable:4940 slab_unreclaimable:6115 mapped:43416 shmem:1519 pagetables:1422 sec_pagetables:0 bounce:0 kernel_misc_reclaimable:0 free:1824634 free_pcp:0 free_cma:128675 2月 12 13:31:49 raspi kernel: Node 0 active_anon:2216kB inactive_anon:159808kB active_file:105920kB inactive_file:389432kB unevictable:16kB isolated(anon):0kB isolated(file):0kB mapped:173664kB dirty:14704kB writeback:0kB shmem:6076kB writeback_tmp:0kB kernel_stack:2640kB pagetables:5688kB sec_pagetables:0kB all_unreclaimable? no 2月 12 13:31:49 raspi kernel: DMA free:564664kB boost:36864kB min:53248kB low:57344kB high:61440kB reserved_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:1344kB inactive_file:1480kB unevictable:0kB writepending:24kB present:786432kB managed:626196kB mlocked:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:514700kB 2月 12 13:31:49 raspi kernel: lowmem_reserve[]: 0 0 7232 7232 2月 12 13:31:49 raspi kernel: DMA: 668*4kB (UC) 371*8kB (UC) 276*16kB (UC) 187*32kB (UC) 135*64kB (UC) 43*128kB (UC) 24*256kB (UC) 19*512kB (UC) 9*1024kB (UMC) 1*2048kB (C) 124*4096kB (C) = 565224kB 2月 12 13:31:49 raspi kernel: 125363 total pagecache pages 2月 12 13:31:49 raspi kernel: 0 pages in swap cache 2月 12 13:31:49 raspi kernel: Free swap = 0kB 2月 12 13:31:49 raspi kernel: Total swap = 0kB 2月 12 13:31:49 raspi kernel: 2048000 pages RAM 2月 12 13:31:49 raspi kernel: 1851392 pages HighMem/MovableOnly 2月 12 13:31:49 raspi kernel: 40059 pages reserved 2月 12 13:31:49 raspi kernel: 131072 pages cma reserved 2月 12 13:31:49 raspi kernel: Tasks state (memory values in pages): 2月 12 13:31:49 raspi kernel: [ pid ] uid tgid total_vm rss rss_anon rss_file rss_shmem pgtables_bytes swapents oom_score_adj name 2月 12 13:31:49 raspi kernel: [ 466] 0 466 4679 1837 192 1453 192 65536 0 -250 systemd-journal 2月 12 13:31:49 raspi kernel: [ 488] 0 488 6007 1234 256 978 0 49152 0 -1000 systemd-udevd 2月 12 13:31:49 raspi kernel: [ 723] 0 723 1959 1146 764 382 0 45056 0 0 haveged 2月 12 13:31:49 raspi kernel: [ 730] 108 730 1731 813 64 749 0 40960 0 0 rpcbind 2月 12 13:31:49 raspi kernel: [ 731] 992 731 5856 1481 128 1353 0 61440 0 0 systemd-timesyn 2月 12 13:31:49 raspi kernel: [ 833] 103 833 1571 838 64 774 0 36864 0 0 avahi-daemon 2月 12 13:31:49 raspi kernel: [ 835] 0 835 2738 1310 64 1246 0 40960 0 0 bluetoothd 2月 12 13:31:49 raspi kernel: [ 837] 101 837 1887 962 96 866 0 36864 0 -900 dbus-daemon 2月 12 13:31:49 raspi kernel: [ 858] 103 858 1545 346 32 314 0 32768 0 0 avahi-daemon 2月 12 13:31:49 raspi kernel: [ 859] 0 859 7700 1704 172 1532 0 61440 0 0 systemd-logind 2月 12 13:31:49 raspi kernel: [ 861] 65534 861 1250 607 32 575 0 32768 0 0 thd 2月 12 13:31:49 raspi kernel: [ 863] 1000 863 11915 2404 160 2244 0 73728 0 0 volumio-remote- 2月 12 13:31:49 raspi kernel: [ 873] 0 873 32225 9917 1253 8664 0 270336 0 0 node 2月 12 13:31:49 raspi kernel: [ 977] 100 977 603 444 32 412 0 32768 0 0 dhcpcd 2月 12 13:31:49 raspi kernel: [ 978] 0 978 643 461 32 429 0 32768 0 0 dhcpcd 2月 12 13:31:49 raspi kernel: [ 979] 100 979 560 273 32 241 0 28672 0 0 dhcpcd 2月 12 13:31:49 raspi kernel: [ 980] 100 980 560 241 32 209 0 28672 0 0 dhcpcd 2月 12 13:31:49 raspi kernel: [ 1021] 0 1021 3275 1321 96 1225 0 53248 0 0 wpa_supplicant 2月 12 13:31:49 raspi kernel: [ 1028] 0 1028 10966 1735 128 1607 0 81920 0 0 bluealsa 2月 12 13:31:49 raspi kernel: [ 1097] 0 1097 1574 706 32 674 0 36864 0 0 bash 2月 12 13:31:49 raspi kernel: [ 1099] 0 1099 930 582 32 550 0 32768 0 0 ip 2月 12 13:31:49 raspi kernel: [ 1100] 0 1100 1558 517 32 485 0 32768 0 0 sed 2月 12 13:31:49 raspi kernel: [ 1101] 0 1101 1574 429 33 396 0 32768 0 0 bash 2月 12 13:31:49 raspi kernel: [ 1125] 0 1125 520 325 0 325 0 32768 0 0 ifplugd 2月 12 13:31:49 raspi kernel: [ 1130] 0 1130 3391 1959 192 1767 0 53248 0 -1000 sshd 2月 12 13:31:49 raspi kernel: [ 1141] 0 1141 9777 1430 128 1302 0 57344 0 0 upowerd 2月 12 13:31:49 raspi kernel: [ 1170] 0 1170 16620 3188 416 2702 70 98304 0 0 nmbd 2月 12 13:31:49 raspi kernel: [ 1171] 0 1171 16546 1033 404 629 0 86016 0 0 nmbd 2月 12 13:31:49 raspi kernel: [ 1178] 100 1178 643 285 33 252 0 28672 0 0 dhcpcd 2月 12 13:31:49 raspi kernel: [ 1207] 1000 1207 67085 28784 16329 12455 0 962560 0 0 node 2月 12 13:31:49 raspi kernel: [ 1280] 0 1280 18231 3926 448 3433 45 114688 0 0 winbindd 2月 12 13:31:49 raspi kernel: [ 1283] 0 1283 18292 3586 480 3063 43 110592 0 0 winbindd 2月 12 13:31:49 raspi kernel: [ 1287] 0 1287 19453 4392 512 3686 194 126976 0 0 smbd 2月 12 13:31:49 raspi kernel: [ 1299] 0 1299 19060 2673 502 2171 0 118784 0 0 smbd-notifyd 2月 12 13:31:49 raspi kernel: [ 1300] 0 1300 19060 1286 502 784 0 118784 0 0 cleanupd 2月 12 13:31:49 raspi kernel: [ 1305] 1000 1305 1565 690 32 658 0 32768 0 0 network_monitor 2月 12 13:31:49 raspi kernel: [ 1341] 0 1341 18231 2703 483 2220 0 110592 0 0 winbindd 2月 12 13:31:49 raspi kernel: [ 1342] 0 1342 8257 2240 832 1408 0 61440 0 0 python3 2月 12 13:31:49 raspi kernel: [ 1348] 0 1348 1611 588 134 454 0 40960 0 0 mount.ntfs 2月 12 13:31:49 raspi kernel: [ 1353] 1000 1353 31843 8443 914 7529 0 225280 0 0 node 2月 12 13:31:49 raspi kernel: [ 1363] 1000 1363 32981 11520 2213 9307 0 311296 0 0 node 2月 12 13:31:49 raspi kernel: [ 1364] 1000 1364 32992 11534 2219 9315 0 307200 0 0 node 2月 12 13:31:49 raspi kernel: [ 1365] 1000 1365 32924 11564 2226 9338 0 303104 0 0 node 2月 12 13:31:49 raspi kernel: [ 1468] 0 1468 159016 4982 672 4310 0 151552 0 0 volumio5-onboar 2月 12 13:31:49 raspi kernel: [ 1643] 1000 1643 36124 3190 416 2774 0 139264 0 0 upmpdcli 2月 12 13:31:49 raspi kernel: [ 1717] 102 1717 113368 23825 4998 18827 0 655360 0 0 mpd 2月 12 13:31:49 raspi kernel: [ 1734] 104 1734 37337 2898 416 2482 0 147456 0 0 shairport-sync 2月 12 13:31:49 raspi kernel: [ 1751] 0 1751 1991 890 64 826 0 40960 0 0 lircd 2月 12 13:31:49 raspi kernel: [ 1763] 0 1763 1121 548 32 516 0 36864 0 0 irexec 2月 12 13:31:49 raspi kernel: [ 2484] 1000 2484 1273 342 0 342 0 36864 0 0 sleep 2月 12 13:31:49 raspi kernel: oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0,global_oom,task_memcg=/,task=node,pid=1207,uid=1000 2月 12 13:31:49 raspi kernel: Out of memory: Killed process 1207 (node) total-vm:268340kB, anon-rss:65316kB, file-rss:49820kB, shmem-rss:0kB, UID:1000 pgtables:940kB oom_score_adj:0 2月 12 13:31:49 raspi volumio-remote-updater[863]: [2026-02-12 13:31:49] [error] handle_read_frame error: websocketpp.transport:7 (End of File) 2月 12 13:31:49 raspi volumio-remote-updater[863]: [2026-02-12 13:31:49] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] 2月 12 13:31:49 raspi volumio5-onboarding[1468]: time=2026-02-12T13:31:49.152+09:00 level=ERROR msg="failed reading message" component=volumio/socket error="websocket: close 1006 (abnormal closure): unexpected EOF" 2月 12 13:31:49 raspi volumio5-onboarding[1468]: time=2026-02-12T13:31:49.156+09:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp 127.0.0.1:3000: connect: connection refused" 2月 12 13:31:49 raspi systemd[1]: volumio.service: Main process exited, code=killed, status=9/KILL 2月 12 13:31:49 raspi ntfs-3g[1348]: Unmounting /dev/sda1 (Music) 2月 12 13:31:49 raspi systemd[1]: media-Music.mount: Deactivated successfully. 2月 12 13:31:49 raspi systemd[1]: volumio.service: Failed with result 'signal'. 2月 12 13:31:49 raspi systemd[1]: volumio.service: Consumed 7min 36.316s CPU time. 2月 12 13:31:49 raspi systemd[1]: Started dynamicswap.service - dynamicswap service. 2月 12 13:31:49 raspi systemd[1]: dynamicswap.service: Deactivated successfully. 2月 12 13:31:49 raspi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. 2月 12 13:31:49 raspi systemd[1]: Started dynamicswap.service - dynamicswap service. 2月 12 13:31:49 raspi systemd[1]: Stopped volumio.service - Volumio Backend Module. 2月 12 13:31:49 raspi systemd[1]: volumio.service: Consumed 7min 36.316s CPU time. 2月 12 13:31:49 raspi systemd[1]: Started volumio.service - Volumio Backend Module. 2月 12 13:31:49 raspi systemd[1]: dynamicswap.service: Deactivated successfully. 2月 12 13:31:50 raspi volumio5-onboarding[1468]: time=2026-02-12T13:31:50.158+09:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp 127.0.0.1:3000: connect: connection refused" 2月 12 13:31:51 raspi volumio[2518]: info: ------------------------------------------- 2月 12 13:31:51 raspi volumio[2518]: info: ----- Volumio3 ---- 2月 12 13:31:51 raspi volumio[2518]: info: ------------------------------------------- 2月 12 13:31:51 raspi volumio[2518]: info: ----- System startup ---- 2月 12 13:31:51 raspi volumio[2518]: info: ------------------------------------------- 2月 12 13:31:52 raspi volumio[2518]: info: MYVOLUMIO Environment detected 2月 12 13:31:52 raspi volumio[2518]: info: Plugin folders cleanup 2月 12 13:31:52 raspi volumio[2518]: info: Scanning into folder /volumio/app/plugins/ 2月 12 13:31:52 raspi volumio[2518]: info: Scanning category audio_interface 2月 12 13:31:52 raspi volumio[2518]: info: Scanning category miscellanea 2月 12 13:31:52 raspi volumio[2518]: info: Scanning category music_service 2月 12 13:31:52 raspi volumio[2518]: info: Scanning category plugins.json 2月 12 13:31:52 raspi volumio[2518]: info: Scanning category system_controller 2月 12 13:31:52 raspi volumio[2518]: info: Scanning category user_interface 2月 12 13:31:52 raspi volumio[2518]: info: Scanning into folder /data/plugins/ 2月 12 13:31:52 raspi volumio[2518]: info: Scanning category system_hardware 2月 12 13:31:52 raspi volumio[2518]: info: Scanning category user_interface 2月 12 13:31:52 raspi volumio[2518]: info: Plugin folders cleanup completed 2月 12 13:31:52 raspi volumio[2518]: info: ------------------------------------------- 2月 12 13:31:52 raspi volumio[2518]: info: ----- Core plugins startup ---- 2月 12 13:31:52 raspi volumio[2518]: info: ------------------------------------------- 2月 12 13:31:52 raspi volumio[2518]: info: Loading plugins from folder /volumio/app/plugins/ 2月 12 13:31:52 raspi volumio[2518]: info: Adding plugin upnp to MyMusic Plugins 2月 12 13:31:52 raspi volumio[2518]: info: Adding plugin airplay_emulation to MyMusic Plugins 2月 12 13:31:52 raspi volumio[2518]: info: Adding plugin upnp_browser to MyMusic Plugins 2月 12 13:31:52 raspi volumio[2518]: info: Loading plugins from folder /data/plugins/ 2月 12 13:31:52 raspi volumio[2518]: info: Loading plugin "system"... 2月 12 13:31:52 raspi volumio[2518]: info: Loading plugin "appearance"... 2月 12 13:31:53 raspi volumio[2518]: info: Loading plugin "network"... 2月 12 13:31:53 raspi volumio[2518]: info: Refreshing Cached IP Addresses 2月 12 13:31:53 raspi volumio[2518]: info: Loading plugin "services"... 2月 12 13:31:53 raspi volumio[2518]: info: Loading plugin "volumio5onboarding"... 2月 12 13:31:53 raspi sudo[2556]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 2月 12 13:31:53 raspi sudo[2558]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 2月 12 13:31:53 raspi sudo[2558]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:31:53 raspi sudo[2556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:31:53 raspi volumio[2518]: info: Loading plugin "alsa_controller"... 2月 12 13:31:53 raspi sudo[2558]: pam_unix(sudo:session): session closed for user root 2月 12 13:31:53 raspi sudo[2556]: pam_unix(sudo:session): session closed for user root 2月 12 13:31:53 raspi volumio[2518]: warn: Unable to locate the audio output device USB D/A Converter DA-07X. Please configure a valid output device. 2月 12 13:31:53 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 2月 12 13:31:53 raspi volumio[2518]: info: Loading plugin "wizard"... 2月 12 13:31:53 raspi volumio[2518]: info: Loading plugin "networkfs"... 2月 12 13:31:53 raspi volumio[2518]: info: Starting Udev Watcher for removable devices 2月 12 13:31:53 raspi volumio[2518]: info: Ignoring mount for partition: boot 2月 12 13:31:53 raspi volumio[2518]: info: Ignoring mount for partition: volumio 2月 12 13:31:53 raspi volumio[2518]: info: Ignoring mount for partition: volumio_data 2月 12 13:31:53 raspi volumio[2518]: info: Mounting Device Music 2月 12 13:31:53 raspi sudo[2589]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music -o noatime,dmask=0000,fmask=0000,iocharset=utf8 2月 12 13:31:53 raspi sudo[2589]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:31:54 raspi volumio-remote-updater[863]: [2026-02-12 13:31:54] [connect] Successful connection 2月 12 13:31:55 raspi sudo[2589]: pam_unix(sudo:session): session closed for user root 2月 12 13:31:55 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback 2月 12 13:31:55 raspi volumio[2518]: info: Loading plugin "volumio_command_line_client"... 2月 12 13:31:56 raspi ntfs-3g[2592]: Version 2022.10.3 integrated FUSE 28 2月 12 13:31:56 raspi ntfs-3g[2592]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1) 2月 12 13:31:56 raspi ntfs-3g[2592]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 2月 12 13:31:56 raspi ntfs-3g[2592]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 2月 12 13:31:56 raspi ntfs-3g[2592]: Global ownership and permissions enforced, configuration type 7 2月 12 13:31:56 raspi ntfs-3g[2592]: Unmounting /dev/sda1 (Music) 2月 12 13:31:56 raspi volumio[2518]: info: Loading plugin "upnp"... 2月 12 13:31:56 raspi volumio[2518]: info: [1770870716047] Starting Upmpd Daemon 2月 12 13:31:56 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback 2月 12 13:31:56 raspi volumio[2518]: info: Loading plugin "my_music"... 2月 12 13:31:56 raspi volumio[2518]: info: Loading plugin "mpd"... 2月 12 13:31:56 raspi volumio[2518]: info: Loading plugin "upnp_browser"... 2月 12 13:31:57 raspi volumio[2518]: info: Starting UPNP Browser 2月 12 13:31:57 raspi volumio[2518]: info: Loading plugin "alarm-clock"... 2月 12 13:31:57 raspi volumio[2518]: info: Loading plugin "airplay_emulation"... 2月 12 13:31:57 raspi volumio[2518]: info: Starting Shairport Sync 2月 12 13:31:57 raspi volumio[2518]: info: Loading plugin "last_100"... 2月 12 13:31:57 raspi volumio[2518]: info: Loading plugin "webradio"... 2月 12 13:31:57 raspi volumio[2518]: info: Loading plugin "i2s_dacs"... 2月 12 13:31:57 raspi volumio[2518]: info: I2S DAC not set, start Auto-detection 2月 12 13:31:57 raspi volumio[2518]: info: Loading plugin "volumiodiscovery"... 2月 12 13:31:57 raspi volumio[2518]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. 2月 12 13:31:57 raspi volumio[2518]: *** WARNING *** Please fix your application to use the native API of Avahi! 2月 12 13:31:57 raspi volumio[2518]: *** WARNING *** For more information see 2月 12 13:31:57 raspi volumio[2518]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. 2月 12 13:31:57 raspi volumio[2518]: *** WARNING *** Please fix your application to use the native API of Avahi! 2月 12 13:31:57 raspi node[2518]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. 2月 12 13:31:57 raspi volumio[2518]: *** WARNING *** For more information see 2月 12 13:31:57 raspi node[2518]: *** WARNING *** Please fix your application to use the native API of Avahi! 2月 12 13:31:57 raspi node[2518]: *** WARNING *** For more information see 2月 12 13:31:57 raspi node[2518]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. 2月 12 13:31:57 raspi node[2518]: *** WARNING *** Please fix your application to use the native API of Avahi! 2月 12 13:31:57 raspi node[2518]: *** WARNING *** For more information see 2月 12 13:31:57 raspi volumio[2518]: info: Applying required configuration parameters for plugin volumiodiscovery 2月 12 13:31:57 raspi volumio[2518]: info: Discovery: Started advertising with name: raspi 2月 12 13:31:57 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback 2月 12 13:31:57 raspi volumio[2518]: info: Loading plugin "outputs"... 2月 12 13:31:58 raspi volumio[2518]: info: Loading plugin "albumart"... 2月 12 13:31:58 raspi volumio[2518]: info: Plugin example_plugin is not enabled 2月 12 13:31:58 raspi volumio[2518]: info: Loading plugin "inputs"... 2月 12 13:31:58 raspi volumio[2518]: info: Loading plugin "updater_comm"... 2月 12 13:31:58 raspi volumio[2518]: info: Plugin mpdemulation is not enabled 2月 12 13:31:58 raspi volumio[2518]: info: Loading plugin "rest_api"... 2月 12 13:31:58 raspi volumio[2518]: info: Loading plugin "websocket"... 2月 12 13:31:58 raspi volumio[2518]: info: Starting Socket.io Server version 1.7.4 2月 12 13:31:58 raspi volumio[2518]: info: Loading plugin "ir_controller"... 2月 12 13:31:58 raspi volumio[2518]: info: Applying required configuration parameters for plugin ir_controller 2月 12 13:31:58 raspi volumio[2598]: Forking 3 albumart workers 2月 12 13:31:58 raspi volumio[2518]: info: Loading plugin "peppymeterbasic"... 2月 12 13:32:01 raspi volumio5-onboarding[1468]: time=2026-02-12T13:32:01.159+09:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="read tcp 127.0.0.1:57524->127.0.0.1:3000: i/o timeout" 2月 12 13:32:01 raspi volumio[2518]: info: Loading plugin "touch_display"... 2月 12 13:32:02 raspi volumio[2610]: Starting albumart workers 2月 12 13:32:02 raspi volumio[2518]: info: Applying required configuration parameters for plugin touch_display 2月 12 13:32:03 raspi volumio[2518]: info: Loading i18n strings for locale en 2月 12 13:32:03 raspi volumio[2518]: Updating browse sources language 2月 12 13:32:03 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 2月 12 13:32:04 raspi volumio[2609]: Starting albumart workers 2月 12 13:32:04 raspi volumio[2608]: Starting albumart workers 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::initPlayerControls 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: Express server listening on port 3000 2月 12 13:32:04 raspi volumio[2518]: [Metrics] WebUI: 13s 767.28ms 2月 12 13:32:04 raspi volumio[2518]: info: CoreStateMachine::resetVolumioState 2月 12 13:32:04 raspi volumio[2518]: info: CoreStateMachine::getcurrentVolume 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::volumioRetrievevolume 2月 12 13:32:04 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 2月 12 13:32:04 raspi volumio[2518]: info: Volumio Network Manager: Network status updated: 1 2月 12 13:32:04 raspi volumio[2518]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. 2月 12 13:32:05 raspi volumio[2518]: verbose: New Socket.io Connection to 192.168.3.39 from 192.168.3.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 2月 12 13:32:05 raspi volumio[2518]: info: VolumeController:: Volume=undefined Mute =false 2月 12 13:32:05 raspi volumio[2518]: info: CoreStateMachine::pushState 2月 12 13:32:05 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:05 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo 2月 12 13:32:05 raspi volumio[2518]: info: CoreCommandRouter::volumioPushState 2月 12 13:32:05 raspi volumio[2518]: info: CoreStateMachine::updateTrackBlock 2月 12 13:32:05 raspi volumio[2518]: info: CorePlayQueue::getTrackBlock 2月 12 13:32:05 raspi volumio[2518]: info: CoreCommandRouter::volumioRetrievevolume 2月 12 13:32:05 raspi volumio[2518]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. 2月 12 13:32:05 raspi volumio[2518]: info: CoreStateMachine::setRepeat null single undefined 2月 12 13:32:05 raspi volumio[2518]: info: CoreStateMachine::pushState 2月 12 13:32:05 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:05 raspi volumio[2518]: info: CoreCommandRouter::volumioPushState 2月 12 13:32:05 raspi volumio[2518]: info: CoreStateMachine::setRandom null 2月 12 13:32:05 raspi volumio[2518]: info: CoreStateMachine::pushState 2月 12 13:32:05 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:05 raspi volumio[2518]: info: CoreCommandRouter::volumioPushState 2月 12 13:32:05 raspi volumio[2518]: verbose: New Socket.io Connection to 192.168.3.39 from 192.168.3.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 2月 12 13:32:05 raspi volumio[2518]: info: VolumeController:: Volume=undefined Mute =false 2月 12 13:32:05 raspi volumio[2518]: info: CoreStateMachine::pushState 2月 12 13:32:05 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:05 raspi volumio[2518]: info: CoreCommandRouter::volumioPushState 2月 12 13:32:05 raspi volumio[2518]: info: Setting Device type: Raspberry PI 2月 12 13:32:05 raspi volumio[2518]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb 2月 12 13:32:05 raspi volumio[2518]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 2月 12 13:32:05 raspi volumio[2518]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI 2月 12 13:32:05 raspi volumio[2518]: info: Discovery: adding e7cb7b76-6f77-4b65-abaf-5e585962d2f5 2月 12 13:32:05 raspi volumio[2518]: info: Discovery: Found device Rivo 2月 12 13:32:06 raspi volumio[2518]: info: Discovery: Connecting to remote: 192.168.3.37 2月 12 13:32:06 raspi volumio[2518]: verbose: New Socket.io Connection to 192.168.3.39 from 192.168.3.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 2月 12 13:32:06 raspi volumio[2518]: info: Discovery: adding 62fd630b-5c8b-4832-80ab-a76f6f0b4ec6 2月 12 13:32:06 raspi volumio[2518]: info: Discovery: Found device raspi 2月 12 13:32:06 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:06 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:06 raspi volumio[2518]: info: Discovery: this is already registered, 62fd630b-5c8b-4832-80ab-a76f6f0b4ec6 2月 12 13:32:06 raspi volumio[2518]: info: Discovery: Found device raspi 2月 12 13:32:06 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:06 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:06 raspi volumio[2518]: verbose: New Socket.io Connection to 192.168.3.39:3000 from 192.168.3.37 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 2月 12 13:32:06 raspi sudo[2691]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 2月 12 13:32:06 raspi sudo[2690]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 2月 12 13:32:06 raspi sudo[2691]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:06 raspi sudo[2690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:06 raspi sudo[2690]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:06 raspi sudo[2691]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:06 raspi volumio[2518]: info: Discovery: Connected to remote: 192.168.3.37 2月 12 13:32:06 raspi volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 2月 12 13:32:06 raspi volumio-remote-updater[863]: [2026-02-12 13:32:06] [connect] Successful connection 2月 12 13:32:06 raspi volumio[2518]: info: Completed loading Core Plugins 2月 12 13:32:06 raspi volumio[2518]: info: Preparing to generate the ALSA configuration file 2月 12 13:32:06 raspi volumio[2518]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf 2月 12 13:32:06 raspi volumio[2518]: info: Reading ALSA contributions from plugins. 2月 12 13:32:07 raspi volumio[2518]: verbose: New Socket.io Connection to 192.168.3.39 from 192.168.3.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 2月 12 13:32:07 raspi volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 2月 12 13:32:07 raspi volumio[2518]: verbose: New Socket.io Connection to 192.168.3.39:3000 from 192.168.3.37 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 2月 12 13:32:07 raspi sudo[2707]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service 2月 12 13:32:07 raspi sudo[2707]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:07 raspi volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 2月 12 13:32:07 raspi volumio-remote-updater[863]: [2026-02-12 13:32:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1770870726 101 2月 12 13:32:07 raspi sudo[2707]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:07 raspi volumio[2518]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 8 2月 12 13:32:07 raspi volumio[2518]: info: Upmpdcli Daemon Started 2月 12 13:32:07 raspi volumio[2518]: info: Asound.conf file unchanged, so no further update is needed 2月 12 13:32:07 raspi volumio[2518]: info: Output device has changed, restarting MPD 2月 12 13:32:07 raspi volumio[2518]: info: Output device has changed, restarting Shairport Sync 2月 12 13:32:07 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:07 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 2月 12 13:32:07 raspi sudo[2712]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf 2月 12 13:32:07 raspi sudo[2712]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:07 raspi sudo[2714]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service 2月 12 13:32:07 raspi sudo[2714]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:07 raspi sudo[2712]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:07 raspi systemd[1]: Stopping mpd.service - Music Player Daemon... 2月 12 13:32:07 raspi volumio[2518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 2月 12 13:32:07 raspi volumio[2518]: info: ___________ START PLUGINS ___________ 2月 12 13:32:07 raspi volumio[2518]: info: ControllerMpd::onStart: Initializing MPD 2月 12 13:32:07 raspi volumio[2518]: info: Creating MPD Configuration file 2月 12 13:32:07 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 2月 12 13:32:07 raspi sudo[2723]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service 2月 12 13:32:07 raspi sudo[2723]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:07 raspi volumio[2518]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] 2月 12 13:32:07 raspi volumio[2518]: info: [1770870727922] CoreMusicLibrary::Adding element Media Servers 2月 12 13:32:07 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 2月 12 13:32:07 raspi sudo[2725]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf 2月 12 13:32:07 raspi sudo[2725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:07 raspi volumio[2518]: info: UPNP Browser: Client initialized successfully 2月 12 13:32:07 raspi sudo[2725]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:07 raspi sudo[2728]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 2月 12 13:32:08 raspi sudo[2728]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:08 raspi sudo[2723]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:08 raspi volumio[2518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 2月 12 13:32:08 raspi volumio[2518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] 2月 12 13:32:08 raspi volumio[2518]: info: [1770870728183] CoreMusicLibrary::Adding element Last_100 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] 2月 12 13:32:08 raspi volumio[2518]: info: [1770870728197] CoreMusicLibrary::Adding element Webradio 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 2月 12 13:32:08 raspi volumio[2518]: info: Initializing BBC Radios 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 2月 12 13:32:08 raspi volumio[2518]: info: Loading i18n strings for locale en 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile 2月 12 13:32:08 raspi sudo[2753]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 2月 12 13:32:08 raspi sudo[2753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:08 raspi volumio[2518]: info: Loading i18n strings for locale en 2月 12 13:32:08 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 2月 12 13:32:08 raspi volumio[2518]: info: Volumio Calling Home 2月 12 13:32:08 raspi sudo[2753]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:08 raspi sudo[2757]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge 2月 12 13:32:08 raspi sudo[2757]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:08 raspi sudo[2757]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:09 raspi volumio[2518]: info: Preparing to generate the ALSA configuration file 2月 12 13:32:09 raspi sudo[2766]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc 2月 12 13:32:09 raspi sudo[2768]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service 2月 12 13:32:09 raspi sudo[2768]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:09 raspi sudo[2766]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:09 raspi sudo[2772]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service 2月 12 13:32:09 raspi sudo[2774]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload 2月 12 13:32:09 raspi sudo[2774]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:09 raspi sudo[2766]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:09 raspi sudo[2772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:09 raspi sudo[2768]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:09 raspi systemd[1]: Reloading. 2月 12 13:32:10 raspi sudo[2774]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:10 raspi systemd[1]: Reloading. 2月 12 13:32:11 raspi volumio[2518]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf 2月 12 13:32:11 raspi volumio[2518]: info: Reading ALSA contributions from plugins. 2月 12 13:32:11 raspi volumio[2518]: info: touch_display: No backlight interface detected. 2月 12 13:32:11 raspi volumio[2518]: info: touch_display: systemctl daemon-reload succeeded. 2月 12 13:32:11 raspi volumio[2518]: info: touch_display: systemctl stop getty@tty1.service succeeded. 2月 12 13:32:11 raspi volumio[2518]: info: ir_controller: File permissions successfully set on /etc/lirc/*. 2月 12 13:32:11 raspi volumio[2518]: info: snd_dummy loaded 2月 12 13:32:11 raspi volumio[2518]: info: MPD Permissions set 2月 12 13:32:11 raspi volumio[2518]: info: MPD Permissions set 2月 12 13:32:11 raspi sudo[2814]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service 2月 12 13:32:11 raspi sudo[2814]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:11 raspi sudo[2820]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 2月 12 13:32:11 raspi sudo[2820]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:11 raspi sudo[2823]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 2月 12 13:32:11 raspi sudo[2817]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ 2月 12 13:32:11 raspi sudo[2817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:12 raspi sudo[2820]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:12 raspi sudo[2823]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:12 raspi sudo[2823]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:12 raspi sudo[2817]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:12 raspi volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9 2月 12 13:32:12 raspi systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. 2月 12 13:32:12 raspi sudo[2814]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:12 raspi volumio[2518]: info: Volumio called home 2月 12 13:32:12 raspi sudo[2772]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:12 raspi startx[2849]: X.Org X Server 1.21.1.7 2月 12 13:32:12 raspi startx[2849]: X Protocol Version 11, Revision 0 2月 12 13:32:12 raspi startx[2849]: Current Operating System: Linux raspi 6.12.47-v7l+ #1904 SMP Mon Sep 15 13:08:10 BST 2025 armv7l 2月 12 13:32:12 raspi startx[2849]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave nvme.max_host_mem_size_mb=0 snd_bcm2835.enable_hdmi=0 video=HDMI-A-1:1024x600M@60D numa=fake=2 system_heap.max_order=0 smsc95xx.macaddr=DC:A6:32:B4:33:B2 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=dafa3844-b779-48cd-9b4c-01ecfd09e0f4 imgfile=/volumio_current.sqsh bootpart=UUID=3B89-0B23 datapart=UUID=752d19ad-b702-471d-847a-f79ae83515d0 uuidconfig=cmdline.txt rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no 2月 12 13:32:12 raspi startx[2849]: xorg-server 2:21.1.7-3+rpt3+deb12u11 (https://www.debian.org/support) 2月 12 13:32:12 raspi startx[2849]: Current version of pixman: 0.44.0 2月 12 13:32:12 raspi startx[2849]: Before reporting problems, check http://wiki.x.org 2月 12 13:32:12 raspi startx[2849]: to make sure that you have the latest version. 2月 12 13:32:12 raspi startx[2849]: Markers: (--) probed, (**) from config file, (==) default setting, 2月 12 13:32:12 raspi startx[2849]: (++) from command line, (!!) notice, (II) informational, 2月 12 13:32:12 raspi startx[2849]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. 2月 12 13:32:12 raspi startx[2849]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Feb 12 13:32:12 2026 2月 12 13:32:12 raspi startx[2849]: (==) Using config directory: "/etc/X11/xorg.conf.d" 2月 12 13:32:12 raspi startx[2849]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" 2月 12 13:32:12 raspi kernel: vc4-drm gpu: [drm] User-defined mode not supported: "1024x600": 60 49000 1024 1029 1042 1312 600 602 605 622 0x68 0xa 2月 12 13:32:12 raspi kernel: vc4-drm gpu: [drm] User-defined mode not supported: "1024x600": 60 49000 1024 1029 1042 1312 600 602 605 622 0x68 0xa 2月 12 13:32:12 raspi startx[2849]: (EE) 2月 12 13:32:12 raspi startx[2849]: Fatal server error: 2月 12 13:32:12 raspi startx[2849]: (EE) no screens found(EE) 2月 12 13:32:12 raspi startx[2849]: (EE) 2月 12 13:32:12 raspi startx[2849]: Please consult the The X.Org Foundation support 2月 12 13:32:12 raspi startx[2849]: at http://wiki.x.org 2月 12 13:32:12 raspi startx[2849]: for help. 2月 12 13:32:12 raspi startx[2849]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information. 2月 12 13:32:12 raspi startx[2849]: (EE) 2月 12 13:32:12 raspi startx[2849]: (EE) Server terminated with error (1). Closing log file. 2月 12 13:32:13 raspi volumio[2518]: info: touch_display: systemctl disable getty@tty1.service succeeded. 2月 12 13:32:13 raspi volumio[2518]: info: touch_display: systemctl start volumio-kiosk.service succeeded. 2月 12 13:32:13 raspi volumio[2518]: info: touch_display: Volumio Kiosk started. 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:13 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:13 raspi volumio[2518]: info: touch_display: IframeKeyboardBridge extension installed successfully 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 2月 12 13:32:13 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:14 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:14 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:14 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket 2月 12 13:32:14 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:14 raspi volumio[2518]: info: touch_display: No Raspberry Pi Foundation touch screen detected. 2月 12 13:32:14 raspi sudo[2880]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf 2月 12 13:32:14 raspi sudo[2880]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:14 raspi sudo[2880]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:14 raspi sudo[2882]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf 2月 12 13:32:14 raspi sudo[2882]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:14 raspi volumio[2518]: info: Starting Shairport Sync 2月 12 13:32:14 raspi sudo[2882]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:14 raspi volumio[2518]: info: Starting Shairport Sync 2月 12 13:32:14 raspi volumio[2518]: info: Starting Shairport Sync 2月 12 13:32:14 raspi sudo[2886]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync 2月 12 13:32:14 raspi sudo[2888]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync 2月 12 13:32:14 raspi sudo[2888]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:14 raspi sudo[2890]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync 2月 12 13:32:14 raspi sudo[2890]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:14 raspi sudo[2886]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:14 raspi volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 2月 12 13:32:14 raspi volumio[2518]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. 2月 12 13:32:14 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:14 raspi systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... 2月 12 13:32:14 raspi systemd[1]: shairport-sync.service: Deactivated successfully. 2月 12 13:32:14 raspi systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. 2月 12 13:32:14 raspi systemd[1]: shairport-sync.service: Consumed 2.298s CPU time. 2月 12 13:32:14 raspi systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. 2月 12 13:32:14 raspi sudo[2888]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:14 raspi volumio[2518]: info: ir_controller: LIRC correctly updated. 2月 12 13:32:14 raspi volumio[2518]: info: ir_controller: HAT already loaded /proc/device-tree/ir_receiver! 2月 12 13:32:14 raspi sudo[2890]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:14 raspi sudo[2886]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:14 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:14 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:14 raspi volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 2月 12 13:32:14 raspi volumio[2518]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. 2月 12 13:32:14 raspi volumio[2518]: info: Asound.conf file unchanged, so no further update is needed 2月 12 13:32:14 raspi volumio[2518]: info: Output device has changed, restarting MPD 2月 12 13:32:14 raspi volumio[2518]: info: Output device has changed, restarting Shairport Sync 2月 12 13:32:14 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:14 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 2月 12 13:32:15 raspi sudo[2912]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf 2月 12 13:32:15 raspi volumio[2518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 2月 12 13:32:15 raspi sudo[2912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:15 raspi sudo[2915]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service 2月 12 13:32:15 raspi sudo[2915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:15 raspi sudo[2912]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:15 raspi volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 11 2月 12 13:32:15 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:15 raspi volumio[2518]: info: Shairport-Sync Started 2月 12 13:32:15 raspi volumio[2518]: Error adding Membership: Error: addMembership EINVAL 2月 12 13:32:15 raspi volumio[2518]: info: Shairport-Sync Started 2月 12 13:32:15 raspi volumio[2518]: info: Shairport-Sync Started 2月 12 13:32:15 raspi volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 11 2月 12 13:32:15 raspi volumio[2518]: verbose: New Socket.io Connection to 192.168.3.39 from 192.168.3.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 2月 12 13:32:15 raspi volumio[2518]: info: MPD Permissions set 2月 12 13:32:15 raspi volumio[2518]: verbose: New Socket.io Connection to 192.168.3.39 from 192.168.3.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 2月 12 13:32:15 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:15 raspi volumio[2518]: info: Starting Shairport Sync 2月 12 13:32:15 raspi sudo[2934]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync 2月 12 13:32:15 raspi sudo[2934]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:15 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:15 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:15 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:16 raspi sudo[2938]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service 2月 12 13:32:16 raspi systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... 2月 12 13:32:16 raspi systemd[1]: shairport-sync.service: Deactivated successfully. 2月 12 13:32:16 raspi systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. 2月 12 13:32:16 raspi systemd[1]: shairport-sync.service: Consumed 1.066s CPU time. 2月 12 13:32:16 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:16 raspi sudo[2938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:16 raspi systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. 2月 12 13:32:16 raspi lircd[1751]: lircd-0.10.1[1751]: Notice: caught signal 2月 12 13:32:16 raspi lircd-0.10.1[1751]: Notice: caught signal 2月 12 13:32:16 raspi systemd[1]: Stopping lircd.service - Flexible IR remote input/output application support... 2月 12 13:32:16 raspi systemd[1]: lircd.service: Deactivated successfully. 2月 12 13:32:16 raspi systemd[1]: Stopped lircd.service - Flexible IR remote input/output application support. 2月 12 13:32:16 raspi systemd[1]: irexec.service: Deactivated successfully. 2月 12 13:32:16 raspi sudo[2934]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:16 raspi systemd[1]: Starting lircd-setup.service - lircd(8) initialization helper tool... 2月 12 13:32:16 raspi volumio[2518]: info: Shairport-Sync Started 2月 12 13:32:16 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:16 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:16 raspi lircd-setup[2957]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in Python 3.12. Use ConfigParser directly instead. 2月 12 13:32:16 raspi lircd-setup[2957]: parser = configparser.SafeConfigParser() 2月 12 13:32:16 raspi systemd[1]: lircd-setup.service: Deactivated successfully. 2月 12 13:32:16 raspi systemd[1]: Finished lircd-setup.service - lircd(8) initialization helper tool. 2月 12 13:32:16 raspi systemd[1]: Starting lircd.service - Flexible IR remote input/output application support... 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Info: lircd: Opening log, level: Info 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Version: lircd 0.10.1 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: System info: Linux raspi 6.12.47-v7l+ #1904 SMP Mon Sep 15 13:08:10 BST 2025 armv7l GNU/Linux 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Info: Initial device: /dev/lirc0 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Info: [lirc] protocol is enabled 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Info: Initial device: /dev/lirc0 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Info: [lirc] protocol is enabled 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: driver: default 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: output: /var/run/lirc/lircd 2月 12 13:32:16 raspi lircd[2963]: lircd-0.10.1[2963]: Info: lircd: Opening log, level: Info 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: nodaemon: 1 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: logfile: syslog 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: immediate-init: 0 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: permission: 666 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: driver-options: 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: pidfile: /var/run/lirc/lircd.pid 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: listen: 0 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: connect: (null) 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: userelease: 0 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: effective_user: (null) 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: release_suffix: _EVUP 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: allow_simulate: 0 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: repeat_max: 600 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: configfile: /etc/lirc/lircd.conf 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Options: dynamic_codes: (null) 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Current driver: default 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Driver API version: 3 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Driver version: 0.10.0 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Info: lircd: Opening log, level: Info 2月 12 13:32:16 raspi lircd[2963]: lircd-0.10.1[2963]: Notice: Using systemd fd 2月 12 13:32:16 raspi lircd[2963]: lircd-0.10.1[2963]: Warning: Running as root 2月 12 13:32:16 raspi lircd[2963]: lircd-0.10.1[2963]: Info: Using remote: /etc/lirc/lircd.conf. 2月 12 13:32:16 raspi lircd[2963]: lircd-0.10.1[2963]: Notice: lircd(default) ready, using /var/run/lirc/lircd 2月 12 13:32:16 raspi systemd[1]: Started lircd.service - Flexible IR remote input/output application support. 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: Using systemd fd 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Warning: Running as root 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Info: Using remote: /etc/lirc/lircd.conf. 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: lircd(default) ready, using /var/run/lirc/lircd 2月 12 13:32:16 raspi sudo[2938]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:16 raspi volumio[2518]: info: ir_controller: systemctl restart lircd.service succeeded. 2月 12 13:32:16 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:16 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:16 raspi sudo[2969]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service 2月 12 13:32:16 raspi sudo[2969]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 2月 12 13:32:16 raspi volumio[2518]: verbose: New Socket.io Connection to 192.168.3.39 from 192.168.3.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 2月 12 13:32:16 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled 2月 12 13:32:16 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:16 raspi systemd[1]: Started irexec.service - Handle events from IR remotes decoded by lircd(8). 2月 12 13:32:16 raspi lircd[2963]: lircd-0.10.1[2963]: Notice: accepted new client on /var/run/lirc/lircd 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Notice: accepted new client on /var/run/lirc/lircd 2月 12 13:32:16 raspi lircd[2963]: lircd-0.10.1[2963]: Info: [lirc] protocol is enabled 2月 12 13:32:16 raspi lircd-0.10.1[2963]: Info: [lirc] protocol is enabled 2月 12 13:32:16 raspi sudo[2969]: pam_unix(sudo:session): session closed for user root 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetVisibleSources 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom 2月 12 13:32:17 raspi volumio[2518]: info: Received Get System Info 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 2月 12 13:32:17 raspi volumio[2518]: info: Discovery: Getting this device information 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: Listing playlists 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus 2月 12 13:32:17 raspi volumio[2518]: info: Received Get System Info 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 2月 12 13:32:17 raspi volumio[2518]: info: Discovery: Getting this device information 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus 2月 12 13:32:17 raspi volumio[2518]: info: Received Get System Info 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 2月 12 13:32:17 raspi volumio[2518]: info: Discovery: Getting this device information 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetVisibleSources 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom 2月 12 13:32:17 raspi volumio[2518]: info: Received Get System Info 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 2月 12 13:32:17 raspi volumio[2518]: info: Discovery: Getting this device information 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 2月 12 13:32:17 raspi volumio[2518]: info: CoreCommandRouter::volumioGetState 2月 12 13:32:17 raspi volumio[2518]: info: CorePlayQueue::getTrack 0 2月 12 13:32:17 raspi volumio[2518]: info: Listing playlists 2月 12 13:32:17 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:17 raspi volumio[2518]: info: ir_controller: systemctl restart irexec.service succeeded. 2月 12 13:32:17 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:17 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:17 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:18 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:18 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:18 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:18 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:18 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:18 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:18 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:18 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:18 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard 2月 12 13:32:19 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken 2月 12 13:32:19 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:19 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:19 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken 2月 12 13:32:19 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:19 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:19 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:19 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:19 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:20 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:20 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:20 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:20 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:20 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:20 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:20 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:20 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:21 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:21 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::getUIConfigOnPlugin 2月 12 13:32:21 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::volumioGetBrowseSources 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::volumioGetBrowseSources 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::volumioGetBrowseSources 2月 12 13:32:21 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats 2月 12 13:32:21 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares 2月 12 13:32:21 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:21 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:21 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:21 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:22 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:22 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:22 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:22 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:22 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:22 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:22 raspi volumio[2518]: info: touch_display: X display number found: 0 2月 12 13:32:22 raspi volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb 2月 12 13:32:23 raspi volumio[2518]: verbose: ControllerMpd::sendMpdCommand rescan 2月 12 13:32:23 raspi volumio[2518]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| 2月 12 13:32:23 raspi volumio[2518]: TypeError: Cannot read properties of undefined (reading 'then') 2月 12 13:32:23 raspi volumio[2518]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6) 2月 12 13:32:23 raspi volumio[2518]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1899:15) 2月 12 13:32:23 raspi volumio[2518]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) 2月 12 13:32:23 raspi volumio[2518]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1098:26) 2月 12 13:32:23 raspi volumio[2518]: at Socket.emit (node:events:514:28) 2月 12 13:32:23 raspi volumio[2518]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 2月 12 13:32:23 raspi volumio[2518]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) 2月 12 13:32:23 raspi volumio[2518]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| 2月 12 13:32:26 raspi sudo[3100]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-12 13:31' 2月 12 13:32:26 raspi sudo[3100]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"