-- Logs begin at Wed 2025-11-05 08:20:15 HKT, end at Wed 2025-11-05 09:51:53 HKT. -- Nov 05 09:50:00 volumio volumio[1112]: info: MyVolumio login type: Token Nov 05 09:50:01 volumio volumio[1112]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 9 Nov 05 09:50:01 volumio volumio[1112]: info: CoreCommandRouter::volumioGetState Nov 05 09:50:01 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:01 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 05 09:50:01 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 05 09:50:01 volumio volumio[1112]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 10 Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::volumioGetState Nov 05 09:50:02 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:02 volumio volumio[1112]: info: Listing playlists Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::volumioGetVisibleSources Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::volumioGetQueue Nov 05 09:50:02 volumio volumio[1112]: info: CoreStateMachine::getQueue Nov 05 09:50:02 volumio volumio[1112]: info: CorePlayQueue::getQueue Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::volumioGetState Nov 05 09:50:02 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:02 volumio volumio[1112]: info: Listing playlists Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::volumioGetVisibleSources Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::volumioGetQueue Nov 05 09:50:02 volumio volumio[1112]: info: CoreStateMachine::getQueue Nov 05 09:50:02 volumio volumio[1112]: info: CorePlayQueue::getQueue Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::volumioGetState Nov 05 09:50:02 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:02 volumio volumio[1112]: info: Listing playlists Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::volumioGetVisibleSources Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:50:02 volumio volumio[1112]: info: CoreCommandRouter::volumioGetQueue Nov 05 09:50:02 volumio volumio[1112]: info: CoreStateMachine::getQueue Nov 05 09:50:02 volumio volumio[1112]: info: CorePlayQueue::getQueue Nov 05 09:50:08 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 05 09:50:08 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 05 09:50:08 volumio volumio[1112]: info: Discovery: Getting this device information Nov 05 09:50:08 volumio volumio[1112]: info: CoreCommandRouter::volumioGetState Nov 05 09:50:08 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:08 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 05 09:50:09 volumio volumio[1112]: info: CoreCommandRouter::volumioPause Nov 05 09:50:09 volumio volumio[1112]: info: CoreStateMachine::pause Nov 05 09:50:09 volumio volumio[1112]: info: CoreStateMachine::stPlaybackTimer Nov 05 09:50:09 volumio volumio[1112]: info: CoreStateMachine::servicePause Nov 05 09:50:09 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:09 volumio volumio[1112]: info: CoreCommandRouter::servicePause Nov 05 09:50:09 volumio volumio[1112]: info: ControllerMpd::pause Nov 05 09:50:09 volumio volumio[1112]: verbose: ControllerMpd::sendMpdCommand pause Nov 05 09:50:09 volumio volumio[1112]: info: Nov 05 09:50:09 volumio volumio[1112]: ---------------------------- MPD announces state update: player Nov 05 09:50:09 volumio volumio[1112]: info: sendMpdCommand pause took 22 milliseconds Nov 05 09:50:09 volumio volumio[1112]: info: ControllerMpd::getState Nov 05 09:50:09 volumio volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Nov 05 09:50:09 volumio volumio[1112]: info: sendMpdCommand status took 3 milliseconds Nov 05 09:50:09 volumio volumio[1112]: verbose: ControllerMpd::parseState Nov 05 09:50:09 volumio volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 09:50:09 volumio volumio[1112]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 05 09:50:09 volumio volumio[1112]: verbose: ControllerMpd::parseTrackInfo Nov 05 09:50:09 volumio volumio[1112]: info: ControllerMpd::pushState Nov 05 09:50:09 volumio volumio[1112]: info: CoreCommandRouter::servicePushState Nov 05 09:50:09 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:09 volumio volumio[1112]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":58041,"duration":178,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Once upon a dream（音乐剧鬼医主题曲）.wav","artist":null,"album":"????02?????","uri":"USB/________/02-《测机王》/01. Once upon a dream（音乐剧鬼医主题曲）.wav","trackType":"wav"} Nov 05 09:50:09 volumio volumio[1112]: verbose: CURRENT POSITION 0 Nov 05 09:50:09 volumio volumio[1112]: info: CoreStateMachine::syncState stateService pause Nov 05 09:50:09 volumio volumio[1112]: info: CoreStateMachine::syncState currentStatus pause Nov 05 09:50:09 volumio volumio[1112]: info: CoreStateMachine::pushState Nov 05 09:50:09 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:09 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 09:50:09 volumio volumio[1112]: info: CoreCommandRouter::volumioPushState Nov 05 09:50:09 volumio volumio[1112]: info: CoreStateMachine::stPlaybackTimer Nov 05 09:50:09 volumio volumio[1112]: info: ------------------------------ 21ms Nov 05 09:50:09 volumio volumio[1112]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 09:50:09 volumio volumio[1112]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Nov 05 09:50:09 volumio volumio[1112]: at Object.readdirSync (fs.js:1048:3) Nov 05 09:50:09 volumio volumio[1112]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Nov 05 09:50:09 volumio volumio[1112]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Nov 05 09:50:09 volumio volumio[1112]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Nov 05 09:50:09 volumio volumio[1112]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Nov 05 09:50:09 volumio volumio[1112]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Nov 05 09:50:09 volumio volumio[1112]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Nov 05 09:50:09 volumio volumio[1112]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Nov 05 09:50:09 volumio volumio[1112]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Nov 05 09:50:09 volumio volumio[1112]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Nov 05 09:50:09 volumio volumio[1112]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Nov 05 09:50:09 volumio volumio[1112]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Nov 05 09:50:09 volumio volumio[1112]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Nov 05 09:50:09 volumio volumio[1112]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Nov 05 09:50:09 volumio volumio[1112]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Nov 05 09:50:09 volumio volumio[1112]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Nov 05 09:50:09 volumio volumio[1112]: errno: -20, Nov 05 09:50:09 volumio volumio[1112]: syscall: 'scandir', Nov 05 09:50:09 volumio volumio[1112]: code: 'ENOTDIR', Nov 05 09:50:09 volumio volumio[1112]: path: '/tmp/peppyrunning' Nov 05 09:50:09 volumio volumio[1112]: } Nov 05 09:50:09 volumio volumio[1112]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 09:50:10 volumio sudo[16756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-05 09:49 Nov 05 09:50:10 volumio sudo[16756]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:10 volumio sudo[16756]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:11 volumio volumio-remote-updater[689]: [2025-11-05 09:50:11] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Nov 05 09:50:11 volumio volumio-remote-updater[689]: [2025-11-05 09:50:11] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Nov 05 09:50:11 volumio volumio-remote-updater[689]: [2025-11-05 09:50:11] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Nov 05 09:50:11 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 05 09:50:11 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 05 09:50:11 volumio systemd[1]: Started dynamicswap service. Nov 05 09:50:11 volumio systemd[1]: dynamicswap.service: Succeeded. Nov 05 09:50:11 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 05 09:50:11 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Nov 05 09:50:11 volumio systemd[1]: Started dynamicswap service. Nov 05 09:50:11 volumio systemd[1]: Stopped Volumio Backend Module. Nov 05 09:50:11 volumio systemd[1]: Started Volumio Backend Module. Nov 05 09:50:11 volumio systemd[1]: dynamicswap.service: Succeeded. Nov 05 09:50:14 volumio volumio[16774]: info: ------------------------------------------- Nov 05 09:50:14 volumio volumio[16774]: info: ----- Volumio3 ---- Nov 05 09:50:14 volumio volumio[16774]: info: ------------------------------------------- Nov 05 09:50:14 volumio volumio[16774]: info: ----- System startup ---- Nov 05 09:50:14 volumio volumio[16774]: info: ------------------------------------------- Nov 05 09:50:15 volumio volumio[16774]: info: MYVOLUMIO Environment detected Nov 05 09:50:15 volumio volumio[16774]: info: Plugin folders cleanup Nov 05 09:50:15 volumio volumio[16774]: info: Scanning into folder /volumio/app/plugins/ Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category audio_interface Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category miscellanea Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category music_service Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category plugins.json Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category system_controller Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category user_interface Nov 05 09:50:15 volumio volumio[16774]: info: Scanning into folder /data/plugins/ Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category audio_interface Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category music_service Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category system_controller Nov 05 09:50:15 volumio volumio[16774]: info: Scanning category user_interface Nov 05 09:50:15 volumio volumio[16774]: info: Plugin folders cleanup completed Nov 05 09:50:15 volumio volumio[16774]: info: ------------------------------------------- Nov 05 09:50:15 volumio volumio[16774]: info: ----- Core plugins startup ---- Nov 05 09:50:15 volumio volumio[16774]: info: ------------------------------------------- Nov 05 09:50:15 volumio volumio[16774]: info: Loading plugins from folder /volumio/app/plugins/ Nov 05 09:50:15 volumio volumio[16774]: info: Adding plugin upnp to MyMusic Plugins Nov 05 09:50:15 volumio volumio[16774]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 05 09:50:15 volumio volumio[16774]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 05 09:50:15 volumio volumio[16774]: info: Loading plugins from folder /data/plugins/ Nov 05 09:50:15 volumio volumio[16774]: info: Loading plugin "system"... Nov 05 09:50:15 volumio volumio[16774]: info: Loading plugin "appearance"... Nov 05 09:50:16 volumio volumio-remote-updater[689]: [2025-11-05 09:50:16] [connect] Successful connection Nov 05 09:50:17 volumio volumio[16774]: info: Loading plugin "network"... Nov 05 09:50:17 volumio volumio[16774]: info: Refreshing Cached IP Addresses Nov 05 09:50:17 volumio sudo[16801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 05 09:50:17 volumio sudo[16801]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:17 volumio sudo[16801]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:17 volumio sudo[16803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 05 09:50:17 volumio sudo[16803]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:17 volumio sudo[16803]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:17 volumio volumio[16774]: info: Loading plugin "services"... Nov 05 09:50:17 volumio volumio[16774]: info: Loading plugin "alsa_controller"... Nov 05 09:50:17 volumio sudo[16814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 05 09:50:17 volumio sudo[16814]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:17 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 05 09:50:17 volumio volumio[16774]: info: Loading plugin "wizard"... Nov 05 09:50:17 volumio volumio[16774]: info: Loading plugin "networkfs"... Nov 05 09:50:18 volumio volumio[16774]: info: Cannot mount NAS local at system boot, trial number 1 ,retrying in 5 seconds Nov 05 09:50:18 volumio volumio[16774]: info: Starting Udev Watcher for removable devices Nov 05 09:50:18 volumio volumio[16774]: info: Ignoring mount for partition: 08D6-1819 Nov 05 09:50:18 volumio volumio[16774]: info: Ignoring mount for partition: boot Nov 05 09:50:18 volumio volumio[16774]: info: Ignoring mount for partition: volumio Nov 05 09:50:18 volumio volumio[16774]: info: Ignoring mount for partition: volumio_data Nov 05 09:50:18 volumio volumio[16774]: info: Mounting Device ________ Nov 05 09:50:18 volumio sudo[16833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/________ -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 05 09:50:18 volumio sudo[16833]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:18 volumio sudo[16833]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:18 volumio volumio[16774]: mount: /media/________: /dev/sdc1 already mounted on /media/________. Nov 05 09:50:18 volumio volumio[16774]: error: Failed to mount ________: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc1" "/mnt/USB/________" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 05 09:50:18 volumio volumio[16774]: mount: /media/________: /dev/sdc1 already mounted on /media/________. Nov 05 09:50:18 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 05 09:50:18 volumio volumio[16774]: info: Loading plugin "volumio_command_line_client"... Nov 05 09:50:18 volumio volumio[16774]: info: Loading plugin "upnp"... Nov 05 09:50:18 volumio volumio[16774]: info: [1762307418385] Starting Upmpd Daemon Nov 05 09:50:18 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 05 09:50:18 volumio volumio[16774]: info: Loading plugin "my_music"... Nov 05 09:50:18 volumio volumio[16774]: info: Loading plugin "mpd"... Nov 05 09:50:18 volumio volumio[16774]: info: Loading plugin "upnp_browser"... Nov 05 09:50:19 volumio volumio[16774]: info: Loading plugin "alarm-clock"... Nov 05 09:50:19 volumio volumio[16774]: info: Loading plugin "airplay_emulation"... Nov 05 09:50:19 volumio volumio[16774]: info: Starting Shairport Sync Nov 05 09:50:19 volumio volumio[16774]: info: Loading plugin "last_100"... Nov 05 09:50:19 volumio volumio[16774]: info: Loading plugin "webradio"... Nov 05 09:50:19 volumio volumio[16774]: info: Loading plugin "i2s_dacs"... Nov 05 09:50:19 volumio volumio[16774]: info: I2S DAC not set, start Auto-detection Nov 05 09:50:19 volumio volumio[16774]: info: Loading plugin "volumiodiscovery"... Nov 05 09:50:19 volumio volumio[16774]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 05 09:50:20 volumio node[16774]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 05 09:50:20 volumio volumio[16774]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 05 09:50:20 volumio volumio[16774]: *** WARNING *** For more information see Nov 05 09:50:20 volumio volumio[16774]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 05 09:50:20 volumio volumio[16774]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 05 09:50:20 volumio volumio[16774]: *** WARNING *** For more information see Nov 05 09:50:20 volumio node[16774]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 05 09:50:20 volumio node[16774]: *** WARNING *** For more information see Nov 05 09:50:20 volumio node[16774]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 05 09:50:20 volumio node[16774]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 05 09:50:20 volumio node[16774]: *** WARNING *** For more information see Nov 05 09:50:20 volumio volumio[16774]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 05 09:50:20 volumio volumio[16774]: info: Discovery: Started advertising with name: Volumio Nov 05 09:50:20 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 05 09:50:20 volumio volumio[16774]: info: Plugin calmradio is not enabled Nov 05 09:50:20 volumio volumio[16774]: info: Loading plugin "autostart"... Nov 05 09:50:20 volumio sudo[16814]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:20 volumio volumio[16774]: info: Applying required configuration parameters for plugin autostart Nov 05 09:50:20 volumio volumio[16774]: info: AutoStart - onVolumioStart - read config.json Nov 05 09:50:20 volumio volumio[16774]: info: Loading plugin "peppy_screensaver"... Nov 05 09:50:21 volumio kernel: usb usb4-port3: disabled by hub (EMI?), re-enabling... Nov 05 09:50:21 volumio kernel: usb 4-3: USB disconnect, device number 2 Nov 05 09:50:22 volumio volumio[16774]: info: Applying required configuration parameters for plugin peppy_screensaver Nov 05 09:50:22 volumio volumio[16774]: info: Loading plugin "outputs"... Nov 05 09:50:22 volumio volumio[16774]: info: Loading plugin "albumart"... Nov 05 09:50:22 volumio volumio[16774]: info: Plugin example_plugin is not enabled Nov 05 09:50:22 volumio volumio[16774]: info: Loading plugin "inputs"... Nov 05 09:50:22 volumio volumio[16774]: info: Loading plugin "updater_comm"... Nov 05 09:50:22 volumio kernel: usb 4-3: new high-speed USB device number 5 using ehci-pci Nov 05 09:50:23 volumio volumio[16774]: Forking 1 albumart workers Nov 05 09:50:23 volumio kernel: usb 4-3: New USB device found, idVendor=0bda, idProduct=9201, bcdDevice=f2.00 Nov 05 09:50:23 volumio kernel: usb 4-3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Nov 05 09:50:23 volumio kernel: usb 4-3: Product: RTL9201 Nov 05 09:50:23 volumio kernel: usb 4-3: Manufacturer: Realtek Nov 05 09:50:23 volumio kernel: usb 4-3: SerialNumber: 012345678999 Nov 05 09:50:23 volumio kernel: usb-storage 4-3:1.0: USB Mass Storage device detected Nov 05 09:50:23 volumio kernel: scsi host7: usb-storage 4-3:1.0 Nov 05 09:50:23 volumio volumio[16774]: info: Plugin mpdemulation is not enabled Nov 05 09:50:23 volumio volumio[16774]: info: Loading plugin "rest_api"... Nov 05 09:50:23 volumio volumio[16774]: info: Loading plugin "websocket"... Nov 05 09:50:23 volumio volumio[16774]: info: Starting Socket.io Server version 2.3.0 Nov 05 09:50:23 volumio volumio[16774]: info: Loading plugin "fusiondsp"... Nov 05 09:50:23 volumio kernel: usb 4-3: USB disconnect, device number 5 Nov 05 09:50:24 volumio volumio[16774]: info: Applying required configuration parameters for plugin fusiondsp Nov 05 09:50:25 volumio volumio[16774]: Starting albumart workers Nov 05 09:50:25 volumio volumio[16774]: info: Loading plugin "mpdoutput"... Nov 05 09:50:25 volumio volumio[16774]: info: Loading plugin "RoonBridge"... Nov 05 09:50:26 volumio volumio[16774]: info: Applying required configuration parameters for plugin RoonBridge Nov 05 09:50:26 volumio volumio[16774]: info: Loading plugin "minidlna"... Nov 05 09:50:26 volumio volumio[16774]: info: Applying required configuration parameters for plugin minidlna Nov 05 09:50:27 volumio volumio[16774]: info: Loading plugin "Systeminfo"... Nov 05 09:50:27 volumio kernel: usb 4-3: new high-speed USB device number 6 using ehci-pci Nov 05 09:50:27 volumio kernel: usb 4-3: New USB device found, idVendor=0bda, idProduct=9201, bcdDevice=f2.00 Nov 05 09:50:27 volumio kernel: usb 4-3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Nov 05 09:50:27 volumio kernel: usb 4-3: Product: RTL9201 Nov 05 09:50:27 volumio kernel: usb 4-3: Manufacturer: Realtek Nov 05 09:50:27 volumio kernel: usb 4-3: SerialNumber: 012345678999 Nov 05 09:50:27 volumio kernel: usb-storage 4-3:1.0: USB Mass Storage device detected Nov 05 09:50:27 volumio kernel: scsi host7: usb-storage 4-3:1.0 Nov 05 09:50:27 volumio volumio[16774]: info: Loading plugin "randomizer"... Nov 05 09:50:28 volumio volumio[16774]: info: Applying required configuration parameters for plugin randomizer Nov 05 09:50:28 volumio volumio[16774]: info: Loading i18n strings for locale zh Nov 05 09:50:28 volumio volumio[16774]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Nov 05 09:50:28 volumio volumio[16774]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Nov 05 09:50:28 volumio volumio[16774]: Updating browse sources language Nov 05 09:50:28 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:50:28 volumio kernel: scsi 7:0:0:0: Direct-Access KINGSTON SA400S37240G 1.02 PQ: 0 ANSI: 6 Nov 05 09:50:28 volumio kernel: sd 7:0:0:0: Attached scsi generic sg2 type 0 Nov 05 09:50:28 volumio kernel: sd 7:0:0:0: [sdd] 468862128 512-byte logical blocks: (240 GB/224 GiB) Nov 05 09:50:28 volumio kernel: sd 7:0:0:0: [sdd] Write Protect is off Nov 05 09:50:28 volumio kernel: sd 7:0:0:0: [sdd] Mode Sense: 37 00 00 08 Nov 05 09:50:28 volumio kernel: sd 7:0:0:0: [sdd] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Nov 05 09:50:28 volumio kernel: sdd: sdd1 Nov 05 09:50:28 volumio kernel: sd 7:0:0:0: [sdd] Attached SCSI disk Nov 05 09:50:29 volumio volumio-remote-updater[689]: [2025-11-05 09:50:29] [connect] Successful connection Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::initPlayerControls Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 05 09:50:29 volumio volumio[16774]: Express server listening on port 3000 Nov 05 09:50:29 volumio volumio[16774]: [Metrics] WebUI: 15s 837.34ms Nov 05 09:50:29 volumio volumio[16774]: info: Setting Device type: x86 Nov 05 09:50:29 volumio volumio[16774]: info: CoreStateMachine::resetVolumioState Nov 05 09:50:29 volumio volumio[16774]: info: CoreStateMachine::getcurrentVolume Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::volumioRetrievevolume Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:50:29 volumio volumio[16774]: info: Cannot mount NAS local at system boot, trial number 2 ,retrying in 5 seconds Nov 05 09:50:29 volumio sudo[16903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 05 09:50:29 volumio sudo[16903]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:29 volumio sudo[16903]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:29 volumio volumio[16774]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 05 09:50:29 volumio sudo[16905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 05 09:50:29 volumio volumio[16774]: info: Completed loading Core Plugins Nov 05 09:50:29 volumio sudo[16905]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:29 volumio volumio[16774]: info: Preparing to generate the ALSA configuration file Nov 05 09:50:29 volumio sudo[16905]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:29 volumio volumio[16774]: info: Volumio Network Manager: Network status updated: 2 Nov 05 09:50:29 volumio volumio[16774]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:13.2/usb4/4-3/4-3:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-uuid/08B9-0FE9 /dev/disk/by-label/\\xb7\\xa2\\xc9\\xd5\\xc8\\xcb\\xc9\\xf9 /dev/disk/by-path/pci-0000:00:13.2-usb-0:3:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/usb-NS3_00_256G_SSD_012345678999-0:0-part1 /dev/disk/by-partuuid/86d8aea1-9570-11f0-ab53-88665a0ab6bb","DEVNAME":"/dev/sdc1","DEVPATH":"/devices/pci0000:00/0000:00:13.2/usb4/4-3/4-3:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc1","DEVTYPE":"partition","DISKSEQ":"3","ID_BUS":"usb","ID_FS_LABEL":"________","ID_FS_LABEL_ENC":"\\xb7\\xa2\\xc9\\xd5\\xc8\\xcb\\xc9\\xf9","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"08B9-0FE9","ID_FS_UUID_ENC":"08B9-0FE9","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"00_256G_SSD","ID_MODEL_ENC":"00\\x20256G\\x20SSD\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"9201","ID_PART_ENTRY_DISK":"8:32","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"500101401","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"86d8aea1-9570-11f0-ab53-88665a0ab6bb","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"430b0710-ebd4-473d-a46b-707679619b38","ID_PATH":"pci-0000:00:13.2-usb-0:3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_13_2-usb-0_3_1_0-scsi-0_0_0_0","ID_REVISION":"1.02","ID_SERIAL":"NS3_00_256G_SSD_012345678999-0:0","ID_SERIAL_SHORT":"012345678999","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"NS3","ID_VENDOR_ENC":"\\x20\\x20\\x20\\x20\\x20NS3","ID_VENDOR_ID":"0bda","MAJOR":"8","MINOR":"33","PARTN":"1","PARTNAME":"Basic data partition","SEQNUM":"3058","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"4697818"} Nov 05 09:50:29 volumio sudo[16909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdc1 Nov 05 09:50:29 volumio sudo[16909]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:29 volumio sudo[16909]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:29 volumio volumio[16774]: umount: /media/________: target is busy. Nov 05 09:50:29 volumio volumio[16774]: error: Failed to umount ________: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sdc1" Nov 05 09:50:29 volumio volumio[16774]: umount: /media/________: target is busy. Nov 05 09:50:29 volumio volumio[16774]: info: CoreStateMachine::pushState Nov 05 09:50:29 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::volumioPushState Nov 05 09:50:29 volumio volumio[16774]: info: CoreStateMachine::updateTrackBlock Nov 05 09:50:29 volumio volumio[16774]: info: CorePlayQueue::getTrackBlock Nov 05 09:50:29 volumio volumio[16774]: info: CoreCommandRouter::volumioRetrievevolume Nov 05 09:50:30 volumio volumio[16774]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Nov 05 09:50:30 volumio volumio[16774]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 05 09:50:30 volumio volumio[16774]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 05 09:50:30 volumio volumio[16774]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Nov 05 09:50:30 volumio volumio[16774]: info: Reading ALSA contributions from plugins. Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 1 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 2 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 4 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 5 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 6 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 7 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 8 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 10 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 11 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 12 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 13 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 14 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 16 Nov 05 09:50:30 volumio volumio-remote-updater[689]: [2025-11-05 09:50:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1762307429 101 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 17 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 18 Nov 05 09:50:30 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19 Nov 05 09:50:30 volumio volumio[16774]: info: CoreStateMachine::pushState Nov 05 09:50:30 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:30 volumio volumio[16774]: info: CoreCommandRouter::volumioPushState Nov 05 09:50:30 volumio volumio[16774]: info: Mounting Device 0B9013F30B9013F3 Nov 05 09:50:30 volumio sudo[16927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdd1 /mnt/USB/0B9013F30B9013F3 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 05 09:50:30 volumio sudo[16927]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:31 volumio ntfs-3g[16930]: Version 2017.3.23AR.3 integrated FUSE 28 Nov 05 09:50:31 volumio ntfs-3g[16930]: Mounted /dev/sdd1 (Read-Write, label "", NTFS 3.1) Nov 05 09:50:31 volumio ntfs-3g[16930]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 05 09:50:31 volumio ntfs-3g[16930]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdd1,blkdev,blksize=4096 Nov 05 09:50:31 volumio ntfs-3g[16930]: Global ownership and permissions enforced, configuration type 7 Nov 05 09:50:31 volumio sudo[16927]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:31 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 20 Nov 05 09:50:31 volumio volumio[16774]: info: CoreStateMachine::setRepeat true single undefined Nov 05 09:50:31 volumio volumio[16774]: info: CoreStateMachine::pushState Nov 05 09:50:31 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:31 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 09:50:31 volumio volumio[16774]: info: CoreCommandRouter::volumioPushState Nov 05 09:50:31 volumio volumio[16774]: info: CoreStateMachine::setRandom false Nov 05 09:50:31 volumio volumio[16774]: info: CoreStateMachine::pushState Nov 05 09:50:31 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:31 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 09:50:31 volumio volumio[16774]: info: CoreCommandRouter::volumioPushState Nov 05 09:50:31 volumio volumio[16774]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 21 Nov 05 09:50:31 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 22 Nov 05 09:50:31 volumio sudo[16933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 05 09:50:31 volumio sudo[16933]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:31 volumio volumio[16774]: info: Scanning new location : "USB/0B9013F30B9013F3" Nov 05 09:50:31 volumio sudo[16933]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:31 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:50:31 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 05 09:50:32 volumio volumio[16774]: info: Discovery: adding 495d9a88-17c5-4731-81ea-956915b1778f Nov 05 09:50:32 volumio volumio[16774]: info: Discovery: Found device Volumio Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:50:32 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:50:32 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:50:32 volumio volumio[16774]: info: Upmpdcli Daemon Started Nov 05 09:50:32 volumio volumio[16774]: info: Asound.conf file unchanged, so no further update is needed Nov 05 09:50:32 volumio volumio[16774]: info: Output device has changed, restarting MPD Nov 05 09:50:32 volumio sudo[16939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 05 09:50:32 volumio sudo[16939]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:32 volumio volumio[16774]: info: Output device has changed, restarting Shairport Sync Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:50:32 volumio sudo[16939]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:32 volumio sudo[16942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 05 09:50:32 volumio sudo[16942]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:32 volumio systemd[1]: Stopping Music Player Daemon... Nov 05 09:50:32 volumio volumio[16774]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 05 09:50:32 volumio volumio[16774]: info: ___________ START PLUGINS ___________ Nov 05 09:50:32 volumio volumio[16774]: info: ControllerMpd::onStart: Initializing MPD Nov 05 09:50:32 volumio volumio[16774]: info: Creating MPD Configuration file Nov 05 09:50:32 volumio sudo[16949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 05 09:50:32 volumio sudo[16949]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:32 volumio sudo[16949]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 05 09:50:32 volumio volumio[16774]: info: [1762307432667] CoreMusicLibrary::Adding element 媒体服务器 Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:50:32 volumio sudo[16952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 05 09:50:32 volumio sudo[16952]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:50:32 volumio volumio[16774]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:32 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:50:33 volumio volumio[16774]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 05 09:50:33 volumio volumio[16774]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 05 09:50:33 volumio volumio[16774]: info: [1762307433106] CoreMusicLibrary::Adding element Last_100 Nov 05 09:50:33 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:50:33 volumio volumio[16774]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 05 09:50:33 volumio volumio[16774]: info: [1762307433115] CoreMusicLibrary::Adding element Webradio Nov 05 09:50:33 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:50:33 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 05 09:50:33 volumio volumio[16774]: info: Initializing BBC Radios Nov 05 09:50:33 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 05 09:50:33 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:50:33 volumio volumio[16774]: info: AutoStart - onStart Nov 05 09:50:33 volumio volumio[16774]: info: Loading i18n strings for locale zh Nov 05 09:50:33 volumio volumio[16774]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Nov 05 09:50:33 volumio volumio[16774]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Nov 05 09:50:33 volumio volumio[16774]: info: /tmp/myfifo created Nov 05 09:50:33 volumio volumio[16774]: info: /tmp/myfifosa created Nov 05 09:50:33 volumio sudo[16975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Nov 05 09:50:33 volumio sudo[16975]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:33 volumio sudo[16975]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:33 volumio volumio[16774]: info: snd-dummy loaded Nov 05 09:50:33 volumio volumio[16774]: error: Plugin peppy_screensaver failed to start! Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Nov 05 09:50:33 volumio volumio[16774]: info: Loading i18n strings for locale zh Nov 05 09:50:33 volumio volumio[16774]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Nov 05 09:50:33 volumio volumio[16774]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Nov 05 09:50:33 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 05 09:50:33 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:33 volumio volumio[16774]: info: FusionDsp - mixtype--------------------- Software Nov 05 09:50:33 volumio volumio[16774]: info: Loading i18n strings for locale zh Nov 05 09:50:33 volumio volumio[16774]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Nov 05 09:50:33 volumio volumio[16774]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Nov 05 09:50:33 volumio sudo[16978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Nov 05 09:50:33 volumio sudo[16978]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:33 volumio sudo[16978]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:34 volumio volumio[16774]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 05 09:50:34 volumio volumio[16774]: info: [1762307434051] CoreMusicLibrary::Adding element Randomizer Nov 05 09:50:34 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:50:34 volumio volumio[16774]: Cannot find translation for source Randomizer Nov 05 09:50:34 volumio volumio[16774]: info: Volumio Calling Home Nov 05 09:50:34 volumio volumio[16774]: info: Preparing to generate the ALSA configuration file Nov 05 09:50:34 volumio volumio[16774]: info: Cannot mount NAS local at system boot, trial number 3 ,retrying in 5 seconds Nov 05 09:50:34 volumio volumio[16774]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 05 09:50:34 volumio volumio[16774]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 05 09:50:34 volumio volumio[16774]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Nov 05 09:50:34 volumio volumio[16774]: info: Reading ALSA contributions from plugins. Nov 05 09:50:34 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 05 09:50:34 volumio volumio[16774]: info: CoreCommandRouter::volumioGetVisibleSources Nov 05 09:50:34 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:50:34 volumio volumio[16774]: info: Listing playlists Nov 05 09:50:35 volumio volumio[16774]: info: MPD Permissions set Nov 05 09:50:35 volumio volumio[16774]: info: MPD Permissions set Nov 05 09:50:35 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 23 Nov 05 09:50:35 volumio volumio[16774]: info: Volumio called home Nov 05 09:50:35 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 24 Nov 05 09:50:35 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 25 Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:50:35 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 05 09:50:36 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:36 volumio volumio[16774]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Nov 05 09:50:36 volumio volumio[16774]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Nov 05 09:50:36 volumio volumio[16774]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Nov 05 09:50:36 volumio volumio[16774]: info: camilladsp service started and running in background, instance 1 Nov 05 09:50:36 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:50:36 volumio volumio[16774]: cannot open device 'volumioHw': Device or resource busy Nov 05 09:50:36 volumio volumio[16774]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 05 09:50:36 volumio volumio[16774]: cannot open device 'volumioHw': Device or resource busy Nov 05 09:50:36 volumio volumio[16774]: info: FusionDsp loaded Nov 05 09:50:36 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 05 09:50:36 volumio volumio[16774]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 05 09:50:36 volumio sudo[17015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 05 09:50:36 volumio volumio[16774]: info: Adding Signal Path Element [object Object] Nov 05 09:50:36 volumio volumio[16774]: info: Adding fusiondspeq DSP Signal Path Element Nov 05 09:50:36 volumio volumio[16774]: info: FusionDsp - ---- installed callbackRead Nov 05 09:50:36 volumio volumio[16774]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 05 09:50:36 volumio sudo[17015]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:50:36 volumio sudo[17015]: pam_unix(sudo:session): session closed for user root Nov 05 09:50:54 volumio mpd_monitor.sh[671]: MPD Monitor Service: MPD Appears to be inactive, restarting Nov 05 09:51:00 volumio volumio-remote-updater[689]: [2025-11-05 09:51:00] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Nov 05 09:51:05 volumio volumio-remote-updater[689]: [2025-11-05 09:51:05] [connect] Successful connection Nov 05 09:51:07 volumio volumio[16774]: MPD error: Timeout Nov 05 09:51:07 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 26 Nov 05 09:51:07 volumio volumio[16774]: info: minidlna: Found miniDLNA version 1.2.1 Nov 05 09:51:07 volumio volumio[16774]: info: minidlna: Starting minidlna.service Nov 05 09:51:07 volumio volumio[16774]: info: Cannot mount NAS local at system boot, trial number 4 ,retrying in 5 seconds Nov 05 09:51:07 volumio sudo[17123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Nov 05 09:51:07 volumio sudo[17123]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:07 volumio sudo[17123]: pam_unix(sudo:session): session closed for user root Nov 05 09:51:07 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 05 09:51:07 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:51:07 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 05 09:51:07 volumio volumio[16774]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion Nov 05 09:51:07 volumio volumio[16774]: error: Plugin user_interface peppy_screensaver failed to complete 'onStart' in a timely fashion Nov 05 09:51:07 volumio volumio[16774]: error: Plugin music_service minidlna failed to complete 'onStart' in a timely fashion Nov 05 09:51:07 volumio volumio[16774]: info: ------------------------------------------- Nov 05 09:51:07 volumio volumio[16774]: info: ----- MyVolumio plugins startup ---- Nov 05 09:51:07 volumio volumio[16774]: info: ------------------------------------------- Nov 05 09:51:07 volumio volumio[16774]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 05 09:51:07 volumio volumio[16774]: info: AutoStart - Plugin is starting Nov 05 09:51:07 volumio volumio[16774]: info: CoreCommandRouter::volumioGetQueue Nov 05 09:51:07 volumio volumio[16774]: info: CoreStateMachine::getQueue Nov 05 09:51:07 volumio volumio[16774]: info: CorePlayQueue::getQueue Nov 05 09:51:07 volumio volumio[16774]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Nov 05 09:51:07 volumio volumio[16774]: info: minidlna: systemctl start minidlna.service succeeded. Nov 05 09:51:07 volumio volumio[16774]: info: Starting Shairport Sync Nov 05 09:51:07 volumio volumio[16774]: info: Starting Shairport Sync Nov 05 09:51:07 volumio volumio[16774]: info: Starting Shairport Sync Nov 05 09:51:07 volumio sudo[17132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 05 09:51:07 volumio sudo[17132]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:07 volumio sudo[17134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 05 09:51:07 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 3 Nov 05 09:51:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 05 09:51:07 volumio sudo[17134]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:07 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 05 09:51:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 05 09:51:07 volumio sudo[17137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 05 09:51:07 volumio sudo[17137]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 05 09:51:07 volumio sudo[17132]: pam_unix(sudo:session): session closed for user root Nov 05 09:51:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 05 09:51:08 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 05 09:51:08 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 05 09:51:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 05 09:51:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 05 09:51:08 volumio sudo[17134]: pam_unix(sudo:session): session closed for user root Nov 05 09:51:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 05 09:51:08 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 05 09:51:08 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 05 09:51:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 05 09:51:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 05 09:51:08 volumio volumio-remote-updater[689]: [2025-11-05 09:51:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1762307465 101 Nov 05 09:51:08 volumio volumio[16774]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Nov 05 09:51:08 volumio sudo[17137]: pam_unix(sudo:session): session closed for user root Nov 05 09:51:08 volumio volumio[16774]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 05 09:51:08 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Nov 05 09:51:08 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 05 09:51:08 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 05 09:51:08 volumio volumio[16774]: info: Discovery: Getting this device information Nov 05 09:51:08 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:51:08 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:51:08 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 05 09:51:08 volumio volumio[16774]: info: Shairport-Sync Started Nov 05 09:51:08 volumio volumio[16774]: Error adding Membership: Error: addMembership EINVAL Nov 05 09:51:08 volumio volumio[16774]: info: Shairport-Sync Started Nov 05 09:51:08 volumio volumio[16774]: info: Asound.conf file unchanged, so no further update is needed Nov 05 09:51:08 volumio volumio[16774]: info: Output device has changed, restarting MPD Nov 05 09:51:08 volumio volumio[16774]: info: Output device has changed, restarting Shairport Sync Nov 05 09:51:08 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:51:08 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:51:08 volumio sudo[17164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 05 09:51:08 volumio sudo[17164]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:08 volumio sudo[17166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 05 09:51:08 volumio sudo[17166]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:08 volumio sudo[17164]: pam_unix(sudo:session): session closed for user root Nov 05 09:51:08 volumio volumio[16774]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 05 09:51:08 volumio volumio[16774]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 05 09:51:09 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Nov 05 09:51:09 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 10 Nov 05 09:51:09 volumio volumio[16774]: info: MPD Permissions set Nov 05 09:51:09 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Nov 05 09:51:09 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:51:09 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 05 09:51:09 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:51:09 volumio volumio[16774]: info: Starting Shairport Sync Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:51:09 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:51:09 volumio volumio[16774]: info: CoreCommandRouter::volumioPause Nov 05 09:51:09 volumio volumio[16774]: info: CoreStateMachine::pause Nov 05 09:51:09 volumio volumio[16774]: info: mpdhttpout --- Volumio set on pause Nov 05 09:51:09 volumio volumio[16774]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Nov 05 09:51:09 volumio sudo[17179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 05 09:51:09 volumio sudo[17179]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 05 09:51:09 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 05 09:51:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 05 09:51:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 05 09:51:09 volumio sudo[17179]: pam_unix(sudo:session): session closed for user root Nov 05 09:51:09 volumio volumio[16774]: info: Shairport-Sync Started Nov 05 09:51:10 volumio sudo[17185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 05 09:51:10 volumio sudo[17185]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:10 volumio sudo[17185]: pam_unix(sudo:session): session closed for user root Nov 05 09:51:10 volumio sudo[17188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 05 09:51:10 volumio sudo[17188]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:10 volumio sudo[17188]: pam_unix(sudo:session): session closed for user root Nov 05 09:51:11 volumio volumio[16774]: verbose: New Socket.io Connection to 192.168.3.220 from 192.168.3.52 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 14 Nov 05 09:51:11 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:51:11 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:51:11 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 05 09:51:11 volumio volumio[16774]: info: Listing playlists Nov 05 09:51:11 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 05 09:51:11 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 05 09:51:11 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 05 09:51:11 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 05 09:51:11 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 05 09:51:11 volumio sudo[17191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 05 09:51:11 volumio sudo[17191]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:12 volumio volumio[16774]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Nov 05 09:51:12 volumio volumio[16774]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Nov 05 09:51:12 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:51:12 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:51:12 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 05 09:51:12 volumio volumio[16774]: info: CoreCommandRouter::volumioGetVisibleSources Nov 05 09:51:12 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:51:12 volumio volumio[16774]: info: Listing playlists Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 05 09:51:17 volumio volumio[16774]: info: Adding plugin bluetooth to MyMusic Plugins Nov 05 09:51:17 volumio volumio[16774]: info: Adding plugin multiroom to MyMusic Plugins Nov 05 09:51:17 volumio volumio[16774]: info: Adding plugin metavolumio to MyMusic Plugins Nov 05 09:51:17 volumio volumio[16774]: info: Adding plugin cd_controller to MyMusic Plugins Nov 05 09:51:17 volumio volumio[16774]: info: Adding plugin qobuzconnect to MyMusic Plugins Nov 05 09:51:17 volumio volumio[16774]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 05 09:51:17 volumio volumio[16774]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 05 09:51:17 volumio volumio[16774]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 05 09:51:18 volumio volumio[16774]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 05 09:51:18 volumio volumio[16774]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 05 09:51:18 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:51:18 volumio volumio[16774]: info: Starting MyVolumio Remote Streaming Endpoints Nov 05 09:51:18 volumio volumio[16774]: info: MyVolumio login type: Token Nov 05 09:51:18 volumio volumio[16774]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 05 09:51:18 volumio volumio[16774]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 05 09:51:20 volumio volumio[16774]: info: Starting Streaming Service Transparent Proxy Nov 05 09:51:20 volumio volumio[16774]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 05 09:51:20 volumio volumio[16774]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 05 09:51:20 volumio volumio[16774]: info: Streaming services startup Nov 05 09:51:20 volumio volumio[16774]: info: Starting Streaming Daemon Nov 05 09:51:20 volumio sudo[17216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 05 09:51:20 volumio sudo[17216]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:20 volumio volumio[16774]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 05 09:51:20 volumio sudo[17216]: pam_unix(sudo:session): session closed for user root Nov 05 09:51:20 volumio volumio[16774]: info: CoreCommandRouter::volumioGetVisibleSources Nov 05 09:51:20 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 09:51:20 volumio volumio[16774]: info: CoreCommandRouter::volumioGetQueue Nov 05 09:51:20 volumio volumio[16774]: info: CoreStateMachine::getQueue Nov 05 09:51:20 volumio volumio[16774]: info: CorePlayQueue::getQueue Nov 05 09:51:20 volumio volumio[16774]: error: Cannot start Volumio Streaming Daemon Nov 05 09:51:20 volumio volumio[16774]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 05 09:51:20 volumio volumio[16774]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 05 09:51:21 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 05 09:51:21 volumio volumio[16774]: info: CURURI: music-library Nov 05 09:51:21 volumio volumio[16774]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Nov 05 09:51:22 volumio volumio[16774]: STREAMING PROXY: Starting server on port 3245 Nov 05 09:51:22 volumio volumio[16774]: Node JS runtime: 14 Nov 05 09:51:33 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 05 09:51:33 volumio volumio[16774]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Nov 05 09:51:33 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:51:33 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:51:38 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:51:38 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 05 09:51:38 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 05 09:51:38 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 05 09:51:38 volumio volumio[16774]: info: CoreCommandRouter::volumioGetBrowseSources Nov 05 09:51:38 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 05 09:51:40 volumio volumio[16774]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 05 09:51:40 volumio volumio[16774]: info: Completed starting MyVolumio Plugin Nov 05 09:51:40 volumio volumio[16774]: [Metrics] CommandRouter: 85s 740.94ms Nov 05 09:51:40 volumio volumio[16774]: info: CoreCommandRouter::volumiosetStartupVolume Nov 05 09:51:40 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 09:51:40 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 09:51:40 volumio volumio[16774]: info: CoreCommandRouter::Close All Modals sent Nov 05 09:51:40 volumio volumio[16774]: info: CoreCommandRouter::Close All Modals sent Nov 05 09:51:40 volumio volumio[16774]: info: FusionDsp - ---- read samplerate, raw: Nov 05 09:51:40 volumio volumio[16774]: error: FusionDsp - invalid sample rate Nov 05 09:51:40 volumio volumio[16774]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 05 09:51:40 volumio volumio[16774]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 05 09:51:40 volumio volumio[16774]: info: camilladsp stopping service pid 17005... Nov 05 09:51:40 volumio volumio[16774]: info: camilladsp service terminated, instance 1 Nov 05 09:51:40 volumio volumio[16774]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 05 09:51:40 volumio volumio[16774]: info: camilladsp service started and running in background, instance 1 Nov 05 09:51:41 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 05 09:51:41 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 05 09:51:41 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 05 09:51:47 volumio volumio[16774]: info: BOOT COMPLETED Nov 05 09:51:47 volumio volumio[16774]: info: mpdhttpout ---Boot completed detected! Patching mpd now! Nov 05 09:51:47 volumio volumio[16774]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Nov 05 09:51:47 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:51:47 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:51:47 volumio volumio[16774]: info: CoreCommandRouter::volumioPause Nov 05 09:51:47 volumio volumio[16774]: info: CoreStateMachine::pause Nov 05 09:51:47 volumio volumio[16774]: info: mpdhttpout --- Volumio set on pause Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 05 09:51:49 volumio volumio[16774]: info: Retrieving Cloud Streaming UI Nov 05 09:51:49 volumio volumio[16774]: info: Getting Tidal Cloud Configuration Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 05 09:51:49 volumio volumio[16774]: info: Getting Qobuz Cloud Configuration Nov 05 09:51:49 volumio volumio[16774]: info: Asking plugin for UI Config Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 05 09:51:49 volumio volumio[16774]: info: Getting Spotify Cloud Configuration Nov 05 09:51:49 volumio volumio[16774]: info: Asking plugin for UI Config Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 05 09:51:49 volumio volumio[16774]: info: Saving Spotify Acccount Nov 05 09:51:49 volumio volumio[16774]: info: Got Tidal Cloud Configuration Nov 05 09:51:49 volumio volumio[16774]: info: Got it Nov 05 09:51:49 volumio volumio[16774]: info: Got it Nov 05 09:51:49 volumio volumio[16774]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 05 09:51:49 volumio volumio[16774]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::volumioGetBrowseSources Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 05 09:51:49 volumio volumio[16774]: info: Received Get System Info Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 05 09:51:49 volumio volumio[16774]: info: Discovery: Getting this device information Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::volumioGetState Nov 05 09:51:49 volumio volumio[16774]: info: CorePlayQueue::getTrack 0 Nov 05 09:51:49 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 05 09:51:50 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 05 09:51:50 volumio sudo[17296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 05 09:51:50 volumio sudo[17296]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 09:51:50 volumio volumio[16774]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 05 09:51:50 volumio volumio[16774]: info: Retrying Login Due to Network Error Nov 05 09:51:52 volumio volumio[16774]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Nov 05 09:51:52 volumio volumio[16774]: verbose: ControllerMpd::sendMpdCommand rescan Nov 05 09:51:52 volumio volumio[16774]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 09:51:52 volumio volumio[16774]: TypeError: Cannot read property 'then' of undefined Nov 05 09:51:52 volumio volumio[16774]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6) Nov 05 09:51:52 volumio volumio[16774]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1886:15) Nov 05 09:51:52 volumio volumio[16774]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Nov 05 09:51:52 volumio volumio[16774]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1087:26) Nov 05 09:51:52 volumio volumio[16774]: at Socket.emit (events.js:400:28) Nov 05 09:51:52 volumio volumio[16774]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 05 09:51:52 volumio volumio[16774]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Nov 05 09:51:52 volumio volumio[16774]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 09:51:53 volumio sudo[17308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-05 09:50 Nov 05 09:51:53 volumio sudo[17308]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"