-- Logs begin at Thu 2019-02-14 19:11:58 KST, end at Wed 2025-04-23 14:47:10 KST. -- Apr 23 14:46:00 myvolumio volumio[1352]: info: Enabling plugin pandora Apr 23 14:46:00 myvolumio volumio[1352]: info: Loading plugin "pandora"... Apr 23 14:46:01 myvolumio volumio[1352]: info: PLUGIN START: pandora Apr 23 14:46:01 myvolumio volumio[1352]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161094] CoreMusicLibrary::Adding element Pandora Radio Apr 23 14:46:01 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source Calm Radio Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source Jellyfin Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source YouTube2 Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source YouTube Music Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source 80s80s Radio Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source RADIO 357 Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source Mixcloud Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source Volusonic Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source SWARM Station Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source SoundCloud Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source Radio Paradise Apr 23 14:46:01 myvolumio volumio[1352]: Cannot find translation for source Pandora Radio Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161095] ControllerPandora::initializeMQTT Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161095] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161096] ControllerPandora::initialSetup Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161096] ControllerPandora::PandoraHandler::init Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161096] ControllerPandora::PandoraHandler::loadErrorCodes Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161097] [Pandora] PandoraHandler::setMaxStationTracks: 16 Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161097] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161097] ControllerPandora::flushPandora Apr 23 14:46:01 myvolumio volumio[1352]: info: CorePlayQueue::getQueue Apr 23 14:46:01 myvolumio volumio[1352]: info: CorePlayQueue::clearAddPlayQueue Apr 23 14:46:01 myvolumio volumio[1352]: info: CorePlayQueue::saveQueue Apr 23 14:46:01 myvolumio volumio[1352]: info: CoreCommandRouter::serviceClearAddPlayTracks Apr 23 14:46:01 myvolumio volumio[1352]: error: WARNING: No clearAddPlayTracks method for service rad357pl Apr 23 14:46:01 myvolumio volumio[1352]: info: CoreCommandRouter::volumioPushQueue Apr 23 14:46:01 myvolumio volumio[1352]: info: [1745387161099] ControllerPandora::validateAndSetAccountOptions Apr 23 14:46:01 myvolumio volumio[1352]: error: [1745387161099] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Apr 23 14:46:01 myvolumio volumio[1352]: info: Done. Apr 23 14:46:01 myvolumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:46:01 myvolumio volumio[1352]: info: FusionDsp - Apr 23 14:46:01 myvolumio volumio[1352]: info: FusionDsp - undefined Apr 23 14:46:05 myvolumio volumio[1352]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:07 myvolumio volumio[1352]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:07 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 23 14:46:07 myvolumio sudo[14493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:07 myvolumio sudo[14493]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:07 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:46:07 myvolumio volumio[1352]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:07 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:07 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:07 myvolumio volumio[1352]: info: Check plugin dependencies Apr 23 14:46:07 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:07 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 14:46:07 myvolumio volumio[1352]: info: Rename folder Apr 23 14:46:07 myvolumio sudo[14497]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:46:07 myvolumio sudo[14497]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:07 myvolumio sudo[14497]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:07 myvolumio volumio[1352]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:07 myvolumio volumio[1352]: info: Move to category Apr 23 14:46:07 myvolumio volumio[1352]: info: Checking if install.sh is present Apr 23 14:46:07 myvolumio volumio[1352]: info: Executing install.sh Apr 23 14:46:07 myvolumio mpd[14503]: Apr 23 14:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:46:07 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:46:07 myvolumio sudo[14493]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:07 myvolumio volumio[1352]: error: updateQueue error: null Apr 23 14:46:07 myvolumio sudo[14510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/mpdoutput/install.sh Apr 23 14:46:07 myvolumio sudo[14510]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:07 myvolumio sudo[14510]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:07 myvolumio volumio[1352]: info: Installing mpd http output Apr 23 14:46:07 myvolumio volumio[1352]: Plugin install end detected on script Apr 23 14:46:07 myvolumio volumio[1352]: info: Install script completed Apr 23 14:46:07 myvolumio volumio[1352]: info: Done installing plugin. Apr 23 14:46:07 myvolumio volumio[1352]: info: Enabling plugin mpdoutput Apr 23 14:46:07 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 23 14:46:07 myvolumio volumio[1352]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.61","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":true,"active":false},{"prettyName":"Mpd http & Icecast output","name":"mpdoutput","category":"audio_interface","version":"1.0.5","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Bandcamp Discover","name":"bandcamp","category":"music_service","version":"1.2.0","icon":"fa-bandcamp","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Calm Radio","name":"calmradio","category":"music_service","version":"1.2.4","icon":"fa-heartbeat","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"DMD2 Music","name":"dmd2_music","category":"music_service","version":"1.1.3","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Jellyfin","name":"jellyfin","category":"music_service","version":"1.1.1","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Logitech Media Server","name":"lms","category":"music_service","version":"1.2.6","icon":"fa fa-music","isManuallyInstalled":false,"active":false},{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Moosbox","name":"moosbox","category":"music_service","version":"1.0.0","icon":"fa-solid fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"MotherEarthRadio","name":"motherearthradio","category":"music_service","version":"1.2.2","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Music Your Brand","name":"myb","category":"music_service","version":"1.0.3","icon":"fa-solid fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"pandora","name":"pandora","category":"music_service","version":"2.12.1","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"RADIO 357","name":"rad357pl","category":"music_service","version":"1.0.2","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.13","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.1.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Squeezelite MC","name":"squeezelite_mc","category":"music_service","version":"1.0.4","icon":"fa-play-circle-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SWARM Station","name":"swarmstation","category":"music_service","version":"1.0.2","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Volusonic","name":"volusonic","category":"music_service","version":"2.3.0","icon":"fa-ship","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube2","name":"youtube2","category":"music_service","version":"1.4.2","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.2.0","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.3.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true}] Apr 23 14:46:07 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 23 14:46:07 myvolumio volumio[1352]: info: Folder /tmp/plugins removed Apr 23 14:46:07 myvolumio volumio[1352]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:07 myvolumio volumio[1352]: info: Folder /data/temp removed Apr 23 14:46:07 myvolumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:46:07 myvolumio volumio[1352]: info: FusionDsp - Apr 23 14:46:08 myvolumio volumio[1352]: info: FusionDsp - undefined Apr 23 14:46:18 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 14:46:18 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:46:18 myvolumio volumio[1352]: info: Discovery: Getting this device information Apr 23 14:46:18 myvolumio volumio[1352]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:18 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:46:21 myvolumio volumio[1352]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:23 myvolumio volumio[1352]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:23 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 23 14:46:23 myvolumio sudo[14603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:23 myvolumio sudo[14603]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:23 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:46:23 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:23 myvolumio volumio[1352]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:23 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:23 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:23 myvolumio volumio[1352]: info: Check plugin dependencies Apr 23 14:46:23 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 14:46:23 myvolumio volumio[1352]: info: Rename folder Apr 23 14:46:23 myvolumio sudo[14607]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:46:23 myvolumio sudo[14607]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:23 myvolumio sudo[14607]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:23 myvolumio volumio[1352]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:23 myvolumio volumio[1352]: info: Move to category Apr 23 14:46:23 myvolumio volumio[1352]: info: Checking if install.sh is present Apr 23 14:46:23 myvolumio volumio[1352]: info: Executing install.sh Apr 23 14:46:23 myvolumio sudo[14621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/mpdoutput/install.sh Apr 23 14:46:23 myvolumio sudo[14621]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:23 myvolumio sudo[14621]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:23 myvolumio volumio[1352]: info: Installing mpd http output Apr 23 14:46:23 myvolumio volumio[1352]: Plugin install end detected on script Apr 23 14:46:23 myvolumio volumio[1352]: info: Install script completed Apr 23 14:46:23 myvolumio volumio[1352]: info: Done installing plugin. Apr 23 14:46:23 myvolumio volumio[1352]: info: Enabling plugin mpdoutput Apr 23 14:46:23 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 23 14:46:23 myvolumio volumio[1352]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.61","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":true,"active":false},{"prettyName":"Mpd http & Icecast output","name":"mpdoutput","category":"audio_interface","version":"1.0.5","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Bandcamp Discover","name":"bandcamp","category":"music_service","version":"1.2.0","icon":"fa-bandcamp","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Calm Radio","name":"calmradio","category":"music_service","version":"1.2.4","icon":"fa-heartbeat","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"DMD2 Music","name":"dmd2_music","category":"music_service","version":"1.1.3","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Jellyfin","name":"jellyfin","category":"music_service","version":"1.1.1","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Logitech Media Server","name":"lms","category":"music_service","version":"1.2.6","icon":"fa fa-music","isManuallyInstalled":false,"active":false},{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Moosbox","name":"moosbox","category":"music_service","version":"1.0.0","icon":"fa-solid fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"MotherEarthRadio","name":"motherearthradio","category":"music_service","version":"1.2.2","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Music Your Brand","name":"myb","category":"music_service","version":"1.0.3","icon":"fa-solid fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"pandora","name":"pandora","category":"music_service","version":"2.12.1","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"RADIO 357","name":"rad357pl","category":"music_service","version":"1.0.2","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.13","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.1.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Squeezelite MC","name":"squeezelite_mc","category":"music_service","version":"1.0.4","icon":"fa-play-circle-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SWARM Station","name":"swarmstation","category":"music_service","version":"1.0.2","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Volusonic","name":"volusonic","category":"music_service","version":"2.3.0","icon":"fa-ship","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube2","name":"youtube2","category":"music_service","version":"1.4.2","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.2.0","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.3.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true}] Apr 23 14:46:23 myvolumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 23 14:46:23 myvolumio volumio[1352]: info: Folder /tmp/plugins removed Apr 23 14:46:23 myvolumio volumio[1352]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:23 myvolumio volumio[1352]: info: Folder /data/temp removed Apr 23 14:46:23 myvolumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:46:23 myvolumio volumio[1352]: info: FusionDsp - Apr 23 14:46:23 myvolumio mpd[14611]: Apr 23 14:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:46:23 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:46:23 myvolumio volumio[1352]: info: FusionDsp - undefined Apr 23 14:46:23 myvolumio sudo[14603]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:23 myvolumio volumio[1352]: error: updateQueue error: null Apr 23 14:46:28 myvolumio volumio[1352]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Apr 23 14:46:32 myvolumio volumio[1352]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Apr 23 14:46:32 myvolumio volumio[1352]: info: FusionDsp - Stopping FusionDsp service Apr 23 14:46:32 myvolumio volumio[1352]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 14:46:32 myvolumio volumio[1352]: TypeError: Cannot read property 'stop' of null Apr 23 14:46:32 myvolumio volumio[1352]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) Apr 23 14:46:32 myvolumio volumio[1352]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Apr 23 14:46:32 myvolumio volumio[1352]: at /volumio/app/pluginmanager.js:956:12 Apr 23 14:46:32 myvolumio volumio[1352]: at ChildProcess.exithandler (child_process.js:299:7) Apr 23 14:46:32 myvolumio volumio[1352]: at ChildProcess.emit (events.js:315:20) Apr 23 14:46:32 myvolumio volumio[1352]: at maybeClose (internal/child_process.js:1048:16) Apr 23 14:46:32 myvolumio volumio[1352]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5) Apr 23 14:46:32 myvolumio volumio[1352]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 14:46:32 myvolumio sudo[14652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-23 14:45 Apr 23 14:46:32 myvolumio sudo[14652]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:32 myvolumio sudo[14652]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:33 myvolumio volumio-remote-updater[793]: [2025-04-23 14:46:33] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 23 14:46:33 myvolumio volumio-remote-updater[793]: [2025-04-23 14:46:33] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 23 14:46:33 myvolumio go-librespot[1539]: time="2025-04-23T14:46:33+09:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Apr 23 14:46:33 myvolumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 23 14:46:33 myvolumio systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 23 14:46:33 myvolumio systemd[1]: Started dynamicswap service. Apr 23 14:46:33 myvolumio systemd[1]: dynamicswap.service: Succeeded. Apr 23 14:46:33 myvolumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 23 14:46:33 myvolumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Apr 23 14:46:33 myvolumio systemd[1]: Started dynamicswap service. Apr 23 14:46:33 myvolumio systemd[1]: Stopped Volumio Backend Module. Apr 23 14:46:33 myvolumio systemd[1]: Started Volumio Backend Module. Apr 23 14:46:33 myvolumio systemd[1]: dynamicswap.service: Succeeded. Apr 23 14:46:33 myvolumio volumio[14666]: info: ------------------------------------------- Apr 23 14:46:33 myvolumio volumio[14666]: info: ----- Volumio3 ---- Apr 23 14:46:33 myvolumio volumio[14666]: info: ------------------------------------------- Apr 23 14:46:33 myvolumio volumio[14666]: info: ----- System startup ---- Apr 23 14:46:33 myvolumio volumio[14666]: info: ------------------------------------------- Apr 23 14:46:34 myvolumio volumio[14666]: info: MYVOLUMIO Environment detected Apr 23 14:46:34 myvolumio volumio[14666]: info: Plugin folders cleanup Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning into folder /volumio/app/plugins/ Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning category miscellanea Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning category plugins.json Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning category system_controller Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning category user_interface Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning into folder /data/plugins/ Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:34 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:34 myvolumio volumio[14666]: info: Plugin folders cleanup completed Apr 23 14:46:34 myvolumio volumio[14666]: info: ------------------------------------------- Apr 23 14:46:34 myvolumio volumio[14666]: info: ----- Core plugins startup ---- Apr 23 14:46:34 myvolumio volumio[14666]: info: ------------------------------------------- Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugins from folder /volumio/app/plugins/ Apr 23 14:46:34 myvolumio volumio[14666]: info: Adding plugin upnp to MyMusic Plugins Apr 23 14:46:34 myvolumio volumio[14666]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 23 14:46:34 myvolumio volumio[14666]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugins from folder /data/plugins/ Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "system"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "appearance"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "network"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Refreshing Cached IP Addresses Apr 23 14:46:34 myvolumio sudo[14695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 23 14:46:34 myvolumio sudo[14695]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:34 myvolumio sudo[14695]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:34 myvolumio sudo[14697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 23 14:46:34 myvolumio sudo[14697]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:34 myvolumio sudo[14697]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "services"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "alsa_controller"... Apr 23 14:46:34 myvolumio sudo[14710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 23 14:46:34 myvolumio sudo[14710]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:34 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "wizard"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "networkfs"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Starting Udev Watcher for removable devices Apr 23 14:46:34 myvolumio volumio[14666]: info: Ignoring mount for partition: boot Apr 23 14:46:34 myvolumio volumio[14666]: info: Ignoring mount for partition: volumio Apr 23 14:46:34 myvolumio volumio[14666]: info: Ignoring mount for partition: volumio_data Apr 23 14:46:34 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "volumio_command_line_client"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "upnp"... Apr 23 14:46:34 myvolumio volumio[14666]: info: [1745387194349] Starting Upmpd Daemon Apr 23 14:46:34 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "my_music"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "mpd"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "upnp_browser"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "alarm-clock"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "airplay_emulation"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Starting Shairport Sync Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "last_100"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "webradio"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "i2s_dacs"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "volumiodiscovery"... Apr 23 14:46:34 myvolumio volumio[14666]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 23 14:46:34 myvolumio node[14666]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 23 14:46:34 myvolumio node[14666]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 23 14:46:34 myvolumio volumio[14666]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 23 14:46:34 myvolumio volumio[14666]: *** WARNING *** For more information see Apr 23 14:46:34 myvolumio volumio[14666]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 23 14:46:34 myvolumio volumio[14666]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 23 14:46:34 myvolumio volumio[14666]: *** WARNING *** For more information see Apr 23 14:46:34 myvolumio node[14666]: *** WARNING *** For more information see Apr 23 14:46:34 myvolumio node[14666]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 23 14:46:34 myvolumio node[14666]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 23 14:46:34 myvolumio node[14666]: *** WARNING *** For more information see Apr 23 14:46:34 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 23 14:46:34 myvolumio volumio[14666]: info: Discovery: Started advertising with name: MyVolumio Apr 23 14:46:34 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "bandcamp"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "calmradio"... Apr 23 14:46:34 myvolumio volumio[14666]: info: Loading plugin "jellyfin"... Apr 23 14:46:35 myvolumio volumio[14666]: info: Loading plugin "mixcloud"... Apr 23 14:46:35 myvolumio volumio[14666]: info: Loading plugin "soundcloud"... Apr 23 14:46:35 myvolumio volumio[14666]: info: Loading plugin "spop"... Apr 23 14:46:35 myvolumio volumio[14666]: info: Loading plugin "squeezelite_mc"... Apr 23 14:46:35 myvolumio volumio[14666]: info: Loading plugin "youtube2"... Apr 23 14:46:36 myvolumio volumio[14666]: info: Loading plugin "ytcr"... Apr 23 14:46:36 myvolumio volumio[14666]: info: Loading plugin "ytmusic"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "outputs"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "albumart"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Plugin example_plugin is not enabled Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "inputs"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "updater_comm"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Plugin mpdemulation is not enabled Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "rest_api"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "websocket"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Starting Socket.io Server version 2.3.0 Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "fusiondsp"... Apr 23 14:46:37 myvolumio volumio[14666]: Forking 3 albumart workers Apr 23 14:46:37 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin fusiondsp Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "mpdoutput"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "80s80s"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin 80s80s Apr 23 14:46:37 myvolumio volumio[14666]: info: [1745387197489] [80s80s] API delay: 30 Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "RoonBridge"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin RoonBridge Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "dmd2_music"... Apr 23 14:46:37 myvolumio volumio[14666]: Starting albumart workers Apr 23 14:46:37 myvolumio volumio[14666]: Starting albumart workers Apr 23 14:46:37 myvolumio volumio[14666]: Starting albumart workers Apr 23 14:46:37 myvolumio volumio[14666]: info: Plugin lms is not enabled Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "minidlna"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin minidlna Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "moosbox"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin moosbox Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "motherearthradio"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin motherearthradio Apr 23 14:46:37 myvolumio volumio[14666]: info: [1745387197903] [MotherEarth] API delay: 5 Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "myb"... Apr 23 14:46:37 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin myb Apr 23 14:46:37 myvolumio volumio[14666]: info: Loading plugin "pandora"... Apr 23 14:46:38 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin pandora Apr 23 14:46:38 myvolumio volumio[14666]: info: Loading plugin "rad357pl"... Apr 23 14:46:38 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin rad357pl Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198166] [rad357pl] API delay: 5 Apr 23 14:46:38 myvolumio volumio[14666]: info: Loading plugin "radio_paradise"... Apr 23 14:46:38 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin radio_paradise Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198199] [RadioParadise] API delay: 5 Apr 23 14:46:38 myvolumio volumio[14666]: info: Loading plugin "swarmstation"... Apr 23 14:46:38 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin swarmstation Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198233] [Swarmstation] API delay: 5 Apr 23 14:46:38 myvolumio volumio[14666]: info: Loading plugin "volusonic"... Apr 23 14:46:38 myvolumio volumio-remote-updater[793]: [2025-04-23 14:46:38] [connect] Successful connection Apr 23 14:46:38 myvolumio volumio[14666]: info: Applying required configuration parameters for plugin volusonic Apr 23 14:46:38 myvolumio volumio[14666]: info: Loading i18n strings for locale ko Apr 23 14:46:38 myvolumio sudo[14710]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:38 myvolumio volumio[14666]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Apr 23 14:46:38 myvolumio volumio[14666]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 23 14:46:38 myvolumio volumio[14666]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. Apr 23 14:46:38 myvolumio volumio[14666]: Updating browse sources language Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::initPlayerControls Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: Express server listening on port 3000 Apr 23 14:46:38 myvolumio volumio[14666]: [Metrics] WebUI: 4s 581.77ms Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreStateMachine::resetVolumioState Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreStateMachine::getcurrentVolume Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioRetrievevolume Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreStateMachine::pushState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioPushState Apr 23 14:46:38 myvolumio volumio[14666]: info: Volumio Network Manager: Network status updated: 3 Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.7 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.159 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.7 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.159 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.7 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.159 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.7 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.159 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 23 14:46:38 myvolumio volumio-remote-updater[793]: [2025-04-23 14:46:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745387198 101 Apr 23 14:46:38 myvolumio volumio[14666]: 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: 9 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:46:38 myvolumio volumio[14666]: info: Discovery: Getting this device information Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.7 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: Reloading queue from file Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreStateMachine::setRepeat null single undefined Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreStateMachine::pushState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioPushState Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreStateMachine::setRandom null Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreStateMachine::pushState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioPushState Apr 23 14:46:38 myvolumio volumio[14666]: info: Setting Device type: Raspberry PI Apr 23 14:46:38 myvolumio volumio[14666]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Apr 23 14:46:38 myvolumio volumio[14666]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04171 Apr 23 14:46:38 myvolumio volumio[14666]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Apr 23 14:46:38 myvolumio volumio[14666]: info: Completed loading Core Plugins Apr 23 14:46:38 myvolumio volumio[14666]: info: Preparing to generate the ALSA configuration file Apr 23 14:46:38 myvolumio volumio[14666]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 23 14:46:38 myvolumio volumio[14666]: info: Reading ALSA contributions from plugins. Apr 23 14:46:38 myvolumio volumio[14666]: verbose: New Socket.io Connection to 192.168.1.42:3000 from 192.168.1.159 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Apr 23 14:46:38 myvolumio volumio[14666]: info: Received Get System Info Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:46:38 myvolumio volumio[14666]: info: Discovery: Getting this device information Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetVisibleSources Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetQueue Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreStateMachine::getQueue Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getQueue Apr 23 14:46:38 myvolumio volumio[14666]: info: Listing playlists Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 23 14:46:38 myvolumio volumio[14666]: info: Received Get System Info Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:46:38 myvolumio volumio[14666]: info: Discovery: Getting this device information Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 23 14:46:38 myvolumio volumio[14666]: info: Discovery: adding 4ea1fc17-0872-4ae4-a0ef-bd430e9fe1e7 Apr 23 14:46:38 myvolumio volumio[14666]: info: Discovery: Found device MyVolumio Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: Discovery: this is already registered, 4ea1fc17-0872-4ae4-a0ef-bd430e9fe1e7 Apr 23 14:46:38 myvolumio volumio[14666]: info: Discovery: Found device MyVolumio Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: Asound.conf file unchanged, so no further update is needed Apr 23 14:46:38 myvolumio volumio[14666]: info: Output device has changed, restarting MPD Apr 23 14:46:38 myvolumio sudo[14788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 23 14:46:38 myvolumio sudo[14788]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:38 myvolumio sudo[14788]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:38 myvolumio volumio[14666]: info: Output device has changed, restarting Shairport Sync Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:38 myvolumio sudo[14791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:38 myvolumio sudo[14791]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:38 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:46:38 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:38 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:38 myvolumio volumio[14666]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 14:46:38 myvolumio volumio[14666]: info: ___________ START PLUGINS ___________ Apr 23 14:46:38 myvolumio volumio[14666]: info: ControllerMpd::onStart: Initializing MPD Apr 23 14:46:38 myvolumio volumio[14666]: info: Creating MPD Configuration file Apr 23 14:46:38 myvolumio sudo[14798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 23 14:46:38 myvolumio sudo[14798]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:38 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:38 myvolumio sudo[14798]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198665] CoreMusicLibrary::Adding element 미디어 서버 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio sudo[14801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:38 myvolumio sudo[14801]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:38 myvolumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 23 14:46:38 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:38 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:38 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:38 myvolumio volumio[14666]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:38 myvolumio sudo[14804]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:46:38 myvolumio sudo[14804]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:38 myvolumio sudo[14804]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:38 myvolumio volumio[14666]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198725] CoreMusicLibrary::Adding element Last_100 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198725] CoreMusicLibrary::Adding element Webradio Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 14:46:38 myvolumio volumio[14666]: info: Initializing BBC Radios Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198777] CoreMusicLibrary::Adding element Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: info: Adding Calm Radio to Browse Sources Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198778] CoreMusicLibrary::Adding element Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:46:38 myvolumio volumio[14666]: info: Discovery: Getting this device information Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198782] CoreMusicLibrary::Adding element Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: info: [jellyfin] Initialized plugin with device info: {"id":"4ea1fc17-0872-4ae4-a0ef-bd430e9fe1e7","host":"http://192.168.0.10","name":"MyVolumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":100,"mute":false,"track":"Radio357 (128K)","albumart":"http://192.168.0.10/albumart?sourceicon=music_service/rad357pl/r35.png"}} Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198784] CoreMusicLibrary::Adding element Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198786] CoreMusicLibrary::Adding element SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: info: Creating Spotify config file Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: [squeezelite_mc] Starting proxy server... Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198797] CoreMusicLibrary::Adding element YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198808] CoreMusicLibrary::Adding element YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: info: Loading i18n strings for locale ko Apr 23 14:46:38 myvolumio volumio[14666]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Apr 23 14:46:38 myvolumio volumio[14666]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 23 14:46:38 myvolumio volumio[14666]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: FusionDsp - mixtype--------------------- None Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198816] CoreMusicLibrary::Adding element 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: info: Stopping AccessToken refresher cron for DMD2 Music Apr 23 14:46:38 myvolumio sudo[14823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Apr 23 14:46:38 myvolumio sudo[14823]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:38 myvolumio volumio[14666]: info: AccessToken refresher cron started for DMD2 Music Apr 23 14:46:38 myvolumio volumio[14666]: info: Loading i18n strings for locale ko Apr 23 14:46:38 myvolumio sudo[14823]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:38 myvolumio volumio[14666]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Apr 23 14:46:38 myvolumio volumio[14666]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 23 14:46:38 myvolumio volumio[14666]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198862] CoreMusicLibrary::Adding element Mother Earth Radio Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mother Earth Radio Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198864] CoreMusicLibrary::Adding element Pandora Radio Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mother Earth Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Pandora Radio Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198865] ControllerPandora::initializeMQTT Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198865] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198866] CoreMusicLibrary::Adding element RADIO 357 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mother Earth Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Pandora Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source RADIO 357 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198867] CoreMusicLibrary::Adding element Radio Paradise Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mother Earth Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Pandora Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source RADIO 357 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Radio Paradise Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198869] CoreMusicLibrary::Adding element SWARM Station Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mother Earth Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Pandora Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source RADIO 357 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Radio Paradise Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SWARM Station Apr 23 14:46:38 myvolumio volumio[14666]: info: Loading i18n strings for locale ko Apr 23 14:46:38 myvolumio volumio[14666]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Apr 23 14:46:38 myvolumio volumio[14666]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 23 14:46:38 myvolumio volumio[14666]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. Apr 23 14:46:38 myvolumio volumio[14666]: Updating browse sources language Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mother Earth Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Pandora Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source RADIO 357 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Radio Paradise Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SWARM Station Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mother Earth Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Pandora Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source RADIO 357 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Radio Paradise Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SWARM Station Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198882] CoreMusicLibrary::Adding element Volusonic Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Bandcamp Discover Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Calm Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Jellyfin Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mixcloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SoundCloud Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube2 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source YouTube Music Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source 80s80s Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Mother Earth Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Pandora Radio Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source RADIO 357 Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Radio Paradise Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source SWARM Station Apr 23 14:46:38 myvolumio volumio[14666]: Cannot find translation for source Volusonic Apr 23 14:46:38 myvolumio volumio[14666]: info: Volumio Calling Home Apr 23 14:46:38 myvolumio volumio[14666]: info: [squeezelite_mc] Proxy server started on port 36849 Apr 23 14:46:38 myvolumio volumio[14666]: info: Preparing to generate the ALSA configuration file Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198928] ControllerPandora::initialSetup Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198928] ControllerPandora::PandoraHandler::init Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198928] ControllerPandora::PandoraHandler::loadErrorCodes Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198932] [Pandora] PandoraHandler::setMaxStationTracks: 16 Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198932] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198932] ControllerPandora::flushPandora Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getQueue Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::clearAddPlayQueue Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::saveQueue Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::serviceClearAddPlayTracks Apr 23 14:46:38 myvolumio volumio[14666]: error: WARNING: No clearAddPlayTracks method for service rad357pl Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioPushQueue Apr 23 14:46:38 myvolumio volumio[14666]: info: [1745387198934] ControllerPandora::validateAndSetAccountOptions Apr 23 14:46:38 myvolumio volumio[14666]: error: [1745387198934] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Apr 23 14:46:38 myvolumio mpd[14809]: Apr 23 14:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:46:38 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:46:38 myvolumio sudo[14791]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:38 myvolumio sudo[14801]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioRetrievevolume Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreStateMachine::pushState Apr 23 14:46:38 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::volumioPushState Apr 23 14:46:38 myvolumio volumio[14666]: info: [squeezelite_mc] Server discovery started Apr 23 14:46:38 myvolumio volumio[14666]: info: [squeezelite_mc] Player finder started Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 14:46:38 myvolumio volumio[14666]: info: [squeezelite_mc] Executing aplay -D hw:0 --nonblock -f MPEG /dev/zero 2>&1 || true Apr 23 14:46:38 myvolumio volumio[14666]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 23 14:46:38 myvolumio volumio[14666]: info: Reading ALSA contributions from plugins. Apr 23 14:46:38 myvolumio volumio[14666]: info: minidlna: Found miniDLNA version 1.2.1 Apr 23 14:46:38 myvolumio volumio[14666]: info: minidlna: Starting minidlna.service Apr 23 14:46:39 myvolumio sudo[14835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Apr 23 14:46:39 myvolumio sudo[14835]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio sudo[14835]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio volumio[14666]: info: MPD Permissions set Apr 23 14:46:39 myvolumio volumio[14666]: info: MPD Permissions set Apr 23 14:46:39 myvolumio volumio[14666]: info: minidlna: systemctl start minidlna.service succeeded. Apr 23 14:46:39 myvolumio volumio[14666]: info: [squeezelite_mc] Card 0 supports the following ALSA formats: ["S16_LE","S24_LE"] Apr 23 14:46:39 myvolumio volumio[14666]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"myvolumio","dsdFormat":null,"card":"0","mixerType":"None","mixer":null} Apr 23 14:46:39 myvolumio volumio[14666]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Apr 23 14:46:39 myvolumio volumio[14666]: info: Spotify config file written Apr 23 14:46:39 myvolumio sudo[14843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 23 14:46:39 myvolumio sudo[14843]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio sudo[14841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Apr 23 14:46:39 myvolumio sudo[14841]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio sudo[14841]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio systemd[1]: Stopping go-librespot Daemon... Apr 23 14:46:39 myvolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Apr 23 14:46:39 myvolumio systemd[1]: go-librespot-daemon.service: Succeeded. Apr 23 14:46:39 myvolumio systemd[1]: Stopped go-librespot Daemon. Apr 23 14:46:39 myvolumio systemd[1]: Started go-librespot Daemon. Apr 23 14:46:39 myvolumio sudo[14843]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio go-librespot[14846]: go-librespot daemon starting... Apr 23 14:46:39 myvolumio volumio[14666]: error: MPD error: The expression evaluated to a falsy value: Apr 23 14:46:39 myvolumio volumio[14666]: assert.ok(self.idling) Apr 23 14:46:39 myvolumio volumio[14666]: error: The expression evaluated to a falsy value: Apr 23 14:46:39 myvolumio volumio[14666]: assert.ok(self.idling) Apr 23 14:46:39 myvolumio volumio[14666]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Apr 23 14:46:39 myvolumio go-librespot[14846]: time="2025-04-23T14:46:39+09:00" level=info msg="running go-librespot 0.2.0" Apr 23 14:46:39 myvolumio go-librespot[14846]: time="2025-04-23T14:46:39+09:00" level=debug msg="app state loaded" Apr 23 14:46:39 myvolumio go-librespot[14846]: time="2025-04-23T14:46:39+09:00" level=debug msg="stored credentials not found" Apr 23 14:46:39 myvolumio volumio[14666]: info: MPD running with PID14809 Apr 23 14:46:39 myvolumio volumio[14666]: ,establishing connection Apr 23 14:46:39 myvolumio go-librespot[14846]: time="2025-04-23T14:46:39+09:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: No need to fix Spotify hosts Apr 23 14:46:39 myvolumio volumio[14666]: error: updateQueue error: null Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:46:39 myvolumio volumio[14666]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Apr 23 14:46:39 myvolumio sudo[14864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Apr 23 14:46:39 myvolumio sudo[14864]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio sudo[14864]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio volumio[14666]: error: updateQueue error: null Apr 23 14:46:39 myvolumio volumio[14666]: info: Starting Shairport Sync Apr 23 14:46:39 myvolumio go-librespot[14846]: time="2025-04-23T14:46:39+09:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 23 14:46:39 myvolumio go-librespot[14846]: time="2025-04-23T14:46:39+09:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 23 14:46:39 myvolumio go-librespot[14846]: time="2025-04-23T14:46:39+09:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 23 14:46:39 myvolumio go-librespot[14846]: time="2025-04-23T14:46:39+09:00" level=info msg="zeroconf server listening on port 37817" Apr 23 14:46:39 myvolumio volumio[14666]: info: Starting Shairport Sync Apr 23 14:46:39 myvolumio sudo[14867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 14:46:39 myvolumio sudo[14867]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 23 14:46:39 myvolumio systemd[1]: shairport-sync.service: Succeeded. Apr 23 14:46:39 myvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 23 14:46:39 myvolumio volumio[14666]: info: Starting Shairport Sync Apr 23 14:46:39 myvolumio sudo[14870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 14:46:39 myvolumio sudo[14870]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:39 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:39 myvolumio volumio[14666]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Apr 23 14:46:39 myvolumio sudo[14874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 14:46:39 myvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 23 14:46:39 myvolumio sudo[14874]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio sudo[14867]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 23 14:46:39 myvolumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 23 14:46:39 myvolumio systemd[1]: shairport-sync.service: Succeeded. Apr 23 14:46:39 myvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 23 14:46:39 myvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 23 14:46:39 myvolumio volumio[14666]: info: FusionDsp - Apr 23 14:46:39 myvolumio sudo[14874]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio sudo[14870]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio sudo[14878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Apr 23 14:46:39 myvolumio sudo[14878]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio sudo[14878]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio volumio[14666]: info: FusionDsp - Apr 23 14:46:39 myvolumio volumio[14666]: info: FusionDsp - Apr 23 14:46:39 myvolumio volumio[14666]: info: FusionDsp - Apr 23 14:46:39 myvolumio volumio[14666]: info: Shairport-Sync Started Apr 23 14:46:39 myvolumio volumio[14666]: Error adding Membership: Error: addMembership EINVAL Apr 23 14:46:39 myvolumio volumio[14666]: info: Asound.conf file unchanged, so no further update is needed Apr 23 14:46:39 myvolumio volumio[14666]: info: Output device has changed, restarting MPD Apr 23 14:46:39 myvolumio sudo[14884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 23 14:46:39 myvolumio sudo[14884]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio sudo[14884]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio volumio[14666]: info: Output device has changed, restarting Shairport Sync Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:39 myvolumio sudo[14887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:39 myvolumio sudo[14887]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:46:39 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:39 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:39 myvolumio volumio[14666]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 14:46:39 myvolumio volumio[14666]: info: FusionDsp - undefined Apr 23 14:46:39 myvolumio volumio[14666]: info: FusionDsp - undefined Apr 23 14:46:39 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:39 myvolumio volumio[14666]: info: FusionDsp - undefined Apr 23 14:46:39 myvolumio volumio[14666]: info: FusionDsp - undefined Apr 23 14:46:39 myvolumio sudo[14892]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:46:39 myvolumio sudo[14892]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio sudo[14892]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio volumio[14666]: info: Shairport-Sync Started Apr 23 14:46:39 myvolumio volumio[14666]: info: Shairport-Sync Started Apr 23 14:46:39 myvolumio volumio[14666]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Apr 23 14:46:39 myvolumio sudo[14896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 23 14:46:39 myvolumio sudo[14896]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio volumio[14666]: info: MPD Permissions set Apr 23 14:46:39 myvolumio volumio[14666]: info: Volumio called home Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio systemd[1]: Reloading. Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:39 myvolumio volumio[14666]: info: Starting Shairport Sync Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:39 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreCommandRouter::volumioPause Apr 23 14:46:39 myvolumio volumio[14666]: info: CoreStateMachine::pause Apr 23 14:46:39 myvolumio volumio[14666]: info: mpdhttpout --- Volumio set on pause Apr 23 14:46:39 myvolumio volumio[14666]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Apr 23 14:46:39 myvolumio sudo[14918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 14:46:39 myvolumio sudo[14918]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 23 14:46:39 myvolumio systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. Apr 23 14:46:39 myvolumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Apr 23 14:46:39 myvolumio mpd[14894]: Apr 23 14:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:46:39 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:46:39 myvolumio sudo[14887]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio sudo[14896]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio volumio[14666]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 23 14:46:39 myvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 23 14:46:39 myvolumio systemd[1]: shairport-sync.service: Succeeded. Apr 23 14:46:39 myvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 23 14:46:39 myvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 23 14:46:39 myvolumio sudo[14918]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio volumio[14666]: info: Shairport-Sync Started Apr 23 14:46:39 myvolumio sudo[14924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 23 14:46:39 myvolumio volumio[14666]: error: updateQueue error: null Apr 23 14:46:39 myvolumio sudo[14924]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio sudo[14924]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:39 myvolumio volumio[14666]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Apr 23 14:46:39 myvolumio sudo[14929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Apr 23 14:46:39 myvolumio sudo[14929]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:39 myvolumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Apr 23 14:46:39 myvolumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Apr 23 14:46:39 myvolumio kernel: process '/opt/squeezelite/squeezelite' started with executable stack Apr 23 14:46:39 myvolumio sudo[14929]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:40 myvolumio volumio[14666]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 23 14:46:40 myvolumio sudo[14938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 23 14:46:40 myvolumio sudo[14938]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:40 myvolumio sudo[14938]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:40 myvolumio volumio[14666]: info: [yt-cast-receiver] DIAL server listening on port 8098 Apr 23 14:46:40 myvolumio volumio[14666]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 23 14:46:40 myvolumio volumio[14666]: 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 Apr 23 14:46:40 myvolumio volumio[14666]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 23 14:46:40 myvolumio volumio[14666]: info: camilladsp service started and running in background, instance 1 Apr 23 14:46:40 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:40 myvolumio volumio[14666]: cannot open device 'volumioHw': Device or resource busy Apr 23 14:46:40 myvolumio volumio[14666]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 23 14:46:40 myvolumio volumio[14666]: cannot open device 'volumioHw': Device or resource busy Apr 23 14:46:40 myvolumio volumio[14666]: info: FusionDsp loaded Apr 23 14:46:40 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:46:40 myvolumio sudo[14956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 23 14:46:40 myvolumio sudo[14956]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:40 myvolumio volumio[14666]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 23 14:46:40 myvolumio volumio[14666]: info: Adding Signal Path Element [object Object] Apr 23 14:46:40 myvolumio volumio[14666]: info: Adding fusiondspeq DSP Signal Path Element Apr 23 14:46:40 myvolumio volumio[14666]: info: FusionDsp - ---- installed callbackRead Apr 23 14:46:40 myvolumio volumio[14666]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 23 14:46:40 myvolumio volumio[14666]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Apr 23 14:46:40 myvolumio volumio[14666]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 23 14:46:40 myvolumio systemd[1]: Started FusionDsp Daemon. Apr 23 14:46:40 myvolumio sudo[14956]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:40 myvolumio volumio[14666]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 23 14:46:40 myvolumio sudo[14961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 23 14:46:40 myvolumio sudo[14961]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:40 myvolumio sudo[14961]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:40 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:40 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:46:40 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 14:46:41 myvolumio volumio[14666]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 23 14:46:41 myvolumio sudo[14964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 23 14:46:41 myvolumio sudo[14964]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:41 myvolumio sudo[14964]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:41 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 23 14:46:41 myvolumio sudo[14967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:41 myvolumio sudo[14967]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:41 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:46:41 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:41 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:41 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:41 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:41 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:41 myvolumio sudo[14969]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:46:41 myvolumio sudo[14969]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:41 myvolumio sudo[14969]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:42 myvolumio volumio[14666]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 23 14:46:42 myvolumio sudo[14973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 23 14:46:42 myvolumio sudo[14973]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:42 myvolumio sudo[14973]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:42 myvolumio mpd[14971]: Apr 23 14:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:46:42 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:46:42 myvolumio sudo[14967]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:42 myvolumio volumio[14666]: error: updateQueue error: null Apr 23 14:46:42 myvolumio volumio[14666]: info: go-librespot daemon successfully initialized Apr 23 14:46:42 myvolumio volumio[14666]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 23 14:46:42 myvolumio sudo[14978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 23 14:46:42 myvolumio sudo[14978]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:42 myvolumio sudo[14978]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:42 myvolumio volumio[14666]: info: Completed starting Core Plugins Apr 23 14:46:42 myvolumio volumio[14666]: info: ------------------------------------------- Apr 23 14:46:42 myvolumio volumio[14666]: info: ----- MyVolumio plugins startup ---- Apr 23 14:46:42 myvolumio volumio[14666]: info: ------------------------------------------- Apr 23 14:46:42 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 23 14:46:44 myvolumio volumio[14666]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 23 14:46:44 myvolumio sudo[14995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 23 14:46:44 myvolumio sudo[14995]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:44 myvolumio sudo[14995]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:44 myvolumio sudo[14998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 23 14:46:44 myvolumio sudo[14998]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:44 myvolumio sudo[14998]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:44 myvolumio sudo[15001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 23 14:46:44 myvolumio sudo[15001]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:44 myvolumio sudo[15001]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:44 myvolumio volumio[14666]: info: Upmpdcli Daemon Started Apr 23 14:46:44 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 23 14:46:45 myvolumio volumio[14666]: info: Initializing connection to go-librespot Websocket Apr 23 14:46:45 myvolumio go-librespot[14846]: time="2025-04-23T14:46:45+09:00" level=debug msg="new websocket client" Apr 23 14:46:45 myvolumio volumio[14666]: info: Connection to go-librespot Websocket established Apr 23 14:46:45 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 23 14:46:45 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 23 14:46:46 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 23 14:46:46 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 23 14:46:47 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 23 14:46:47 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 23 14:46:48 myvolumio volumio[14666]: info: Getting Spotify volume Apr 23 14:46:48 myvolumio volumio[14666]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Apr 23 14:46:48 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:48 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:48 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 23 14:46:48 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 14:46:48 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:46:48 myvolumio volumio[14666]: info: Discovery: Getting this device information Apr 23 14:46:48 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:48 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:48 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:46:50 myvolumio volumio[14666]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 23 14:46:51 myvolumio volumio[14666]: info: Adding plugin bluetooth to MyMusic Plugins Apr 23 14:46:51 myvolumio volumio[14666]: info: Adding plugin multiroom to MyMusic Plugins Apr 23 14:46:51 myvolumio volumio[14666]: info: Adding plugin metavolumio to MyMusic Plugins Apr 23 14:46:51 myvolumio volumio[14666]: info: Adding plugin cd_controller to MyMusic Plugins Apr 23 14:46:51 myvolumio volumio[14666]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 23 14:46:51 myvolumio volumio[14666]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 23 14:46:51 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:51 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:51 myvolumio volumio[14666]: info: Starting MyVolumio Remote Streaming Endpoints Apr 23 14:46:51 myvolumio volumio[14666]: info: MyVolumio login type: Token Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 23 14:46:51 myvolumio volumio[14666]: info: Starting Streaming Service Transparent Proxy Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 23 14:46:51 myvolumio volumio[14666]: info: Streaming services startup Apr 23 14:46:51 myvolumio volumio[14666]: info: Starting Streaming Daemon Apr 23 14:46:51 myvolumio sudo[15013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 23 14:46:51 myvolumio sudo[15013]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:51 myvolumio sudo[15013]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:51 myvolumio volumio[14666]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 23 14:46:51 myvolumio volumio[14666]: error: Cannot start Volumio Streaming Daemon Apr 23 14:46:51 myvolumio volumio[14666]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 23 14:46:51 myvolumio volumio[14666]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 23 14:46:51 myvolumio volumio[14666]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:51 myvolumio volumio[14666]: STREAMING PROXY: Starting server on port 3245 Apr 23 14:46:51 myvolumio volumio[14666]: Node JS runtime: 14 Apr 23 14:46:51 myvolumio volumio[14666]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:51 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 23 14:46:51 myvolumio sudo[15022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:51 myvolumio sudo[15022]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:51 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:46:51 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:51 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:51 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:51 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:51 myvolumio volumio[14666]: info: Check plugin dependencies Apr 23 14:46:51 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:51 myvolumio volumio[14666]: error: Error finding native modules: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name "*.node" 2>/dev/null {"status":1,"signal":null,"output":[null,"",""],"pid":15027,"stdout":"","stderr":"","stack":"Error: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name \"*.node\" 2>/dev/null\n at checkExecSyncError (child_process.js:616:11)\n at execSync (child_process.js:652:15)\n at PluginManager.checkPluginDependencies (/volumio/app/pluginmanager.js:1149:26)\n at nextTickCallback (/data/plugins/audio_interface/mpdoutput/node_modules/kew/kew.js:47:28)\n at processTicksAndRejections (internal/process/task_queues.js:75:11)"} Apr 23 14:46:51 myvolumio volumio[14666]: info: An error occurred installing the plugin. Rolling back config Apr 23 14:46:51 myvolumio volumio[14666]: info: Plugin folders cleanup Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning into folder /volumio/app/plugins/ Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning category miscellanea Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning category plugins.json Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning category system_controller Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning category user_interface Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning into folder /data/plugins/ Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:51 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:51 myvolumio volumio[14666]: info: Plugin folders cleanup completed Apr 23 14:46:51 myvolumio volumio[14666]: info: Error: Error Apr 23 14:46:51 myvolumio volumio[14666]: info: Error: Error Apr 23 14:46:51 myvolumio volumio[14666]: info: Folder /tmp/plugins removed Apr 23 14:46:51 myvolumio volumio[14666]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:51 myvolumio volumio[14666]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:51 myvolumio volumio[14666]: info: Folder /data/temp removed Apr 23 14:46:51 myvolumio sudo[15026]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:46:51 myvolumio sudo[15026]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:51 myvolumio sudo[15026]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:51 myvolumio volumio[14666]: error: MyVolumio Custom Token format not valid, refreshing it Apr 23 14:46:52 myvolumio mpd[15030]: Apr 23 14:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:46:52 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:46:52 myvolumio sudo[15022]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:52 myvolumio volumio[14666]: error: updateQueue error: null Apr 23 14:46:53 myvolumio volumio[14666]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:53 myvolumio volumio[14666]: info: MyVolumio login type: Token Apr 23 14:46:53 myvolumio volumio[14666]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:53 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 23 14:46:53 myvolumio sudo[15038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:53 myvolumio sudo[15038]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:53 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:46:53 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:53 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:53 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:53 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:53 myvolumio volumio[14666]: info: An error occurred installing the plugin. Rolling back config Apr 23 14:46:53 myvolumio volumio[14666]: info: Plugin folders cleanup Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning into folder /volumio/app/plugins/ Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning category miscellanea Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning category plugins.json Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning category system_controller Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning category user_interface Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning into folder /data/plugins/ Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:53 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:53 myvolumio volumio[14666]: info: Plugin folders cleanup completed Apr 23 14:46:53 myvolumio volumio[14666]: info: Error: Error Apr 23 14:46:53 myvolumio volumio[14666]: info: Error: Error Apr 23 14:46:53 myvolumio volumio[14666]: info: Folder /tmp/plugins removed Apr 23 14:46:53 myvolumio volumio[14666]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:53 myvolumio volumio[14666]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:53 myvolumio volumio[14666]: info: Folder /data/temp removed Apr 23 14:46:53 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:53 myvolumio sudo[15041]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:46:53 myvolumio sudo[15041]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:53 myvolumio sudo[15041]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:53 myvolumio mpd[15044]: Apr 23 14:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:46:53 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:46:53 myvolumio sudo[15038]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:53 myvolumio volumio[14666]: error: updateQueue error: null Apr 23 14:46:53 myvolumio volumio[14666]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:53 myvolumio volumio[14666]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 23 14:46:54 myvolumio volumio[14666]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:54 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 23 14:46:54 myvolumio sudo[15067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:54 myvolumio sudo[15067]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:54 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:46:54 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:54 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:54 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:54 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:54 myvolumio volumio[14666]: info: An error occurred installing the plugin. Rolling back config Apr 23 14:46:54 myvolumio volumio[14666]: info: Plugin folders cleanup Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning into folder /volumio/app/plugins/ Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning category miscellanea Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning category plugins.json Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning category system_controller Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning category user_interface Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning into folder /data/plugins/ Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:54 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:54 myvolumio volumio[14666]: info: Plugin folders cleanup completed Apr 23 14:46:54 myvolumio volumio[14666]: info: Error: Error Apr 23 14:46:54 myvolumio volumio[14666]: info: Error: Error Apr 23 14:46:54 myvolumio volumio[14666]: info: Folder /tmp/plugins removed Apr 23 14:46:54 myvolumio volumio[14666]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:54 myvolumio volumio[14666]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:54 myvolumio volumio[14666]: info: Folder /data/temp removed Apr 23 14:46:54 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:54 myvolumio sudo[15071]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:46:54 myvolumio sudo[15071]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:54 myvolumio sudo[15071]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:54 myvolumio mpd[15073]: Apr 23 14:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:46:54 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:46:54 myvolumio sudo[15067]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:54 myvolumio volumio[14666]: error: updateQueue error: null Apr 23 14:46:54 myvolumio volumio[14666]: info: MyVolumio token set successfully Apr 23 14:46:54 myvolumio volumio[14666]: info: MYVOLUMIO: Adding device Apr 23 14:46:54 myvolumio volumio[14666]: info: MYVOLUMIO: Evaluating Server Apr 23 14:46:55 myvolumio volumio[14666]: info: MyVolumio status changed Apr 23 14:46:55 myvolumio volumio[14666]: info: Streaming services startup Apr 23 14:46:55 myvolumio volumio[14666]: info: Starting Streaming Daemon Apr 23 14:46:55 myvolumio volumio[14666]: info: Removing browser output: myVolumio user plan is not superstar Apr 23 14:46:55 myvolumio volumio[14666]: info: Removing audio output: Apr 23 14:46:55 myvolumio volumio[14666]: info: Stoppping Tunnel 1 Apr 23 14:46:55 myvolumio sudo[15094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 23 14:46:55 myvolumio sudo[15094]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:55 myvolumio sudo[15094]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:55 myvolumio volumio[14666]: error: Cannot start Volumio Streaming Daemon Apr 23 14:46:55 myvolumio volumio[14666]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 23 14:46:55 myvolumio volumio[14666]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 23 14:46:55 myvolumio sudo[15097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 23 14:46:55 myvolumio sudo[15097]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:55 myvolumio sudo[15097]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:55 myvolumio volumio[14666]: info: Remote SSH Stopped Apr 23 14:46:55 myvolumio volumio[14666]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/armhf Apr 23 14:46:55 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 23 14:46:55 myvolumio sudo[15100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:46:55 myvolumio sudo[15100]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:55 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:46:55 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:46:55 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:46:55 myvolumio volumio[14666]: info: CoreCommandRouter::volumioGetState Apr 23 14:46:55 myvolumio volumio[14666]: info: CorePlayQueue::getTrack 0 Apr 23 14:46:55 myvolumio volumio[14666]: info: An error occurred installing the plugin. Rolling back config Apr 23 14:46:55 myvolumio volumio[14666]: info: Plugin folders cleanup Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning into folder /volumio/app/plugins/ Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning category miscellanea Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning category plugins.json Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning category system_controller Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning category user_interface Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning into folder /data/plugins/ Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning category audio_interface Apr 23 14:46:55 myvolumio volumio[14666]: info: Scanning category music_service Apr 23 14:46:55 myvolumio volumio[14666]: info: Plugin folders cleanup completed Apr 23 14:46:55 myvolumio volumio[14666]: info: Error: Error Apr 23 14:46:55 myvolumio volumio[14666]: info: Error: Error Apr 23 14:46:55 myvolumio volumio[14666]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:55 myvolumio volumio[14666]: info: Folder /tmp/plugins removed Apr 23 14:46:55 myvolumio volumio[14666]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:55 myvolumio volumio[14666]: info: Folder /data/temp removed Apr 23 14:46:55 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:46:55 myvolumio sudo[15104]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:46:55 myvolumio sudo[15104]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:55 myvolumio sudo[15104]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:55 myvolumio mpd[15107]: Apr 23 14:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:46:55 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:46:55 myvolumio sudo[15100]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:55 myvolumio volumio[14666]: error: updateQueue error: null Apr 23 14:46:56 myvolumio volumio[14666]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Apr 23 14:46:56 myvolumio volumio[14666]: info: Setting Geolocation for MyVolumio to as1 Apr 23 14:46:56 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:56 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:56 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:56 myvolumio volumio[14666]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Apr 23 14:46:57 myvolumio volumio[14666]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 23 14:46:57 myvolumio volumio[14666]: info: Updating MyVolumio device info Apr 23 14:46:57 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:57 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:57 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:46:57 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 23 14:46:57 myvolumio volumio[14666]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 23 14:46:59 myvolumio volumio[14666]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Apr 23 14:46:59 myvolumio volumio[14666]: info: FusionDsp - Stopping FusionDsp service Apr 23 14:46:59 myvolumio volumio[14666]: info: camilladsp stopping service pid 14946... Apr 23 14:46:59 myvolumio volumio[14666]: info: camilladsp service terminated, instance 1 Apr 23 14:46:59 myvolumio sudo[15118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Apr 23 14:46:59 myvolumio sudo[15118]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:46:59 myvolumio volumio[14958]: Backend configuration: Apr 23 14:46:59 myvolumio volumio[14958]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Apr 23 14:46:59 myvolumio volumio[14958]: active_config_txt: null Apr 23 14:46:59 myvolumio volumio[14958]: camilla_host: 127.0.0.1 Apr 23 14:46:59 myvolumio volumio[14958]: camilla_port: 9876 Apr 23 14:46:59 myvolumio volumio[14958]: coeff_dir: /data/INTERNAL/FusionDsp/filters Apr 23 14:46:59 myvolumio volumio[14958]: config_dir: /data/configuration/audio_interface/fusiondsp Apr 23 14:46:59 myvolumio volumio[14958]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Apr 23 14:46:59 myvolumio volumio[14958]: log_file: /tmp/camilladsp.log Apr 23 14:46:59 myvolumio volumio[14958]: on_get_active_config: null Apr 23 14:46:59 myvolumio volumio[14958]: on_set_active_config: null Apr 23 14:46:59 myvolumio volumio[14958]: port: 5011 Apr 23 14:46:59 myvolumio volumio[14958]: supported_capture_types: null Apr 23 14:46:59 myvolumio volumio[14958]: supported_playback_types: null Apr 23 14:46:59 myvolumio volumio[14958]: update_config_symlink: false Apr 23 14:46:59 myvolumio volumio[14958]: update_config_txt: false Apr 23 14:46:59 myvolumio volumio[14958]: ======== Running on http://0.0.0.0:5011 ======== Apr 23 14:46:59 myvolumio volumio[14958]: (Press CTRL+C to quit) Apr 23 14:46:59 myvolumio systemd[1]: Stopping FusionDsp Daemon... Apr 23 14:46:59 myvolumio systemd[1]: fusiondsp.service: Succeeded. Apr 23 14:46:59 myvolumio systemd[1]: Stopped FusionDsp Daemon. Apr 23 14:46:59 myvolumio sudo[15118]: pam_unix(sudo:session): session closed for user root Apr 23 14:46:59 myvolumio volumio[14666]: info: FusionDsp - Reporting Fusion DSP Disabled Apr 23 14:46:59 myvolumio volumio[14666]: info: Removing fusiondspeq DSP Signal Path Element Apr 23 14:46:59 myvolumio volumio[14666]: info: Check plugin dependencies Apr 23 14:46:59 myvolumio volumio[14666]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 14:46:59 myvolumio volumio[14666]: info: Rename folder Apr 23 14:46:59 myvolumio volumio[14666]: info: Folder /tmp/downloaded_plugin.zip removed Apr 23 14:46:59 myvolumio volumio[14666]: info: Move to category Apr 23 14:47:00 myvolumio volumio[14666]: info: Checking if install.sh is present Apr 23 14:47:00 myvolumio volumio[14666]: info: Executing install.sh Apr 23 14:47:00 myvolumio sudo[15132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Apr 23 14:47:00 myvolumio sudo[15132]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:00 myvolumio volumio[14666]: info: creating filters folder and copying demo filters Apr 23 14:47:00 myvolumio volumio[14666]: info: copying demo flters Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/ Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/2XEQ15/ Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/PEQ/ Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/convfir/ Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/convfir/kef.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/convfir/test.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/EQ15/ Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/EQ15/.Bass-FusionDsp.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/EQ15/.Classic-FusionDsp.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/EQ15/.Voice-FusionDsp.json Apr 23 14:47:01 myvolumio volumio[14666]: info: ./presets/EQ15/.Rock-FusionDsp.json Apr 23 14:47:01 myvolumio sudo[15157]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Apr 23 14:47:01 myvolumio sudo[15157]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:01 myvolumio volumio[14666]: info: Installing/fusiondsp dependencies Apr 23 14:47:01 myvolumio volumio[14666]: info: MYVOLUMIO: Adding device Apr 23 14:47:01 myvolumio volumio[14666]: info: MYVOLUMIO: Evaluating Server Apr 23 14:47:01 myvolumio volumio[14666]: info: Hit:1 https://deb.nodesource.com/node_14.x buster InRelease Apr 23 14:47:02 myvolumio volumio[14666]: info: Hit:2 http://raspbian.raspberrypi.org/raspbian buster InRelease Apr 23 14:47:02 myvolumio volumio[14666]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Apr 23 14:47:02 myvolumio volumio[14666]: info: FusionDsp - Stopping FusionDsp service Apr 23 14:47:02 myvolumio volumio[14666]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 14:47:02 myvolumio volumio[14666]: TypeError: Cannot read property 'stop' of null Apr 23 14:47:02 myvolumio volumio[14666]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) Apr 23 14:47:02 myvolumio volumio[14666]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Apr 23 14:47:02 myvolumio volumio[14666]: at /volumio/app/pluginmanager.js:956:12 Apr 23 14:47:02 myvolumio volumio[14666]: at ChildProcess.exithandler (child_process.js:299:7) Apr 23 14:47:02 myvolumio volumio[14666]: at ChildProcess.emit (events.js:315:20) Apr 23 14:47:02 myvolumio volumio[14666]: at maybeClose (internal/child_process.js:1048:16) Apr 23 14:47:02 myvolumio volumio[14666]: at Socket. (internal/child_process.js:439:11) Apr 23 14:47:02 myvolumio volumio[14666]: at Socket.emit (events.js:315:20) Apr 23 14:47:02 myvolumio volumio[14666]: at Pipe. (net.js:673:12) Apr 23 14:47:02 myvolumio volumio[14666]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 14:47:02 myvolumio sudo[15318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-23 14:46 Apr 23 14:47:02 myvolumio sudo[15318]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:02 myvolumio sudo[15318]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:02 myvolumio volumio-remote-updater[793]: [2025-04-23 14:47:02] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 23 14:47:02 myvolumio volumio-remote-updater[793]: [2025-04-23 14:47:02] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 23 14:47:02 myvolumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 23 14:47:02 myvolumio go-librespot[14846]: time="2025-04-23T14:47:02+09:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Apr 23 14:47:02 myvolumio sudo[15132]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:02 myvolumio sudo[15157]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:02 myvolumio systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 23 14:47:02 myvolumio systemd[1]: Started dynamicswap service. Apr 23 14:47:02 myvolumio systemd[1]: dynamicswap.service: Succeeded. Apr 23 14:47:02 myvolumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 23 14:47:02 myvolumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Apr 23 14:47:02 myvolumio systemd[1]: Started dynamicswap service. Apr 23 14:47:02 myvolumio systemd[1]: Stopped Volumio Backend Module. Apr 23 14:47:02 myvolumio systemd[1]: Started Volumio Backend Module. Apr 23 14:47:02 myvolumio systemd[1]: dynamicswap.service: Succeeded. Apr 23 14:47:02 myvolumio volumio[15329]: info: ------------------------------------------- Apr 23 14:47:02 myvolumio volumio[15329]: info: ----- Volumio3 ---- Apr 23 14:47:02 myvolumio volumio[15329]: info: ------------------------------------------- Apr 23 14:47:02 myvolumio volumio[15329]: info: ----- System startup ---- Apr 23 14:47:02 myvolumio volumio[15329]: info: ------------------------------------------- Apr 23 14:47:03 myvolumio volumio[15329]: info: MYVOLUMIO Environment detected Apr 23 14:47:03 myvolumio volumio[15329]: info: Plugin folders cleanup Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning into folder /volumio/app/plugins/ Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning category audio_interface Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning category miscellanea Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning category music_service Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning category plugins.json Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning category system_controller Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning category user_interface Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning into folder /data/plugins/ Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning category audio_interface Apr 23 14:47:03 myvolumio volumio[15329]: info: Scanning category music_service Apr 23 14:47:03 myvolumio volumio[15329]: info: Plugin folders cleanup completed Apr 23 14:47:03 myvolumio volumio[15329]: info: ------------------------------------------- Apr 23 14:47:03 myvolumio volumio[15329]: info: ----- Core plugins startup ---- Apr 23 14:47:03 myvolumio volumio[15329]: info: ------------------------------------------- Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugins from folder /volumio/app/plugins/ Apr 23 14:47:03 myvolumio volumio[15329]: info: Adding plugin upnp to MyMusic Plugins Apr 23 14:47:03 myvolumio volumio[15329]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 23 14:47:03 myvolumio volumio[15329]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugins from folder /data/plugins/ Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "system"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "appearance"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "network"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Refreshing Cached IP Addresses Apr 23 14:47:03 myvolumio sudo[15355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 23 14:47:03 myvolumio sudo[15355]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:03 myvolumio sudo[15355]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:03 myvolumio sudo[15357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 23 14:47:03 myvolumio sudo[15357]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:03 myvolumio sudo[15357]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "services"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "alsa_controller"... Apr 23 14:47:03 myvolumio sudo[15366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 23 14:47:03 myvolumio sudo[15366]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:03 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "wizard"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "networkfs"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Starting Udev Watcher for removable devices Apr 23 14:47:03 myvolumio volumio[15329]: info: Ignoring mount for partition: boot Apr 23 14:47:03 myvolumio volumio[15329]: info: Ignoring mount for partition: volumio Apr 23 14:47:03 myvolumio volumio[15329]: info: Ignoring mount for partition: volumio_data Apr 23 14:47:03 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "volumio_command_line_client"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "upnp"... Apr 23 14:47:03 myvolumio volumio[15329]: info: [1745387223344] Starting Upmpd Daemon Apr 23 14:47:03 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "my_music"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "mpd"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "upnp_browser"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "alarm-clock"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "airplay_emulation"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Starting Shairport Sync Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "last_100"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "webradio"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "i2s_dacs"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "volumiodiscovery"... Apr 23 14:47:03 myvolumio volumio[15329]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 23 14:47:03 myvolumio node[15329]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 23 14:47:03 myvolumio node[15329]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 23 14:47:03 myvolumio volumio[15329]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 23 14:47:03 myvolumio volumio[15329]: *** WARNING *** For more information see Apr 23 14:47:03 myvolumio volumio[15329]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 23 14:47:03 myvolumio volumio[15329]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 23 14:47:03 myvolumio volumio[15329]: *** WARNING *** For more information see Apr 23 14:47:03 myvolumio node[15329]: *** WARNING *** For more information see Apr 23 14:47:03 myvolumio node[15329]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 23 14:47:03 myvolumio node[15329]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 23 14:47:03 myvolumio node[15329]: *** WARNING *** For more information see Apr 23 14:47:03 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 23 14:47:03 myvolumio volumio[15329]: info: Discovery: Started advertising with name: MyVolumio Apr 23 14:47:03 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "bandcamp"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "calmradio"... Apr 23 14:47:03 myvolumio volumio[15329]: info: Loading plugin "jellyfin"... Apr 23 14:47:04 myvolumio volumio[15329]: info: Loading plugin "mixcloud"... Apr 23 14:47:04 myvolumio volumio[15329]: info: Loading plugin "soundcloud"... Apr 23 14:47:04 myvolumio volumio[15329]: info: Loading plugin "spop"... Apr 23 14:47:04 myvolumio volumio[15329]: info: Loading plugin "squeezelite_mc"... Apr 23 14:47:04 myvolumio volumio[15329]: info: Loading plugin "youtube2"... Apr 23 14:47:05 myvolumio volumio[15329]: info: Loading plugin "ytcr"... Apr 23 14:47:05 myvolumio volumio[15329]: info: Loading plugin "ytmusic"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "outputs"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "albumart"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Plugin example_plugin is not enabled Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "inputs"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "updater_comm"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Plugin mpdemulation is not enabled Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "rest_api"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "websocket"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Starting Socket.io Server version 2.3.0 Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "fusiondsp"... Apr 23 14:47:06 myvolumio volumio[15329]: Forking 3 albumart workers Apr 23 14:47:06 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin fusiondsp Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "mpdoutput"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "80s80s"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin 80s80s Apr 23 14:47:06 myvolumio volumio[15329]: info: [1745387226471] [80s80s] API delay: 30 Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "RoonBridge"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin RoonBridge Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "dmd2_music"... Apr 23 14:47:06 myvolumio volumio[15329]: Starting albumart workers Apr 23 14:47:06 myvolumio volumio[15329]: Starting albumart workers Apr 23 14:47:06 myvolumio volumio[15329]: Starting albumart workers Apr 23 14:47:06 myvolumio volumio[15329]: info: Plugin lms is not enabled Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "minidlna"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin minidlna Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "moosbox"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin moosbox Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "motherearthradio"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin motherearthradio Apr 23 14:47:06 myvolumio volumio[15329]: info: [1745387226865] [MotherEarth] API delay: 5 Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "myb"... Apr 23 14:47:06 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin myb Apr 23 14:47:06 myvolumio volumio[15329]: info: Loading plugin "pandora"... Apr 23 14:47:07 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin pandora Apr 23 14:47:07 myvolumio volumio[15329]: info: Loading plugin "rad357pl"... Apr 23 14:47:07 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin rad357pl Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227130] [rad357pl] API delay: 5 Apr 23 14:47:07 myvolumio volumio[15329]: info: Loading plugin "radio_paradise"... Apr 23 14:47:07 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin radio_paradise Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227163] [RadioParadise] API delay: 5 Apr 23 14:47:07 myvolumio volumio[15329]: info: Loading plugin "swarmstation"... Apr 23 14:47:07 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin swarmstation Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227204] [Swarmstation] API delay: 5 Apr 23 14:47:07 myvolumio volumio[15329]: info: Loading plugin "volusonic"... Apr 23 14:47:07 myvolumio volumio-remote-updater[793]: [2025-04-23 14:47:07] [connect] Successful connection Apr 23 14:47:07 myvolumio volumio[15329]: info: Applying required configuration parameters for plugin volusonic Apr 23 14:47:07 myvolumio volumio[15329]: info: Loading i18n strings for locale ko Apr 23 14:47:07 myvolumio volumio[15329]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Apr 23 14:47:07 myvolumio volumio[15329]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 23 14:47:07 myvolumio volumio[15329]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. Apr 23 14:47:07 myvolumio volumio[15329]: Updating browse sources language Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::initPlayerControls Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 14:47:07 myvolumio sudo[15366]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:07 myvolumio volumio[15329]: Express server listening on port 3000 Apr 23 14:47:07 myvolumio volumio[15329]: [Metrics] WebUI: 4s 558.87ms Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreStateMachine::resetVolumioState Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreStateMachine::getcurrentVolume Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioRetrievevolume Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreStateMachine::pushState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioPushState Apr 23 14:47:07 myvolumio volumio[15329]: info: Volumio Network Manager: Network status updated: 3 Apr 23 14:47:07 myvolumio volumio[15329]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.7 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Apr 23 14:47:07 myvolumio volumio[15329]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.159 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Apr 23 14:47:07 myvolumio volumio[15329]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.7 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Apr 23 14:47:07 myvolumio volumio[15329]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.159 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Apr 23 14:47:07 myvolumio volumio[15329]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.7 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Apr 23 14:47:07 myvolumio volumio[15329]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.159 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 23 14:47:07 myvolumio volumio[15329]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.7 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 23 14:47:07 myvolumio volumio[15329]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.159 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 23 14:47:07 myvolumio volumio-remote-updater[793]: [2025-04-23 14:47:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745387227 101 Apr 23 14:47:07 myvolumio volumio[15329]: 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: 9 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:47:07 myvolumio volumio[15329]: info: Discovery: Getting this device information Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: Reloading queue from file Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreStateMachine::setRepeat null single undefined Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreStateMachine::pushState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioPushState Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreStateMachine::setRandom null Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreStateMachine::pushState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioPushState Apr 23 14:47:07 myvolumio volumio[15329]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Apr 23 14:47:07 myvolumio volumio[15329]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04171 Apr 23 14:47:07 myvolumio volumio[15329]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Apr 23 14:47:07 myvolumio volumio[15329]: info: Setting Device type: Raspberry PI Apr 23 14:47:07 myvolumio volumio[15329]: info: Completed loading Core Plugins Apr 23 14:47:07 myvolumio volumio[15329]: info: Preparing to generate the ALSA configuration file Apr 23 14:47:07 myvolumio volumio[15329]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 23 14:47:07 myvolumio volumio[15329]: info: Reading ALSA contributions from plugins. Apr 23 14:47:07 myvolumio volumio[15329]: verbose: New Socket.io Connection to 192.168.1.42:3000 from 192.168.1.159 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Apr 23 14:47:07 myvolumio volumio[15329]: info: Received Get System Info Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:47:07 myvolumio volumio[15329]: info: Discovery: Getting this device information Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetVisibleSources Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetQueue Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreStateMachine::getQueue Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getQueue Apr 23 14:47:07 myvolumio volumio[15329]: info: Listing playlists Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 23 14:47:07 myvolumio volumio[15329]: info: Received Get System Info Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:47:07 myvolumio volumio[15329]: info: Discovery: Getting this device information Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: Discovery: adding 4ea1fc17-0872-4ae4-a0ef-bd430e9fe1e7 Apr 23 14:47:07 myvolumio volumio[15329]: info: Discovery: Found device MyVolumio Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: Discovery: this is already registered, 4ea1fc17-0872-4ae4-a0ef-bd430e9fe1e7 Apr 23 14:47:07 myvolumio volumio[15329]: info: Discovery: Found device MyVolumio Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 23 14:47:07 myvolumio volumio[15329]: info: Asound.conf file unchanged, so no further update is needed Apr 23 14:47:07 myvolumio volumio[15329]: info: Output device has changed, restarting MPD Apr 23 14:47:07 myvolumio sudo[15448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 23 14:47:07 myvolumio sudo[15448]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:07 myvolumio sudo[15448]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:07 myvolumio volumio[15329]: info: Output device has changed, restarting Shairport Sync Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:47:07 myvolumio sudo[15451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:47:07 myvolumio sudo[15451]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:07 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:47:07 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:47:07 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:47:07 myvolumio volumio[15329]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 14:47:07 myvolumio volumio[15329]: info: ___________ START PLUGINS ___________ Apr 23 14:47:07 myvolumio volumio[15329]: info: ControllerMpd::onStart: Initializing MPD Apr 23 14:47:07 myvolumio volumio[15329]: info: Creating MPD Configuration file Apr 23 14:47:07 myvolumio sudo[15458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 23 14:47:07 myvolumio sudo[15458]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:07 myvolumio sudo[15458]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:07 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227631] CoreMusicLibrary::Adding element 미디어 서버 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio sudo[15461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:47:07 myvolumio sudo[15461]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:47:07 myvolumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 23 14:47:07 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:47:07 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:47:07 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:47:07 myvolumio volumio[15329]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:47:07 myvolumio sudo[15463]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:47:07 myvolumio sudo[15463]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:07 myvolumio sudo[15463]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:07 myvolumio volumio[15329]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227684] CoreMusicLibrary::Adding element Last_100 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227685] CoreMusicLibrary::Adding element Webradio Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 14:47:07 myvolumio volumio[15329]: info: Initializing BBC Radios Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227738] CoreMusicLibrary::Adding element Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: info: Adding Calm Radio to Browse Sources Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227739] CoreMusicLibrary::Adding element Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 14:47:07 myvolumio volumio[15329]: info: Discovery: Getting this device information Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227743] CoreMusicLibrary::Adding element Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: info: [jellyfin] Initialized plugin with device info: {"id":"4ea1fc17-0872-4ae4-a0ef-bd430e9fe1e7","host":"http://192.168.0.10","name":"MyVolumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":100,"mute":false,"track":"Radio357 (128K)","albumart":"http://192.168.0.10/albumart?sourceicon=music_service/rad357pl/r35.png"}} Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227745] CoreMusicLibrary::Adding element Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227747] CoreMusicLibrary::Adding element SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: info: Creating Spotify config file Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: [squeezelite_mc] Starting proxy server... Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227758] CoreMusicLibrary::Adding element YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227770] CoreMusicLibrary::Adding element YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: info: Loading i18n strings for locale ko Apr 23 14:47:07 myvolumio volumio[15329]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Apr 23 14:47:07 myvolumio volumio[15329]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 23 14:47:07 myvolumio volumio[15329]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: FusionDsp - mixtype--------------------- None Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227777] CoreMusicLibrary::Adding element 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: info: Stopping AccessToken refresher cron for DMD2 Music Apr 23 14:47:07 myvolumio sudo[15483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Apr 23 14:47:07 myvolumio sudo[15483]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:07 myvolumio volumio[15329]: info: AccessToken refresher cron started for DMD2 Music Apr 23 14:47:07 myvolumio volumio[15329]: info: Loading i18n strings for locale ko Apr 23 14:47:07 myvolumio sudo[15483]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:07 myvolumio volumio[15329]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Apr 23 14:47:07 myvolumio volumio[15329]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 23 14:47:07 myvolumio volumio[15329]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227825] CoreMusicLibrary::Adding element Mother Earth Radio Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mother Earth Radio Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227827] CoreMusicLibrary::Adding element Pandora Radio Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mother Earth Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Pandora Radio Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227828] ControllerPandora::initializeMQTT Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227828] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227829] CoreMusicLibrary::Adding element RADIO 357 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mother Earth Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Pandora Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source RADIO 357 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227831] CoreMusicLibrary::Adding element Radio Paradise Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mother Earth Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Pandora Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source RADIO 357 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Radio Paradise Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227832] CoreMusicLibrary::Adding element SWARM Station Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mother Earth Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Pandora Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source RADIO 357 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Radio Paradise Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SWARM Station Apr 23 14:47:07 myvolumio volumio[15329]: info: Loading i18n strings for locale ko Apr 23 14:47:07 myvolumio volumio[15329]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Apr 23 14:47:07 myvolumio volumio[15329]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 23 14:47:07 myvolumio volumio[15329]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. Apr 23 14:47:07 myvolumio volumio[15329]: Updating browse sources language Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mother Earth Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Pandora Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source RADIO 357 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Radio Paradise Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SWARM Station Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mother Earth Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Pandora Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source RADIO 357 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Radio Paradise Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SWARM Station Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227845] CoreMusicLibrary::Adding element Volusonic Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Bandcamp Discover Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Calm Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Jellyfin Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mixcloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SoundCloud Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube2 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source YouTube Music Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source 80s80s Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Mother Earth Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Pandora Radio Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source RADIO 357 Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Radio Paradise Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source SWARM Station Apr 23 14:47:07 myvolumio volumio[15329]: Cannot find translation for source Volusonic Apr 23 14:47:07 myvolumio volumio[15329]: info: Volumio Calling Home Apr 23 14:47:07 myvolumio volumio[15329]: info: [squeezelite_mc] Proxy server started on port 38327 Apr 23 14:47:07 myvolumio volumio[15329]: info: Preparing to generate the ALSA configuration file Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227891] ControllerPandora::initialSetup Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227892] ControllerPandora::PandoraHandler::init Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227892] ControllerPandora::PandoraHandler::loadErrorCodes Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227896] [Pandora] PandoraHandler::setMaxStationTracks: 16 Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227897] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227897] ControllerPandora::flushPandora Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getQueue Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::clearAddPlayQueue Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::saveQueue Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::serviceClearAddPlayTracks Apr 23 14:47:07 myvolumio volumio[15329]: error: WARNING: No clearAddPlayTracks method for service rad357pl Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioPushQueue Apr 23 14:47:07 myvolumio volumio[15329]: info: [1745387227899] ControllerPandora::validateAndSetAccountOptions Apr 23 14:47:07 myvolumio volumio[15329]: error: [1745387227899] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioRetrievevolume Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreStateMachine::pushState Apr 23 14:47:07 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::volumioPushState Apr 23 14:47:07 myvolumio volumio[15329]: info: [squeezelite_mc] Server discovery started Apr 23 14:47:07 myvolumio volumio[15329]: info: [squeezelite_mc] Player finder started Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 14:47:07 myvolumio volumio[15329]: info: [squeezelite_mc] Executing aplay -D hw:0 --nonblock -f MPEG /dev/zero 2>&1 || true Apr 23 14:47:07 myvolumio mpd[15469]: Apr 23 14:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:47:07 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:47:07 myvolumio sudo[15451]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:07 myvolumio sudo[15461]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:07 myvolumio volumio[15329]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 23 14:47:07 myvolumio volumio[15329]: info: Reading ALSA contributions from plugins. Apr 23 14:47:07 myvolumio volumio[15329]: info: [squeezelite_mc] Card 0 supports the following ALSA formats: ["S16_LE","S24_LE"] Apr 23 14:47:07 myvolumio volumio[15329]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"myvolumio","dsdFormat":null,"card":"0","mixerType":"None","mixer":null} Apr 23 14:47:07 myvolumio volumio[15329]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Apr 23 14:47:07 myvolumio volumio[15329]: info: minidlna: Found miniDLNA version 1.2.1 Apr 23 14:47:07 myvolumio volumio[15329]: info: minidlna: Starting minidlna.service Apr 23 14:47:08 myvolumio sudo[15498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Apr 23 14:47:08 myvolumio sudo[15496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Apr 23 14:47:08 myvolumio sudo[15496]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio sudo[15498]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio sudo[15496]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio sudo[15498]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio volumio[15329]: info: MPD Permissions set Apr 23 14:47:08 myvolumio volumio[15329]: info: MPD Permissions set Apr 23 14:47:08 myvolumio volumio[15329]: info: minidlna: systemctl start minidlna.service succeeded. Apr 23 14:47:08 myvolumio volumio[15329]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Apr 23 14:47:08 myvolumio volumio[15329]: info: Spotify config file written Apr 23 14:47:08 myvolumio sudo[15505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Apr 23 14:47:08 myvolumio sudo[15505]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio sudo[15505]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio sudo[15508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 23 14:47:08 myvolumio sudo[15508]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio systemd[1]: Stopping go-librespot Daemon... Apr 23 14:47:08 myvolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Apr 23 14:47:08 myvolumio systemd[1]: go-librespot-daemon.service: Succeeded. Apr 23 14:47:08 myvolumio systemd[1]: Stopped go-librespot Daemon. Apr 23 14:47:08 myvolumio volumio[15329]: error: MPD error: The expression evaluated to a falsy value: Apr 23 14:47:08 myvolumio volumio[15329]: assert.ok(self.idling) Apr 23 14:47:08 myvolumio volumio[15329]: error: The expression evaluated to a falsy value: Apr 23 14:47:08 myvolumio volumio[15329]: assert.ok(self.idling) Apr 23 14:47:08 myvolumio volumio[15329]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Apr 23 14:47:08 myvolumio volumio[15329]: info: MPD running with PID15469 Apr 23 14:47:08 myvolumio volumio[15329]: ,establishing connection Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio systemd[1]: Started go-librespot Daemon. Apr 23 14:47:08 myvolumio go-librespot[15510]: go-librespot daemon starting... Apr 23 14:47:08 myvolumio sudo[15508]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio go-librespot[15510]: time="2025-04-23T14:47:08+09:00" level=info msg="running go-librespot 0.2.0" Apr 23 14:47:08 myvolumio go-librespot[15510]: time="2025-04-23T14:47:08+09:00" level=debug msg="app state loaded" Apr 23 14:47:08 myvolumio go-librespot[15510]: time="2025-04-23T14:47:08+09:00" level=debug msg="stored credentials not found" Apr 23 14:47:08 myvolumio go-librespot[15510]: time="2025-04-23T14:47:08+09:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: No need to fix Spotify hosts Apr 23 14:47:08 myvolumio volumio[15329]: error: updateQueue error: null Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 14:47:08 myvolumio volumio[15329]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Apr 23 14:47:08 myvolumio sudo[15529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Apr 23 14:47:08 myvolumio sudo[15529]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio volumio[15329]: error: updateQueue error: null Apr 23 14:47:08 myvolumio sudo[15529]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio volumio[15329]: info: Starting Shairport Sync Apr 23 14:47:08 myvolumio volumio[15329]: info: Starting Shairport Sync Apr 23 14:47:08 myvolumio sudo[15532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 14:47:08 myvolumio sudo[15532]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio go-librespot[15510]: time="2025-04-23T14:47:08+09:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 23 14:47:08 myvolumio go-librespot[15510]: time="2025-04-23T14:47:08+09:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 23 14:47:08 myvolumio go-librespot[15510]: time="2025-04-23T14:47:08+09:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 23 14:47:08 myvolumio go-librespot[15510]: time="2025-04-23T14:47:08+09:00" level=info msg="zeroconf server listening on port 40531" Apr 23 14:47:08 myvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 23 14:47:08 myvolumio volumio[15329]: info: Starting Shairport Sync Apr 23 14:47:08 myvolumio systemd[1]: shairport-sync.service: Succeeded. Apr 23 14:47:08 myvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 23 14:47:08 myvolumio sudo[15535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 14:47:08 myvolumio sudo[15535]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:08 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:08 myvolumio volumio[15329]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Apr 23 14:47:08 myvolumio sudo[15539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 14:47:08 myvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 23 14:47:08 myvolumio sudo[15539]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio sudo[15532]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 23 14:47:08 myvolumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 23 14:47:08 myvolumio systemd[1]: shairport-sync.service: Succeeded. Apr 23 14:47:08 myvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 23 14:47:08 myvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 23 14:47:08 myvolumio sudo[15542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 23 14:47:08 myvolumio volumio[15329]: info: FusionDsp - Apr 23 14:47:08 myvolumio sudo[15542]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio sudo[15539]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio sudo[15535]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio systemd[1]: Reloading. Apr 23 14:47:08 myvolumio volumio[15329]: info: FusionDsp - Apr 23 14:47:08 myvolumio volumio[15329]: info: FusionDsp - Apr 23 14:47:08 myvolumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 23 14:47:08 myvolumio volumio[15329]: info: FusionDsp - Apr 23 14:47:08 myvolumio volumio[15329]: info: Shairport-Sync Started Apr 23 14:47:08 myvolumio volumio[15329]: Error adding Membership: Error: addMembership EINVAL Apr 23 14:47:08 myvolumio volumio[15329]: info: Asound.conf file unchanged, so no further update is needed Apr 23 14:47:08 myvolumio volumio[15329]: info: Output device has changed, restarting MPD Apr 23 14:47:08 myvolumio sudo[15561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 23 14:47:08 myvolumio sudo[15561]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio sudo[15561]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio volumio[15329]: info: Output device has changed, restarting Shairport Sync Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:47:08 myvolumio sudo[15564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 14:47:08 myvolumio sudo[15564]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio volumio[15329]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 14:47:08 myvolumio volumio[15329]: info: FusionDsp - undefined Apr 23 14:47:08 myvolumio sudo[15542]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio systemd[1]: Stopping Music Player Daemon... Apr 23 14:47:08 myvolumio systemd[1]: mpd.service: Succeeded. Apr 23 14:47:08 myvolumio systemd[1]: Stopped Music Player Daemon. Apr 23 14:47:08 myvolumio volumio[15329]: info: FusionDsp - undefined Apr 23 14:47:08 myvolumio systemd[1]: Starting Music Player Daemon... Apr 23 14:47:08 myvolumio volumio[15329]: info: FusionDsp - undefined Apr 23 14:47:08 myvolumio volumio[15329]: info: FusionDsp - undefined Apr 23 14:47:08 myvolumio sudo[15569]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 14:47:08 myvolumio sudo[15569]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio sudo[15569]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio volumio[15329]: info: Volumio called home Apr 23 14:47:08 myvolumio volumio[15329]: info: Shairport-Sync Started Apr 23 14:47:08 myvolumio volumio[15329]: info: Shairport-Sync Started Apr 23 14:47:08 myvolumio volumio[15329]: info: MPD Permissions set Apr 23 14:47:08 myvolumio volumio[15329]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 23 14:47:08 myvolumio sudo[15573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 23 14:47:08 myvolumio sudo[15573]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio sudo[15573]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:08 myvolumio volumio[15329]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Apr 23 14:47:08 myvolumio volumio[15329]: info: Starting Shairport Sync Apr 23 14:47:08 myvolumio sudo[15580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Apr 23 14:47:08 myvolumio sudo[15580]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::volumioGetState Apr 23 14:47:08 myvolumio volumio[15329]: info: CorePlayQueue::getTrack 0 Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreCommandRouter::volumioPause Apr 23 14:47:08 myvolumio volumio[15329]: info: CoreStateMachine::pause Apr 23 14:47:08 myvolumio volumio[15329]: info: mpdhttpout --- Volumio set on pause Apr 23 14:47:08 myvolumio volumio[15329]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Apr 23 14:47:08 myvolumio sudo[15583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 14:47:08 myvolumio sudo[15583]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:08 myvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 23 14:47:08 myvolumio systemd[1]: shairport-sync.service: Succeeded. Apr 23 14:47:08 myvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 23 14:47:08 myvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 23 14:47:08 myvolumio sudo[15583]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio volumio[15329]: info: Shairport-Sync Started Apr 23 14:47:08 myvolumio mpd[15571]: Apr 23 14:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 14:47:08 myvolumio systemd[1]: Started Music Player Daemon. Apr 23 14:47:08 myvolumio sudo[15564]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:08 myvolumio volumio[15329]: error: updateQueue error: null Apr 23 14:47:08 myvolumio systemd[1]: squeezelite.service: Succeeded. Apr 23 14:47:08 myvolumio systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Apr 23 14:47:08 myvolumio sudo[15580]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:09 myvolumio volumio[15329]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 23 14:47:09 myvolumio sudo[15593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 23 14:47:09 myvolumio sudo[15593]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:09 myvolumio sudo[15593]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:09 myvolumio volumio[15329]: info: [squeezelite_mc] Executing rm /tmp/squeezelite.log Apr 23 14:47:09 myvolumio sudo[15597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /tmp/squeezelite.log Apr 23 14:47:09 myvolumio sudo[15597]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:09 myvolumio sudo[15597]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:09 myvolumio volumio[15329]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Apr 23 14:47:09 myvolumio sudo[15600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Apr 23 14:47:09 myvolumio sudo[15600]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:09 myvolumio volumio[15329]: info: [yt-cast-receiver] DIAL server listening on port 8098 Apr 23 14:47:09 myvolumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Apr 23 14:47:09 myvolumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Apr 23 14:47:09 myvolumio sudo[15600]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:09 myvolumio volumio[15329]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 23 14:47:09 myvolumio volumio[15329]: 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 Apr 23 14:47:09 myvolumio volumio[15329]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 23 14:47:09 myvolumio volumio[15329]: info: camilladsp service started and running in background, instance 1 Apr 23 14:47:09 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 14:47:09 myvolumio volumio[15329]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 23 14:47:09 myvolumio volumio[15329]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 23 14:47:09 myvolumio volumio[15329]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 23 14:47:09 myvolumio volumio[15329]: info: FusionDsp loaded Apr 23 14:47:09 myvolumio volumio[15329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 14:47:09 myvolumio sudo[15616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 23 14:47:09 myvolumio sudo[15616]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 14:47:09 myvolumio volumio[15329]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 23 14:47:09 myvolumio volumio[15329]: info: Adding Signal Path Element [object Object] Apr 23 14:47:09 myvolumio volumio[15329]: info: Adding fusiondspeq DSP Signal Path Element Apr 23 14:47:09 myvolumio volumio[15329]: info: FusionDsp - ---- installed callbackRead Apr 23 14:47:09 myvolumio volumio[15329]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 14:47:09 myvolumio volumio[15329]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 23 14:47:09 myvolumio volumio[15329]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Apr 23 14:47:09 myvolumio volumio[15329]: at onErrorNT (internal/child_process.js:465:16) Apr 23 14:47:09 myvolumio volumio[15329]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 23 14:47:09 myvolumio volumio[15329]: at runNextTicks (internal/process/task_queues.js:62:3) Apr 23 14:47:09 myvolumio volumio[15329]: at listOnTimeout (internal/timers.js:523:9) Apr 23 14:47:09 myvolumio volumio[15329]: at processTimers (internal/timers.js:497:7) { Apr 23 14:47:09 myvolumio volumio[15329]: errno: -2, Apr 23 14:47:09 myvolumio volumio[15329]: code: 'ENOENT', Apr 23 14:47:09 myvolumio volumio[15329]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 23 14:47:09 myvolumio volumio[15329]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 23 14:47:09 myvolumio volumio[15329]: spawnargs: [ Apr 23 14:47:09 myvolumio volumio[15329]: '-p', Apr 23 14:47:09 myvolumio volumio[15329]: 9876, Apr 23 14:47:09 myvolumio volumio[15329]: '-o', Apr 23 14:47:09 myvolumio volumio[15329]: '/tmp/camilladsp.log', Apr 23 14:47:09 myvolumio volumio[15329]: '-l', Apr 23 14:47:09 myvolumio volumio[15329]: 'warn', Apr 23 14:47:09 myvolumio volumio[15329]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 23 14:47:09 myvolumio volumio[15329]: ] Apr 23 14:47:09 myvolumio volumio[15329]: } Apr 23 14:47:09 myvolumio volumio[15329]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 14:47:09 myvolumio systemd[1]: Started FusionDsp Daemon. Apr 23 14:47:09 myvolumio sudo[15616]: pam_unix(sudo:session): session closed for user root Apr 23 14:47:09 myvolumio volumio[15618]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory Apr 23 14:47:09 myvolumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Apr 23 14:47:09 myvolumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 23 14:47:10 myvolumio sudo[15628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-23 14:46 Apr 23 14:47:10 myvolumio sudo[15628]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"