-- Logs begin at Sun 2025-06-15 07:04:11 UTC, end at Fri 2025-12-26 20:25:31 UTC. -- Dec 26 20:24:00 volumio volumio[5022]: info: Cannot mount NAS 1T at system boot, trial number 1 ,retrying in 5 seconds Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "alarm-clock"... Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "airplay_emulation"... Dec 26 20:24:00 volumio volumio[5022]: info: Starting Shairport Sync Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "last_100"... Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "webradio"... Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "i2s_dacs"... Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "volumiodiscovery"... Dec 26 20:24:00 volumio volumio[5022]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 26 20:24:00 volumio node[5022]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 26 20:24:00 volumio node[5022]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 20:24:00 volumio node[5022]: *** WARNING *** For more information see Dec 26 20:24:00 volumio node[5022]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 26 20:24:00 volumio node[5022]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 20:24:00 volumio node[5022]: *** WARNING *** For more information see Dec 26 20:24:00 volumio volumio[5022]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 20:24:00 volumio volumio[5022]: *** WARNING *** For more information see Dec 26 20:24:00 volumio volumio[5022]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 26 20:24:00 volumio volumio[5022]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 20:24:00 volumio volumio[5022]: *** WARNING *** For more information see Dec 26 20:24:00 volumio volumio[5022]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 26 20:24:00 volumio volumio[5022]: Discovery: StartAdv! undefined Dec 26 20:24:00 volumio volumio[5022]: Discovery: Started advertising... Volumio - undefined Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "outputs"... Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "albumart"... Dec 26 20:24:00 volumio volumio[5022]: info: Plugin example_plugin is not enabled Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "inputs"... Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "updater_comm"... Dec 26 20:24:00 volumio volumio[5022]: info: Plugin mpdemulation is not enabled Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "rest_api"... Dec 26 20:24:00 volumio volumio[5022]: info: Loading plugin "websocket"... Dec 26 20:24:00 volumio volumio[5022]: info: ___________ START PLUGINS ___________ Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 20:24:00 volumio volumio[5022]: info: [1766780640421] CoreMusicLibrary::Adding element Media Servers Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: Forking 3 albumart workers Dec 26 20:24:00 volumio volumio[5022]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 20:24:00 volumio volumio[5022]: info: [1766780640507] CoreMusicLibrary::Adding element Last_100 Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 20:24:00 volumio volumio[5022]: info: [1766780640510] CoreMusicLibrary::Adding element Webradio Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 20:24:00 volumio volumio[5022]: info: ------------------------------------------- Dec 26 20:24:00 volumio volumio[5022]: info: ----- MyVolumio plugins startup ---- Dec 26 20:24:00 volumio volumio[5022]: info: ------------------------------------------- Dec 26 20:24:00 volumio volumio[5022]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 26 20:24:00 volumio volumio[5022]: info: Loading i18n strings for locale zh Dec 26 20:24:00 volumio volumio[5022]: Updating browse sources language Dec 26 20:24:00 volumio volumio[5022]: Cannot find translation for sourceMedia Servers Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::initPlayerControls Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:24:00 volumio volumio[5022]: info: BOOT COMPLETED Dec 26 20:24:00 volumio volumio[5022]: [Metrics] CommandRouter: 2s 824.59ms Dec 26 20:24:00 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:00 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Dec 26 20:24:00 volumio volumio[5022]: Starting albumart workers Dec 26 20:24:01 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:24:01 volumio volumio[5022]: Starting albumart workers Dec 26 20:24:01 volumio volumio[5022]: Starting albumart workers Dec 26 20:24:01 volumio volumio-remote-updater[489]: [2025-12-26 20:24:01] [connect] Successful connection Dec 26 20:24:05 volumio volumio[5022]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 26 20:24:05 volumio volumio[5022]: info: CoreCommandRouter::Close All Modals sent Dec 26 20:24:05 volumio volumio[5022]: info: CoreCommandRouter::Close All Modals sent Dec 26 20:24:05 volumio volumio[5022]: Express server listening on port 3000 Dec 26 20:24:05 volumio volumio[5022]: [Metrics] WebUI: 8s 418.05ms Dec 26 20:24:05 volumio volumio[5022]: Volumio Calling Home Dec 26 20:24:05 volumio volumio[5022]: info: CoreStateMachine::resetVolumioState Dec 26 20:24:05 volumio volumio[5022]: info: CoreStateMachine::getcurrentVolume Dec 26 20:24:05 volumio volumio[5022]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 20:24:06 volumio volumio[5022]: info: Cannot mount NAS 1T at system boot, trial number 2 ,retrying in 5 seconds Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:06 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:06 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:06 volumio volumio[5022]: info: CoreStateMachine::updateTrackBlock Dec 26 20:24:06 volumio volumio[5022]: info: CorePlayQueue::getTrackBlock Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 20:24:06 volumio volumio[5022]: info: Setting Device type: Raspberry PI Dec 26 20:24:06 volumio volumio[5022]: error: Cannot initialize MPD Connection: MPD is not running Dec 26 20:24:06 volumio volumio-remote-updater[489]: [2025-12-26 20:24:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1766780641 101 Dec 26 20:24:06 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:06 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:06 volumio volumio[5022]: info: Cannot read play queue from file Dec 26 20:24:06 volumio volumio[5022]: info: CoreStateMachine::setRepeat false single undefined Dec 26 20:24:06 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:06 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:06 volumio volumio[5022]: info: CoreStateMachine::setRandom false Dec 26 20:24:06 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:06 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:06 volumio volumio[5022]: info: Starting Shairport Sync Dec 26 20:24:06 volumio volumio[5022]: info: Starting Shairport Sync Dec 26 20:24:06 volumio sudo[5148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 20:24:06 volumio sudo[5148]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:06 volumio sudo[5150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 20:24:06 volumio sudo[5150]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 26 20:24:06 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 26 20:24:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 26 20:24:06 volumio sudo[5148]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 26 20:24:06 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 26 20:24:06 volumio sudo[5150]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 26 20:24:06 volumio volumio[5022]: info: Shairport-Sync Started Dec 26 20:24:06 volumio volumio[5022]: Error adding Membership: Error: addMembership EINVAL Dec 26 20:24:06 volumio volumio[5022]: Discovery: adding 23003156-77c0-4b6d-b981-53fd832c8ef3 Dec 26 20:24:06 volumio volumio[5022]: info: mDNS: Found device Volumio Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::volumioGetState Dec 26 20:24:06 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:06 volumio volumio[5022]: info: Shairport-Sync Started Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::volumioGetState Dec 26 20:24:06 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:06 volumio volumio[5022]: info: Volumio called home Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 26 20:24:06 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 26 20:24:08 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:24:09 volumio sudo[5184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 20:24:09 volumio sudo[5184]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:09 volumio sudo[5186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 20:24:09 volumio sudo[5184]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:09 volumio sudo[5186]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:09 volumio sudo[5186]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:09 volumio sudo[5197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 26 20:24:09 volumio sudo[5197]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:09 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Dec 26 20:24:09 volumio sudo[5197]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:09 volumio volumio[5022]: info: Upmpdcli Daemon Started Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 26 20:24:09 volumio volumio[5022]: info: Adding plugin bluetooth to MyMusic Plugins Dec 26 20:24:09 volumio volumio[5022]: info: Adding plugin cd_controller to MyMusic Plugins Dec 26 20:24:09 volumio volumio[5022]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 26 20:24:09 volumio volumio[5022]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 26 20:24:09 volumio volumio[5022]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 26 20:24:10 volumio volumio[5022]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 26 20:24:10 volumio volumio[5022]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 26 20:24:10 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:10 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:10 volumio volumio[5022]: info: Starting MyVolumio Remote Streaming Endpoints Dec 26 20:24:10 volumio volumio[5022]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 26 20:24:10 volumio volumio[5022]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 26 20:24:10 volumio volumio[5022]: info: Streaming services startup Dec 26 20:24:10 volumio volumio[5022]: info: Starting Streaming Daemon Dec 26 20:24:10 volumio sudo[5211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 26 20:24:10 volumio sudo[5211]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:10 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 26 20:24:10 volumio volumio[5022]: info: MyVolumio not started Dec 26 20:24:10 volumio volumio[5022]: info: Initializing device activation check Dec 26 20:24:10 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 26 20:24:10 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 26 20:24:10 volumio volumio[5022]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 26 20:24:10 volumio sudo[5211]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:10 volumio volumio-streaming-daemon[5221]: ############################ Dec 26 20:24:10 volumio volumio-streaming-daemon[5221]: # Volumio Streaming Daemon # Dec 26 20:24:10 volumio volumio-streaming-daemon[5221]: # Running on port 7777 # Dec 26 20:24:10 volumio volumio-streaming-daemon[5221]: ############################ Dec 26 20:24:10 volumio volumio-streaming-daemon[5221]: Environment: production Dec 26 20:24:10 volumio volumio[5022]: info: CoreCommandRouter::volumioGetState Dec 26 20:24:10 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:10 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 26 20:24:10 volumio volumio[5022]: info: CoreCommandRouter::volumioGetVisibleSources Dec 26 20:24:10 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:10 volumio volumio[5022]: info: Listing playlists Dec 26 20:24:10 volumio volumio[5022]: info: CoreCommandRouter::volumioGetQueue Dec 26 20:24:10 volumio volumio[5022]: info: CoreStateMachine::getQueue Dec 26 20:24:10 volumio volumio[5022]: info: CorePlayQueue::getQueue Dec 26 20:24:11 volumio volumio[5022]: info: Cannot mount NAS 1T at system boot, trial number 3 ,retrying in 5 seconds Dec 26 20:24:12 volumio volumio-streaming-daemon[5221]: Environment: production Dec 26 20:24:12 volumio volumio[5022]: info: Fetching Streaming Services browse cache Dec 26 20:24:13 volumio volumio[5022]: info: VolumeController::SetAlsaVolume95 Dec 26 20:24:13 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:13 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:13 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:13 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:13 volumio volumio[5022]: info: VolumeController::SetAlsaVolume70 Dec 26 20:24:13 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:13 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:13 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:13 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:13 volumio volumio[5022]: info: VolumeController::SetAlsaVolume55 Dec 26 20:24:13 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:13 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:13 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:13 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:13 volumio volumio[5022]: info: VolumeController::SetAlsaVolume40 Dec 26 20:24:13 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:13 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:13 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:13 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:14 volumio volumio[5022]: info: VolumeController::SetAlsaVolume25 Dec 26 20:24:14 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:14 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:14 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:14 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:14 volumio volumio[5022]: info: VolumeController::SetAlsaVolume30 Dec 26 20:24:14 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:14 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:14 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:14 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:14 volumio volumio[5022]: info: VolumeController::SetAlsaVolume35 Dec 26 20:24:14 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:14 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:14 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:14 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:14 volumio volumio[5022]: info: VolumeController::SetAlsaVolume90 Dec 26 20:24:14 volumio volumio[5022]: info: CoreStateMachine::pushState Dec 26 20:24:14 volumio volumio[5022]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:14 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:14 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:14 volumio nmbd[798]: [2025/12/26 20:24:14.478769, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 26 20:24:14 volumio nmbd[798]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.50.48 for name WORKGROUP<1d>. Dec 26 20:24:14 volumio nmbd[798]: This response was from IP 192.168.50.18, reporting an IP address of 192.168.50.18. Dec 26 20:24:16 volumio volumio[5022]: info: Cannot mount NAS 1T at system boot, trial number 4 ,retrying in 5 seconds Dec 26 20:24:16 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:24:18 volumio volumio[5022]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 26 20:24:18 volumio volumio[5022]: info: CoreStateMachine::ClearQueue Dec 26 20:24:18 volumio volumio[5022]: info: CoreStateMachine::stop Dec 26 20:24:18 volumio volumio[5022]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 20:24:18 volumio volumio[5022]: verbose: UNSET VOLATILE Dec 26 20:24:18 volumio volumio[5022]: info: CorePlayQueue::clearPlayQueue Dec 26 20:24:18 volumio volumio[5022]: info: CorePlayQueue::saveQueue Dec 26 20:24:18 volumio volumio[5022]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:18 volumio volumio[5022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:18 volumio volumio[5022]: info: CoreCommandRouter::volumioPushQueue Dec 26 20:24:18 volumio volumio[5022]: info: CoreStateMachine::addQueueItems Dec 26 20:24:18 volumio volumio[5022]: info: CorePlayQueue::addQueueItems Dec 26 20:24:18 volumio volumio[5022]: info: Adding Item to queue: mnt/INTERNAL/K歌之王 陈奕迅.ape Dec 26 20:24:18 volumio volumio[5022]: info: Exploding uri mnt/INTERNAL/K歌之王 陈奕迅.ape in service mpd Dec 26 20:24:18 volumio volumio[5022]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 20:24:18 volumio volumio[5022]: TypeError: Cannot read property 'then' of undefined Dec 26 20:24:18 volumio volumio[5022]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2479:19) Dec 26 20:24:18 volumio volumio[5022]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2277:21) Dec 26 20:24:18 volumio volumio[5022]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1283:16) Dec 26 20:24:18 volumio volumio[5022]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:144:48) Dec 26 20:24:18 volumio volumio[5022]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:238:25) Dec 26 20:24:18 volumio volumio[5022]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:476:23) Dec 26 20:24:18 volumio volumio[5022]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:452:17) Dec 26 20:24:18 volumio volumio[5022]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:106:35) Dec 26 20:24:18 volumio volumio[5022]: at emitTwo (events.js:126:13) Dec 26 20:24:18 volumio volumio[5022]: at Socket.emit (events.js:214:7) Dec 26 20:24:18 volumio volumio[5022]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 26 20:24:18 volumio volumio[5022]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Dec 26 20:24:18 volumio volumio[5022]: at process._tickCallback (internal/process/next_tick.js:180:9) Dec 26 20:24:18 volumio volumio[5022]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 20:24:19 volumio sudo[5248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-26 20:23 Dec 26 20:24:19 volumio sudo[5248]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:19 volumio sudo[5248]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:19 volumio volumio-remote-updater[489]: [2025-12-26 20:24:19] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 26 20:24:19 volumio volumio-remote-updater[489]: [2025-12-26 20:24:19] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 26 20:24:19 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 26 20:24:19 volumio systemd[1]: Unit volumio.service entered failed state. Dec 26 20:24:19 volumio systemd[1]: Starting dynamicswap service... Dec 26 20:24:19 volumio systemd[1]: Started dynamicswap service. Dec 26 20:24:19 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 26 20:24:19 volumio systemd[1]: Starting dynamicswap service... Dec 26 20:24:19 volumio systemd[1]: Started dynamicswap service. Dec 26 20:24:19 volumio systemd[1]: Stopping Volumio Backend Module... Dec 26 20:24:19 volumio systemd[1]: Starting Volumio Backend Module... Dec 26 20:24:19 volumio systemd[1]: Started Volumio Backend Module. Dec 26 20:24:20 volumio volumio[5269]: info: ------------------------------------------- Dec 26 20:24:20 volumio volumio[5269]: info: ----- Volumio2 ---- Dec 26 20:24:20 volumio volumio[5269]: info: ------------------------------------------- Dec 26 20:24:20 volumio volumio[5269]: info: ----- System startup ---- Dec 26 20:24:20 volumio volumio[5269]: info: ------------------------------------------- Dec 26 20:24:20 volumio volumio[5269]: info: MYVOLUMIO Environment detected Dec 26 20:24:20 volumio volumio[5269]: info: Plugin folders cleanup Dec 26 20:24:20 volumio volumio[5269]: info: Scanning into folder /volumio/app/plugins/ Dec 26 20:24:20 volumio volumio[5269]: info: Scanning category audio_interface Dec 26 20:24:20 volumio volumio[5269]: info: Scanning category miscellanea Dec 26 20:24:20 volumio volumio[5269]: info: Scanning category music_service Dec 26 20:24:20 volumio volumio[5269]: info: Scanning category plugins.json Dec 26 20:24:20 volumio volumio[5269]: info: Scanning category system_controller Dec 26 20:24:20 volumio volumio[5269]: info: Scanning category user_interface Dec 26 20:24:20 volumio volumio[5269]: info: Scanning into folder /data/plugins/ Dec 26 20:24:20 volumio volumio[5269]: info: Plugin folders cleanup completed Dec 26 20:24:20 volumio volumio[5269]: info: ------------------------------------------- Dec 26 20:24:20 volumio volumio[5269]: info: ----- Core plugins startup ---- Dec 26 20:24:20 volumio volumio[5269]: info: ------------------------------------------- Dec 26 20:24:20 volumio volumio[5269]: info: Loading plugins from folder /volumio/app/plugins/ Dec 26 20:24:20 volumio volumio[5269]: info: Adding plugin upnp to MyMusic Plugins Dec 26 20:24:20 volumio volumio[5269]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 26 20:24:20 volumio volumio[5269]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 26 20:24:20 volumio volumio[5269]: info: Loading plugins from folder /data/plugins/ Dec 26 20:24:20 volumio volumio[5269]: info: Loading plugin "system"... Dec 26 20:24:20 volumio volumio[5269]: info: Loading plugin "appearance"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "network"... Dec 26 20:24:22 volumio volumio[5269]: info: Refreshing Cached IP Addresses Dec 26 20:24:22 volumio sudo[5294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "services"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "alsa_controller"... Dec 26 20:24:22 volumio sudo[5294]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:22 volumio sudo[5294]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:22 volumio sudo[5297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 20:24:22 volumio sudo[5297]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:22 volumio sudo[5297]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "wizard"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "volumio_command_line_client"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "upnp"... Dec 26 20:24:22 volumio volumio[5269]: info: [1766780662247] Starting Upmpd Daemon Dec 26 20:24:22 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "my_music"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "mpd"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "upnp_browser"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "networkfs"... Dec 26 20:24:22 volumio volumio[5269]: info: Cannot mount NAS 1T at system boot, trial number 1 ,retrying in 5 seconds Dec 26 20:24:22 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "alarm-clock"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "airplay_emulation"... Dec 26 20:24:22 volumio volumio[5269]: info: Starting Shairport Sync Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "last_100"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "webradio"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "i2s_dacs"... Dec 26 20:24:22 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "volumiodiscovery"... Dec 26 20:24:22 volumio volumio[5269]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 26 20:24:22 volumio node[5269]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 26 20:24:22 volumio node[5269]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 20:24:22 volumio node[5269]: *** WARNING *** For more information see Dec 26 20:24:22 volumio node[5269]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 26 20:24:22 volumio node[5269]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 20:24:22 volumio node[5269]: *** WARNING *** For more information see Dec 26 20:24:22 volumio volumio[5269]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 20:24:22 volumio volumio[5269]: *** WARNING *** For more information see Dec 26 20:24:22 volumio volumio[5269]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 26 20:24:22 volumio volumio[5269]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 20:24:22 volumio volumio[5269]: *** WARNING *** For more information see Dec 26 20:24:22 volumio volumio[5269]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 26 20:24:22 volumio volumio[5269]: Discovery: StartAdv! undefined Dec 26 20:24:22 volumio volumio[5269]: Discovery: Started advertising... Volumio - undefined Dec 26 20:24:22 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "outputs"... Dec 26 20:24:22 volumio volumio[5269]: info: Loading plugin "albumart"... Dec 26 20:24:23 volumio volumio[5269]: info: Plugin example_plugin is not enabled Dec 26 20:24:23 volumio volumio[5269]: info: Loading plugin "inputs"... Dec 26 20:24:23 volumio volumio[5269]: info: Loading plugin "updater_comm"... Dec 26 20:24:23 volumio volumio[5269]: info: Plugin mpdemulation is not enabled Dec 26 20:24:23 volumio volumio[5269]: info: Loading plugin "rest_api"... Dec 26 20:24:23 volumio volumio[5269]: info: Loading plugin "websocket"... Dec 26 20:24:23 volumio volumio[5269]: info: ___________ START PLUGINS ___________ Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 20:24:23 volumio volumio[5269]: info: [1766780663153] CoreMusicLibrary::Adding element Media Servers Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: Forking 3 albumart workers Dec 26 20:24:23 volumio volumio[5269]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 20:24:23 volumio volumio[5269]: info: [1766780663236] CoreMusicLibrary::Adding element Last_100 Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 20:24:23 volumio volumio[5269]: info: [1766780663239] CoreMusicLibrary::Adding element Webradio Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 20:24:23 volumio volumio[5269]: info: ------------------------------------------- Dec 26 20:24:23 volumio volumio[5269]: info: ----- MyVolumio plugins startup ---- Dec 26 20:24:23 volumio volumio[5269]: info: ------------------------------------------- Dec 26 20:24:23 volumio volumio[5269]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 26 20:24:23 volumio volumio[5269]: info: Loading i18n strings for locale zh Dec 26 20:24:23 volumio volumio[5269]: Updating browse sources language Dec 26 20:24:23 volumio volumio[5269]: Cannot find translation for sourceMedia Servers Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::initPlayerControls Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:24:23 volumio volumio[5269]: info: BOOT COMPLETED Dec 26 20:24:23 volumio volumio[5269]: [Metrics] CommandRouter: 2s 799.58ms Dec 26 20:24:23 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:23 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Dec 26 20:24:23 volumio volumio[5269]: Starting albumart workers Dec 26 20:24:23 volumio volumio[5269]: Starting albumart workers Dec 26 20:24:23 volumio volumio[5269]: Starting albumart workers Dec 26 20:24:23 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:24:24 volumio volumio-remote-updater[489]: [2025-12-26 20:24:24] [connect] Successful connection Dec 26 20:24:28 volumio volumio[5269]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::Close All Modals sent Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::Close All Modals sent Dec 26 20:24:28 volumio volumio[5269]: Express server listening on port 3000 Dec 26 20:24:28 volumio volumio[5269]: [Metrics] WebUI: 8s 398.59ms Dec 26 20:24:28 volumio volumio[5269]: Volumio Calling Home Dec 26 20:24:28 volumio volumio[5269]: info: CoreStateMachine::resetVolumioState Dec 26 20:24:28 volumio volumio[5269]: info: CoreStateMachine::getcurrentVolume Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 20:24:28 volumio volumio[5269]: info: Cannot mount NAS 1T at system boot, trial number 2 ,retrying in 5 seconds Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 20:24:28 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:28 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:28 volumio volumio[5269]: info: CoreStateMachine::updateTrackBlock Dec 26 20:24:28 volumio volumio[5269]: info: CorePlayQueue::getTrackBlock Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 20:24:28 volumio volumio[5269]: info: Setting Device type: Raspberry PI Dec 26 20:24:28 volumio volumio[5269]: error: Cannot initialize MPD Connection: MPD is not running Dec 26 20:24:28 volumio volumio-remote-updater[489]: [2025-12-26 20:24:28] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1766780664 101 Dec 26 20:24:28 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:28 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:28 volumio volumio[5269]: info: Cannot read play queue from file Dec 26 20:24:28 volumio volumio[5269]: info: CoreStateMachine::setRepeat false single undefined Dec 26 20:24:28 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:28 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:28 volumio volumio[5269]: info: CoreStateMachine::setRandom false Dec 26 20:24:28 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:28 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:28 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:28 volumio volumio[5269]: info: Starting Shairport Sync Dec 26 20:24:28 volumio volumio[5269]: info: Starting Shairport Sync Dec 26 20:24:28 volumio sudo[5409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 20:24:28 volumio sudo[5409]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:28 volumio sudo[5412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 20:24:29 volumio sudo[5412]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 26 20:24:29 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 26 20:24:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 26 20:24:29 volumio sudo[5409]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 26 20:24:29 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 26 20:24:29 volumio sudo[5412]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::volumioGetState Dec 26 20:24:29 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:29 volumio volumio[5269]: Discovery: adding 23003156-77c0-4b6d-b981-53fd832c8ef3 Dec 26 20:24:29 volumio volumio[5269]: info: mDNS: Found device Volumio Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::volumioGetState Dec 26 20:24:29 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:29 volumio volumio[5269]: info: Shairport-Sync Started Dec 26 20:24:29 volumio volumio[5269]: Error adding Membership: Error: addMembership EINVAL Dec 26 20:24:29 volumio volumio[5269]: info: Shairport-Sync Started Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::volumioGetVisibleSources Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:29 volumio volumio[5269]: info: Listing playlists Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::volumioGetQueue Dec 26 20:24:29 volumio volumio[5269]: info: CoreStateMachine::getQueue Dec 26 20:24:29 volumio volumio[5269]: info: CorePlayQueue::getQueue Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::volumioGetState Dec 26 20:24:29 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:29 volumio volumio[5269]: info: Volumio called home Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 26 20:24:29 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 26 20:24:31 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 26 20:24:32 volumio volumio[5269]: info: Adding plugin bluetooth to MyMusic Plugins Dec 26 20:24:32 volumio volumio[5269]: info: Adding plugin cd_controller to MyMusic Plugins Dec 26 20:24:32 volumio volumio[5269]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 26 20:24:32 volumio volumio[5269]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 26 20:24:32 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:32 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:32 volumio volumio[5269]: info: Starting MyVolumio Remote Streaming Endpoints Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 26 20:24:32 volumio volumio[5269]: info: Streaming services startup Dec 26 20:24:32 volumio volumio[5269]: info: Starting Streaming Daemon Dec 26 20:24:32 volumio sudo[5442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 26 20:24:32 volumio sudo[5442]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:32 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 26 20:24:32 volumio volumio[5269]: info: MyVolumio not started Dec 26 20:24:32 volumio volumio[5269]: info: Initializing device activation check Dec 26 20:24:32 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 26 20:24:32 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 26 20:24:32 volumio volumio[5269]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 26 20:24:32 volumio sudo[5442]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:32 volumio volumio-streaming-daemon[5452]: ############################ Dec 26 20:24:32 volumio volumio-streaming-daemon[5452]: # Volumio Streaming Daemon # Dec 26 20:24:32 volumio volumio-streaming-daemon[5452]: # Running on port 7777 # Dec 26 20:24:32 volumio volumio-streaming-daemon[5452]: ############################ Dec 26 20:24:32 volumio volumio-streaming-daemon[5452]: Environment: production Dec 26 20:24:32 volumio sudo[5462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 20:24:32 volumio sudo[5462]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:32 volumio sudo[5465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 20:24:32 volumio sudo[5462]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:32 volumio sudo[5465]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:32 volumio sudo[5465]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:32 volumio sudo[5477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 26 20:24:32 volumio sudo[5477]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:32 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Dec 26 20:24:32 volumio sudo[5477]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:32 volumio volumio[5269]: info: Upmpdcli Daemon Started Dec 26 20:24:33 volumio volumio[5269]: info: Cannot mount NAS 1T at system boot, trial number 3 ,retrying in 5 seconds Dec 26 20:24:35 volumio volumio-streaming-daemon[5452]: Environment: production Dec 26 20:24:35 volumio volumio[5269]: info: Fetching Streaming Services browse cache Dec 26 20:24:38 volumio volumio[5269]: info: Cannot mount NAS 1T at system boot, trial number 4 ,retrying in 5 seconds Dec 26 20:24:39 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:24:43 volumio volumio[5269]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Dec 26 20:24:46 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Dec 26 20:24:48 volumio volumio[5269]: info: Setting Remote Device Volume: http://192.168.50.48 Dec 26 20:24:48 volumio volumio[5269]: info: Dec 26 20:24:48 volumio volumio[5269]: ---------------------------- Client requests Volume 94 Dec 26 20:24:48 volumio volumio[5269]: info: VolumeController::SetAlsaVolume94 Dec 26 20:24:48 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:48 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:48 volumio volumio[5269]: info: Done setting volume on: Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Dec 26 20:24:48 volumio volumio[5269]: info: Setting Remote Device Volume: http://192.168.50.48 Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Dec 26 20:24:48 volumio volumio[5269]: info: Setting Remote Device Volume: http://192.168.50.48 Dec 26 20:24:48 volumio volumio[5269]: info: Dec 26 20:24:48 volumio volumio[5269]: ---------------------------- Client requests Volume 96 Dec 26 20:24:48 volumio volumio[5269]: info: VolumeController::SetAlsaVolume96 Dec 26 20:24:48 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:48 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:48 volumio volumio[5269]: info: Done setting volume on: Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Dec 26 20:24:48 volumio volumio[5269]: info: Setting Remote Device Volume: http://192.168.50.48 Dec 26 20:24:48 volumio volumio[5269]: info: Dec 26 20:24:48 volumio volumio[5269]: ---------------------------- Client requests Volume 98 Dec 26 20:24:48 volumio volumio[5269]: info: VolumeController::SetAlsaVolume98 Dec 26 20:24:48 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:48 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:48 volumio volumio[5269]: info: Done setting volume on: Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Dec 26 20:24:48 volumio volumio[5269]: info: Setting Remote Device Volume: http://192.168.50.48 Dec 26 20:24:48 volumio volumio[5269]: info: Dec 26 20:24:48 volumio volumio[5269]: ---------------------------- Client requests Volume 99 Dec 26 20:24:48 volumio volumio[5269]: info: VolumeController::SetAlsaVolume99 Dec 26 20:24:48 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:48 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:48 volumio volumio[5269]: info: Done setting volume on: Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Dec 26 20:24:48 volumio volumio[5269]: info: Setting Remote Device Volume: http://192.168.50.48 Dec 26 20:24:48 volumio volumio[5269]: info: Dec 26 20:24:48 volumio volumio[5269]: ---------------------------- Client requests Volume 100 Dec 26 20:24:48 volumio volumio[5269]: info: VolumeController::SetAlsaVolume100 Dec 26 20:24:48 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:48 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:48 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:49 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:49 volumio volumio[5269]: info: Done setting volume on: Dec 26 20:24:49 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Dec 26 20:24:49 volumio volumio[5269]: info: Setting Remote Device Volume: http://192.168.50.48 Dec 26 20:24:49 volumio volumio[5269]: info: Dec 26 20:24:49 volumio volumio[5269]: ---------------------------- Client requests Volume 100 Dec 26 20:24:49 volumio volumio[5269]: info: VolumeController::SetAlsaVolume100 Dec 26 20:24:49 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:49 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:49 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:49 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:49 volumio volumio[5269]: info: Done setting volume on: Dec 26 20:24:49 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Dec 26 20:24:49 volumio volumio[5269]: info: Setting Remote Device Volume: http://192.168.50.48 Dec 26 20:24:49 volumio volumio[5269]: info: Dec 26 20:24:49 volumio volumio[5269]: ---------------------------- Client requests Volume 100 Dec 26 20:24:49 volumio volumio[5269]: info: VolumeController::SetAlsaVolume100 Dec 26 20:24:49 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:49 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:49 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:49 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:49 volumio volumio[5269]: info: Done setting volume on: Dec 26 20:24:49 volumio volumio[5269]: info: Dec 26 20:24:49 volumio volumio[5269]: ---------------------------- Client requests Volume 100 Dec 26 20:24:49 volumio volumio[5269]: info: VolumeController::SetAlsaVolume100 Dec 26 20:24:49 volumio volumio[5269]: info: CoreStateMachine::pushState Dec 26 20:24:49 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:49 volumio volumio[5269]: info: CoreCommandRouter::volumioPushState Dec 26 20:24:49 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 20:24:49 volumio volumio[5269]: info: Done setting volume on: Dec 26 20:24:53 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 20:24:53 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:24:54 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:24:55 volumio sudo[5501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 20:24:55 volumio sudo[5501]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:55 volumio sudo[5504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 20:24:55 volumio sudo[5501]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:55 volumio sudo[5504]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:55 volumio sudo[5504]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:55 volumio volumio[5269]: info: CoreCommandRouter::volumioGetState Dec 26 20:24:55 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:55 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 26 20:24:55 volumio volumio[5269]: info: CoreCommandRouter::volumioGetVisibleSources Dec 26 20:24:55 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:55 volumio volumio[5269]: info: Listing playlists Dec 26 20:24:55 volumio volumio[5269]: info: CoreCommandRouter::volumioGetQueue Dec 26 20:24:55 volumio volumio[5269]: info: CoreStateMachine::getQueue Dec 26 20:24:55 volumio volumio[5269]: info: CorePlayQueue::getQueue Dec 26 20:24:57 volumio sudo[5520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 20:24:57 volumio sudo[5522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 20:24:57 volumio sudo[5520]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:57 volumio sudo[5522]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:57 volumio sudo[5520]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:57 volumio sudo[5522]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:58 volumio sudo[5538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 20:24:58 volumio sudo[5538]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:58 volumio sudo[5540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 20:24:58 volumio sudo[5538]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:58 volumio sudo[5540]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 20:24:58 volumio sudo[5540]: pam_unix(sudo:session): session closed for user root Dec 26 20:24:58 volumio volumio[5269]: info: CoreCommandRouter::volumioGetState Dec 26 20:24:58 volumio volumio[5269]: info: CorePlayQueue::getTrack 0 Dec 26 20:24:58 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 26 20:24:58 volumio volumio[5269]: info: CoreCommandRouter::volumioGetVisibleSources Dec 26 20:24:58 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 20:24:58 volumio volumio[5269]: info: Listing playlists Dec 26 20:24:58 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 26 20:24:58 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 26 20:24:58 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 26 20:24:58 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 26 20:25:00 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 20:25:01 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 26 20:25:05 volumio volumio[5269]: info: Getting Alsa Cards List without I2S DAC Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 26 20:25:05 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 26 20:25:09 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:25:15 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Dec 26 20:25:17 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:25:24 volumio wpa_supplicant[892]: wlan0: Failed to initiate sched scan Dec 26 20:25:26 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 26 20:25:26 volumio volumio[5269]: info: CoreCommandRouter::volumioGetQueue Dec 26 20:25:26 volumio volumio[5269]: info: CoreStateMachine::getQueue Dec 26 20:25:26 volumio volumio[5269]: info: CorePlayQueue::getQueue Dec 26 20:25:26 volumio volumio[5269]: error: Cannot download Available plugins list: Error: ETIMEDOUT Dec 26 20:25:28 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 26 20:25:28 volumio volumio[5269]: info: CURURI: genres:// Dec 26 20:25:28 volumio volumio[5269]: error: Failed to execute browseSource: TypeError: Cannot read property 'sendCommand' of undefined Dec 26 20:25:30 volumio volumio[5269]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 26 20:25:30 volumio volumio[5269]: info: CURURI: albums:// Dec 26 20:25:30 volumio volumio[5269]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 20:25:30 volumio volumio[5269]: TypeError: Cannot read property 'sendCommand' of undefined Dec 26 20:25:30 volumio volumio[5269]: at /volumio/app/plugins/music_service/mpd/index.js:2938:22 Dec 26 20:25:30 volumio volumio[5269]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Dec 26 20:25:30 volumio volumio[5269]: at process._tickCallback (internal/process/next_tick.js:180:9) Dec 26 20:25:30 volumio volumio[5269]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 20:25:31 volumio sudo[5595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-26 20:24 Dec 26 20:25:31 volumio sudo[5595]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"