-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Thu 2025-05-29 18:49:49 EDT. -- May 29 18:48:22 pecanpiplus volumio[846]: {"status":"play","position":0,"title":"audio_f_16.dff","artist":null,"album":null,"albumart":"/albumart","uri":"http://192.168.1.205:49153/audirvana/audio_f_16.dff","trackType":"dff","seek":0,"duration":1152,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"bitrate":null,"random":null,"repeat":false,"repeatSingle":false,"consume":true,"volume":100,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"updatedb":false,"volatile":false,"service":"mpd"} May 29 18:48:22 pecanpiplus volumio[846]: ACTIVITY STATUS CHANGED TO: 1 May 29 18:48:33 pecanpiplus ntpd[810]: 198.137.202.32 local addr 192.168.1.198 -> May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 18:48:37 pecanpiplus volumio[846]: info: Retrieving Cloud Streaming UI May 29 18:48:37 pecanpiplus volumio[846]: info: Getting Tidal Cloud Configuration May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 18:48:37 pecanpiplus volumio[846]: info: Getting Qobuz Cloud Configuration May 29 18:48:37 pecanpiplus volumio[846]: info: Asking plugin for UI Config May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 18:48:37 pecanpiplus volumio[846]: info: Getting Spotify Cloud Configuration May 29 18:48:37 pecanpiplus volumio[846]: info: Asking plugin for UI Config May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 18:48:37 pecanpiplus volumio[846]: info: Saving Spotify Acccount May 29 18:48:37 pecanpiplus volumio[846]: info: Got it May 29 18:48:37 pecanpiplus volumio[846]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 29 18:48:37 pecanpiplus volumio[846]: info: Got Tidal Cloud Configuration May 29 18:48:37 pecanpiplus volumio[846]: info: Got it May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::volumioGetBrowseSources May 29 18:48:37 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:48:38 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 29 18:48:41 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:48:45 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:48:49 pecanpiplus volumio[846]: info: Disabling MyMusic plugin upnp May 29 18:48:49 pecanpiplus sudo[4701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 29 18:48:49 pecanpiplus sudo[4701]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 18:48:49 pecanpiplus systemd[1]: Stopping UPnP Renderer front-end to MPD... May 29 18:48:49 pecanpiplus volumio[846]: error: Upnp client error: Error: This socket has been ended by the other party May 29 18:48:49 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:48:52 pecanpiplus volumio[846]: {"status":"play","position":0,"title":"audio_f_16.dff","artist":null,"album":null,"albumart":"/albumart","uri":"http://192.168.1.205:49153/audirvana/audio_f_16.dff","trackType":"dff","seek":0,"duration":1152,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"bitrate":null,"random":null,"repeat":false,"repeatSingle":false,"consume":true,"volume":100,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"updatedb":false,"volatile":false,"service":"mpd"} May 29 18:48:52 pecanpiplus volumio[846]: ACTIVITY STATUS CHANGED TO: 1 May 29 18:48:53 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:48:56 pecanpiplus volumio[846]: info: Disabling MyMusic plugin metavolumio May 29 18:48:56 pecanpiplus volumio[846]: info: Removing METAVOLUMIO REST API Endpoints May 29 18:48:56 pecanpiplus volumio[846]: info: Removing metavolumio REST Endpoint May 29 18:48:57 pecanpiplus volumio[846]: info: Removing getSimilarArtists REST Endpoint May 29 18:48:57 pecanpiplus volumio[846]: info: Removing getSimilarAlbums REST Endpoint May 29 18:48:57 pecanpiplus volumio[846]: info: Removing getSimilarTracks REST Endpoint May 29 18:48:57 pecanpiplus volumio[846]: info: Disabling plugin metavolumio May 29 18:48:57 pecanpiplus volumio[846]: info: Done. May 29 18:48:57 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:01 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:03 pecanpiplus volumio[846]: info: Disabling MyMusic plugin upnp May 29 18:49:03 pecanpiplus sudo[4777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 29 18:49:03 pecanpiplus sudo[4777]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 18:49:06 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:09 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:14 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:18 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:22 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:22 pecanpiplus volumio[846]: {"status":"play","position":0,"title":"audio_f_16.dff","artist":null,"album":null,"albumart":"/albumart","uri":"http://192.168.1.205:49153/audirvana/audio_f_16.dff","trackType":"dff","seek":0,"duration":1152,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"bitrate":null,"random":null,"repeat":false,"repeatSingle":false,"consume":true,"volume":100,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"updatedb":false,"volatile":false,"service":"mpd"} May 29 18:49:22 pecanpiplus volumio[846]: ACTIVITY STATUS CHANGED TO: 1 May 29 18:49:26 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:30 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:30 pecanpiplus ntpd[810]: 44.190.5.123 local addr 192.168.1.198 -> May 29 18:49:31 pecanpiplus volumio[846]: info: CALLMETHOD: miscellanea my_music updateMusicLibrarySupersearchSources [object Object] May 29 18:49:31 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , updateMusicLibrarySupersearchSources May 29 18:49:31 pecanpiplus volumio[846]: info: CoreCommandRouter::volumioGetBrowseSources May 29 18:49:31 pecanpiplus volumio[846]: info: CoreCommandRouter::volumioGetBrowseSources May 29 18:49:31 pecanpiplus volumio[846]: info: CoreCommandRouter::updateGlobalSearchableBrowseSources May 29 18:49:34 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:38 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:41 pecanpiplus ntpd[810]: 23.150.40.242 local addr 192.168.1.198 -> May 29 18:49:41 pecanpiplus ntpd[810]: 104.167.215.195 local addr 192.168.1.198 -> May 29 18:49:42 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:46 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 18:49:47 pecanpiplus volumio[846]: info: Enabling MyMusic plugin upnp May 29 18:49:47 pecanpiplus volumio[846]: info: Enabling plugin upnp May 29 18:49:47 pecanpiplus volumio[846]: info: Loading plugin "upnp"... May 29 18:49:47 pecanpiplus volumio[846]: info: [1748558987608] Starting Upmpd Daemon May 29 18:49:47 pecanpiplus volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 29 18:49:47 pecanpiplus volumio[846]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 18:49:47 pecanpiplus volumio[846]: Error: listen EADDRINUSE: address already in use :::6599 May 29 18:49:47 pecanpiplus volumio[846]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) May 29 18:49:47 pecanpiplus volumio[846]: at listenInCluster (net.js:1366:12) May 29 18:49:47 pecanpiplus volumio[846]: at Server.listen (net.js:1452:7) May 29 18:49:47 pecanpiplus volumio[846]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) May 29 18:49:47 pecanpiplus volumio[846]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) May 29 18:49:47 pecanpiplus volumio[846]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 29 18:49:47 pecanpiplus volumio[846]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 29 18:49:47 pecanpiplus volumio[846]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { May 29 18:49:47 pecanpiplus volumio[846]: code: 'EADDRINUSE', May 29 18:49:47 pecanpiplus volumio[846]: errno: -98, May 29 18:49:47 pecanpiplus volumio[846]: syscall: 'listen', May 29 18:49:47 pecanpiplus volumio[846]: address: '::', May 29 18:49:47 pecanpiplus volumio[846]: port: 6599 May 29 18:49:47 pecanpiplus volumio[846]: } May 29 18:49:47 pecanpiplus volumio[846]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 18:49:49 pecanpiplus sudo[5028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-29 18:48 May 29 18:49:49 pecanpiplus sudo[5028]: 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="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="orchard" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Mar 2025 06:55:38 PM CET" VOLUMIO_VERSION="3.793" VOLUMIO_HARDWARE="pi-kiosk" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_VENDOR_MODEL="Orchard Audio PecanPi+ Streamer Premium" VOLUMIO_VENDOR="Orchard Audio" VOLUMIO_MODEL="PecanPi+ Streamer Premium" VOLUMIO_HASH="51351bccb1b7851be50d1946377b8590"