-- Logs begin at Thu 2019-02-14 05:11:58 EST, end at Sat 2026-02-07 16:49:52 EST. -- Feb 07 16:48:13 volumio-shd volumio[1089]: info: CoreCommandRouter::servicePushState Feb 07 16:48:13 volumio-shd volumio[1089]: info: CoreStateMachine::pushState Feb 07 16:48:13 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 16:48:13 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioPushState Feb 07 16:48:13 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioGetState Feb 07 16:48:13 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output update for this device Feb 07 16:48:13 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output Feb 07 16:48:13 volumio-shd volumio[1089]: info: Updating RAAT Signal Path Feb 07 16:48:13 volumio-shd volumio[1089]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Feb 07 16:48:14 volumio-shd go-librespot[19178]: time="2026-02-07T16:48:14-05:00" level=trace msg="sent dealer ping" Feb 07 16:48:14 volumio-shd go-librespot[19178]: time="2026-02-07T16:48:14-05:00" level=trace msg="received dealer pong" Feb 07 16:48:25 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioGetQueue Feb 07 16:48:25 volumio-shd volumio[1089]: info: CoreStateMachine::getQueue Feb 07 16:48:25 volumio-shd volumio[1089]: info: CorePlayQueue::getQueue Feb 07 16:48:26 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources Feb 07 16:48:26 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 16:48:26 volumio-shd volumio[1089]: info: Listing playlists Feb 07 16:48:27 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 07 16:48:27 volumio-shd volumio[1089]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 07 16:48:33 volumio-shd volumio[1089]: info: CoreCommandRouter::servicePushState Feb 07 16:48:33 volumio-shd volumio[1089]: info: CoreStateMachine::pushState Feb 07 16:48:33 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 16:48:33 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioPushState Feb 07 16:48:33 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioGetState Feb 07 16:48:33 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output update for this device Feb 07 16:48:33 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output Feb 07 16:48:33 volumio-shd volumio[1089]: info: Updating RAAT Signal Path Feb 07 16:48:33 volumio-shd volumio[1089]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Feb 07 16:48:37 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 16:48:37 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 07 16:48:44 volumio-shd go-librespot[19178]: time="2026-02-07T16:48:44-05:00" level=trace msg="sent dealer ping" Feb 07 16:48:44 volumio-shd go-librespot[19178]: time="2026-02-07T16:48:44-05:00" level=trace msg="received dealer pong" Feb 07 16:48:44 volumio-shd go-librespot[19178]: time="2026-02-07T16:48:44-05:00" level=trace msg="received accesspoint ping" Feb 07 16:48:44 volumio-shd go-librespot[19178]: time="2026-02-07T16:48:44-05:00" level=trace msg="received accesspoint pong ack" Feb 07 16:48:53 volumio-shd volumio[1089]: info: CoreCommandRouter::servicePushState Feb 07 16:48:53 volumio-shd volumio[1089]: info: CoreStateMachine::pushState Feb 07 16:48:53 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 16:48:53 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioPushState Feb 07 16:48:53 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioGetState Feb 07 16:48:53 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output update for this device Feb 07 16:48:53 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output Feb 07 16:48:53 volumio-shd volumio[1089]: info: Updating RAAT Signal Path Feb 07 16:48:53 volumio-shd volumio[1089]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Feb 07 16:48:58 volumio-shd volumiologrotate[505]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Feb 07 16:48:58 volumio-shd volumiologrotate[505]: ls: cannot access 'SHD': No such file or directory Feb 07 16:49:12 volumio-shd volumio[1089]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/soundcloud/minidspshd/buster/armhf Feb 07 16:49:13 volumio-shd volumio[1089]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/soundcloud/minidspshd/buster/armhf Feb 07 16:49:13 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSoundCloud Feb 07 16:49:13 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 16:49:13 volumio-shd volumio[1089]: Cannot find translation for source YouTube Music Feb 07 16:49:13 volumio-shd volumio[1089]: Cannot find translation for source 80s80s Radio Feb 07 16:49:13 volumio-shd volumio[1089]: Cannot find translation for source Presets Feb 07 16:49:13 volumio-shd volumio[1089]: Cannot find translation for source QOBUZ Feb 07 16:49:13 volumio-shd volumio[1089]: Cannot find translation for source Spotify Feb 07 16:49:13 volumio-shd volumio[1089]: info: CoreCommandRouter::servicePushState Feb 07 16:49:13 volumio-shd volumio[1089]: info: CoreStateMachine::pushState Feb 07 16:49:13 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 16:49:13 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioPushState Feb 07 16:49:13 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioGetState Feb 07 16:49:13 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output update for this device Feb 07 16:49:13 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output Feb 07 16:49:13 volumio-shd volumio[1089]: info: Updating RAAT Signal Path Feb 07 16:49:13 volumio-shd volumio[1089]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Feb 07 16:49:13 volumio-shd volumio[1089]: info: Check plugin dependencies Feb 07 16:49:13 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 16:49:13 volumio-shd volumio[1089]: info: Rename folder Feb 07 16:49:13 volumio-shd volumio[1089]: info: Folder /tmp/downloaded_plugin.zip removed Feb 07 16:49:13 volumio-shd volumio[1089]: info: Move to category Feb 07 16:49:14 volumio-shd go-librespot[19178]: time="2026-02-07T16:49:14-05:00" level=trace msg="sent dealer ping" Feb 07 16:49:14 volumio-shd volumio[1089]: info: Checking if install.sh is present Feb 07 16:49:14 volumio-shd volumio[1089]: info: Executing install.sh Feb 07 16:49:14 volumio-shd go-librespot[19178]: time="2026-02-07T16:49:14-05:00" level=trace msg="received dealer pong" Feb 07 16:49:14 volumio-shd sudo[1630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/soundcloud/install.sh Feb 07 16:49:14 volumio-shd sudo[1630]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 16:49:14 volumio-shd sudo[1630]: pam_unix(sudo:session): session closed for user root Feb 07 16:49:14 volumio-shd volumio[1089]: info: Install script completed Feb 07 16:49:14 volumio-shd volumio[1089]: info: Done installing plugin. Feb 07 16:49:14 volumio-shd volumio[1089]: info: Enabling plugin soundcloud Feb 07 16:49:14 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 16:49:14 volumio-shd volumio[1089]: info: [{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","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":"SoundCloud","name":"soundcloud","category":"music_service","version":"0.1.5","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.0.6","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.0.2","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true}] Feb 07 16:49:14 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 07 16:49:14 volumio-shd volumio[1089]: info: SoundCloud plugin installed Feb 07 16:49:14 volumio-shd volumio[1089]: Plugin install end detected on script Feb 07 16:49:14 volumio-shd volumio[1089]: info: Folder /tmp/plugins removed Feb 07 16:49:14 volumio-shd volumio[1089]: info: Folder /tmp/downloaded_plugin.zip removed Feb 07 16:49:14 volumio-shd volumio[1089]: info: Folder /data/temp removed Feb 07 16:49:20 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 07 16:49:32 volumio-shd volumio[1089]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/minidspshd/buster/armhf Feb 07 16:49:33 volumio-shd volumio[1089]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/minidspshd/buster/armhf Feb 07 16:49:33 volumio-shd go-librespot[19178]: time="2026-02-07T16:49:33-05:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Feb 07 16:49:33 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Feb 07 16:49:33 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 16:49:33 volumio-shd volumio[1089]: Cannot find translation for source YouTube Music Feb 07 16:49:33 volumio-shd volumio[1089]: Cannot find translation for source 80s80s Radio Feb 07 16:49:33 volumio-shd volumio[1089]: Cannot find translation for source Presets Feb 07 16:49:33 volumio-shd volumio[1089]: Cannot find translation for source QOBUZ Feb 07 16:49:33 volumio-shd sudo[1668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop go-librespot-daemon.service Feb 07 16:49:33 volumio-shd sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 16:49:33 volumio-shd systemd[1]: Stopping go-librespot Daemon... Feb 07 16:49:33 volumio-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Feb 07 16:49:33 volumio-shd systemd[1]: go-librespot-daemon.service: Succeeded. Feb 07 16:49:33 volumio-shd systemd[1]: Stopped go-librespot Daemon. Feb 07 16:49:33 volumio-shd sudo[1668]: pam_unix(sudo:session): session closed for user root Feb 07 16:49:33 volumio-shd volumio[1089]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 07 16:49:33 volumio-shd volumio[1089]: info: Connection to go-librespot Websocket closed Feb 07 16:49:34 volumio-shd volumio[1089]: info: Check plugin dependencies Feb 07 16:49:34 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 16:49:34 volumio-shd volumio[1089]: info: Rename folder Feb 07 16:49:34 volumio-shd volumio[1089]: info: CoreCommandRouter::servicePushState Feb 07 16:49:34 volumio-shd volumio[1089]: info: CoreStateMachine::pushState Feb 07 16:49:34 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 16:49:34 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioPushState Feb 07 16:49:34 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioGetState Feb 07 16:49:34 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output update for this device Feb 07 16:49:34 volumio-shd volumio[1089]: info: MRS: Pushing multiroomSync output Feb 07 16:49:34 volumio-shd volumio[1089]: info: Updating RAAT Signal Path Feb 07 16:49:34 volumio-shd volumio[1089]: info: Folder /tmp/downloaded_plugin.zip removed Feb 07 16:49:34 volumio-shd volumio[1089]: info: Move to category Feb 07 16:49:36 volumio-shd volumio[1089]: info: Checking if install.sh is present Feb 07 16:49:36 volumio-shd volumio[1089]: info: Executing install.sh Feb 07 16:49:36 volumio-shd sudo[1684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh Feb 07 16:49:36 volumio-shd sudo[1684]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 16:49:36 volumio-shd volumio[1089]: info: Installing Go-librespot Feb 07 16:49:36 volumio-shd volumio[1089]: info: Checking old vollibrespot installs Feb 07 16:49:36 volumio-shd systemd[1]: Reloading. Feb 07 16:49:36 volumio-shd 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. Feb 07 16:49:37 volumio-shd systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Feb 07 16:49:37 volumio-shd systemd[1]: serial-getty@ttyS0.service: Current command vanished from the unit file, execution of the command list won't be resumed. Feb 07 16:49:37 volumio-shd volumio[1089]: info: Downloading daemon Feb 07 16:49:39 volumio-shd volumio[1089]: info: Creating directories Feb 07 16:49:39 volumio-shd volumio[1089]: info: Creating Start Script Feb 07 16:49:39 volumio-shd systemd[1]: Reloading. Feb 07 16:49:39 volumio-shd 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. Feb 07 16:49:40 volumio-shd sudo[1684]: pam_unix(sudo:session): session closed for user root Feb 07 16:49:40 volumio-shd volumio[1089]: info: Install script completed Feb 07 16:49:40 volumio-shd volumio[1089]: info: Done installing plugin. Feb 07 16:49:40 volumio-shd volumio[1089]: info: Enabling plugin spop Feb 07 16:49:40 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 16:49:40 volumio-shd volumio[1089]: info: [{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","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":"SoundCloud","name":"soundcloud","category":"music_service","version":"0.1.5","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.0.6","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.0.2","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true}] Feb 07 16:49:40 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 07 16:49:40 volumio-shd volumio[1089]: Plugin install end detected on script Feb 07 16:49:40 volumio-shd volumio[1089]: info: Folder /tmp/plugins removed Feb 07 16:49:40 volumio-shd volumio[1089]: info: Folder /tmp/downloaded_plugin.zip removed Feb 07 16:49:40 volumio-shd volumio[1089]: info: Folder /data/temp removed Feb 07 16:49:51 volumio-shd volumio[1089]: info: Starting Uninstall of plugin music_service - soundcloud Feb 07 16:49:51 volumio-shd volumio[1089]: info: Uninstalling plugin soundcloud Feb 07 16:49:51 volumio-shd volumio[1089]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSoundCloud Feb 07 16:49:51 volumio-shd volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 16:49:51 volumio-shd volumio[1089]: Cannot find translation for source YouTube Music Feb 07 16:49:51 volumio-shd volumio[1089]: Cannot find translation for source 80s80s Radio Feb 07 16:49:51 volumio-shd volumio[1089]: Cannot find translation for source Presets Feb 07 16:49:51 volumio-shd volumio[1089]: Cannot find translation for source QOBUZ Feb 07 16:49:51 volumio-shd volumio[1089]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 16:49:51 volumio-shd volumio[1089]: TypeError: Cannot read property 'clear' of undefined Feb 07 16:49:51 volumio-shd volumio[1089]: at SoundCloudContext.reset (/data/plugins/music_service/soundcloud/lib/soundcloud.js:83:21) Feb 07 16:49:51 volumio-shd volumio[1089]: at ControllerSoundCloud.onStop (/data/plugins/music_service/soundcloud/index.js:177:8) Feb 07 16:49:51 volumio-shd volumio[1089]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Feb 07 16:49:51 volumio-shd volumio[1089]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Feb 07 16:49:51 volumio-shd volumio[1089]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22) Feb 07 16:49:51 volumio-shd volumio[1089]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1271:45) Feb 07 16:49:51 volumio-shd volumio[1089]: at Socket.emit (events.js:400:28) Feb 07 16:49:51 volumio-shd volumio[1089]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Feb 07 16:49:51 volumio-shd volumio[1089]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Feb 07 16:49:51 volumio-shd volumio[1089]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 16:49:52 volumio-shd sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 16:48 Feb 07 16:49:52 volumio-shd sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 18 Nov 2025 04:14:14 PM CET" VOLUMIO_VERSION="3.877" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="57978c68a391dbf6badbe915e5672a72"