-- Logs begin at Thu 2024-11-21 15:25:14 CET, end at Thu 2024-11-21 15:39:58 CET. -- Nov 21 15:38:31 bedroom volumio[1174]: error: Upnp client error: Error: This socket has been ended by the other party Nov 21 15:38:35 bedroom volumio[1174]: info: Starting UPNP Playback Nov 21 15:38:35 bedroom volumio[1174]: info: Preparing playback through UPNP Nov 21 15:38:35 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetState Nov 21 15:38:35 bedroom volumio[1174]: info: CorePlayQueue::getTrack 0 Nov 21 15:38:35 bedroom volumio[1174]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 21 15:38:36 bedroom volumio[1174]: info: Clearing queue after UPNP request Nov 21 15:38:36 bedroom volumio[1174]: info: CoreStateMachine::ClearQueue Nov 21 15:38:36 bedroom volumio[1174]: info: CoreStateMachine::stop Nov 21 15:38:36 bedroom volumio[1174]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 15:38:36 bedroom volumio[1174]: info: CorePlayQueue::clearPlayQueue Nov 21 15:38:36 bedroom volumio[1174]: info: CorePlayQueue::saveQueue Nov 21 15:38:36 bedroom volumio[1174]: info: CoreCommandRouter::volumioPushState Nov 21 15:38:36 bedroom volumio[1174]: info: MRS: Pushing multiroomSync output update for this device Nov 21 15:38:36 bedroom volumio[1174]: info: MRS: Pushing multiroomSync output Nov 21 15:38:36 bedroom volumio[1174]: info: CoreCommandRouter::volumioPushQueue Nov 21 15:38:36 bedroom volumio[1174]: info: Nov 21 15:38:36 bedroom volumio[1174]: ---------------------------- MPD announces system playlist update Nov 21 15:38:36 bedroom volumio[1174]: info: Ignoring MPD Status Update Nov 21 15:38:36 bedroom volumio[1174]: error: updateQueue error: null Nov 21 15:38:36 bedroom volumio[1174]: info: ------------------------------ 1ms Nov 21 15:38:36 bedroom volumio[1174]: info: Starting UPNP Playback Nov 21 15:38:36 bedroom volumio[1174]: info: Preparing playback through UPNP Nov 21 15:38:36 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetState Nov 21 15:38:36 bedroom volumio[1174]: info: CorePlayQueue::getTrack 0 Nov 21 15:38:36 bedroom volumio[1174]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 21 15:38:47 bedroom volumio[1174]: info: Starting UPNP Playback Nov 21 15:38:47 bedroom volumio[1174]: info: Preparing playback through UPNP Nov 21 15:38:47 bedroom volumio[1174]: info: Consume mode Nov 21 15:38:47 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetState Nov 21 15:38:47 bedroom volumio[1174]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 21 15:38:48 bedroom volumio[1174]: info: Clearing queue after UPNP request Nov 21 15:38:48 bedroom volumio[1174]: info: CoreStateMachine::ClearQueue Nov 21 15:38:48 bedroom volumio[1174]: info: CoreStateMachine::stop Nov 21 15:38:48 bedroom volumio[1174]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 15:38:48 bedroom volumio[1174]: info: CorePlayQueue::clearPlayQueue Nov 21 15:38:48 bedroom volumio[1174]: info: CorePlayQueue::saveQueue Nov 21 15:38:48 bedroom volumio[1174]: info: CoreCommandRouter::volumioPushState Nov 21 15:38:48 bedroom volumio[1174]: info: MRS: Pushing multiroomSync output update for this device Nov 21 15:38:48 bedroom volumio[1174]: info: MRS: Pushing multiroomSync output Nov 21 15:38:48 bedroom volumio[1174]: info: CoreCommandRouter::volumioPushQueue Nov 21 15:38:48 bedroom volumio[1174]: info: Nov 21 15:38:48 bedroom volumio[1174]: ---------------------------- MPD announces system playlist update Nov 21 15:38:48 bedroom volumio[1174]: info: Ignoring MPD Status Update Nov 21 15:38:48 bedroom volumio[1174]: error: updateQueue error: null Nov 21 15:38:48 bedroom volumio[1174]: info: ------------------------------ 1ms Nov 21 15:38:48 bedroom volumio[1174]: info: Starting UPNP Playback Nov 21 15:38:48 bedroom volumio[1174]: info: Preparing playback through UPNP Nov 21 15:38:48 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetState Nov 21 15:38:48 bedroom volumio[1174]: info: CorePlayQueue::getTrack 0 Nov 21 15:38:48 bedroom volumio[1174]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 21 15:39:26 bedroom volumio[1174]: info: Starting UPNP Playback Nov 21 15:39:26 bedroom volumio[1174]: info: Preparing playback through UPNP Nov 21 15:39:26 bedroom volumio[1174]: info: Consume mode Nov 21 15:39:26 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetState Nov 21 15:39:26 bedroom volumio[1174]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 21 15:39:27 bedroom volumio[1174]: info: Clearing queue after UPNP request Nov 21 15:39:27 bedroom volumio[1174]: info: CoreStateMachine::ClearQueue Nov 21 15:39:27 bedroom volumio[1174]: info: CoreStateMachine::stop Nov 21 15:39:27 bedroom volumio[1174]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 15:39:27 bedroom volumio[1174]: info: CorePlayQueue::clearPlayQueue Nov 21 15:39:27 bedroom volumio[1174]: info: CorePlayQueue::saveQueue Nov 21 15:39:27 bedroom volumio[1174]: info: CoreCommandRouter::volumioPushState Nov 21 15:39:27 bedroom volumio[1174]: info: MRS: Pushing multiroomSync output update for this device Nov 21 15:39:27 bedroom volumio[1174]: info: MRS: Pushing multiroomSync output Nov 21 15:39:27 bedroom volumio[1174]: info: CoreCommandRouter::volumioPushQueue Nov 21 15:39:27 bedroom volumio[1174]: info: Nov 21 15:39:27 bedroom volumio[1174]: ---------------------------- MPD announces system playlist update Nov 21 15:39:27 bedroom volumio[1174]: info: Ignoring MPD Status Update Nov 21 15:39:27 bedroom volumio[1174]: error: updateQueue error: null Nov 21 15:39:27 bedroom volumio[1174]: info: ------------------------------ 1ms Nov 21 15:39:27 bedroom volumio[1174]: info: Starting UPNP Playback Nov 21 15:39:27 bedroom volumio[1174]: info: Preparing playback through UPNP Nov 21 15:39:27 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetState Nov 21 15:39:27 bedroom volumio[1174]: info: CorePlayQueue::getTrack 0 Nov 21 15:39:27 bedroom volumio[1174]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 21 15:39:31 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetState Nov 21 15:39:33 bedroom volumio[1174]: info: Executing endpoint metavolumio Nov 21 15:39:33 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 15:39:34 bedroom volumio[1174]: xcb_connection_has_error() returned true Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 21 15:39:34 bedroom volumio[1174]: info: Getting Alsa Cards List without I2S DAC Nov 21 15:39:34 bedroom volumio[1174]: xcb_connection_has_error() returned true Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 15:39:34 bedroom volumio[1174]: xcb_connection_has_error() returned true Nov 21 15:39:34 bedroom volumio[1174]: xcb_connection_has_error() returned true Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 21 15:39:34 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 21 15:39:39 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetState Nov 21 15:39:41 bedroom volumio[1174]: info: Executing endpoint metavolumio Nov 21 15:39:41 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 15:39:46 bedroom volumio[1174]: info: Retrieving Cloud Streaming UI Nov 21 15:39:46 bedroom volumio[1174]: info: Getting Tidal Cloud Configuration Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 15:39:46 bedroom volumio[1174]: info: Getting Qobuz Cloud Configuration Nov 21 15:39:46 bedroom volumio[1174]: info: Asking plugin for UI Config Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 15:39:46 bedroom volumio[1174]: info: Getting Spotify Cloud Configuration Nov 21 15:39:46 bedroom volumio[1174]: info: Asking plugin for UI Config Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 15:39:46 bedroom volumio[1174]: info: Saving Spotify Acccount Nov 21 15:39:46 bedroom volumio[1174]: info: Got it Nov 21 15:39:46 bedroom volumio[1174]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 21 15:39:46 bedroom volumio[1174]: info: Got Tidal Cloud Configuration Nov 21 15:39:46 bedroom volumio[1174]: info: Got it Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetBrowseSources Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetBrowseSources Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetBrowseSources Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 21 15:39:46 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 21 15:39:48 bedroom volumio[1174]: info: Disabling MyMusic plugin upnp Nov 21 15:39:48 bedroom sudo[4695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Nov 21 15:39:48 bedroom sudo[4695]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 15:39:48 bedroom systemd[1]: Stopping UPnP Renderer front-end to MPD... Nov 21 15:39:48 bedroom volumio[1174]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 21 15:39:48 bedroom volumio[1174]: error: Upnp client error: Error: This socket has been ended by the other party Nov 21 15:39:48 bedroom volumio[1174]: info: Tunnel connection is inactive, restarting it Nov 21 15:39:48 bedroom volumio[1174]: info: Starting Tunnel 1 Nov 21 15:39:48 bedroom volumio[1174]: info: Starting Tunnel Connection Checker Nov 21 15:39:48 bedroom sudo[4702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Nov 21 15:39:48 bedroom sudo[4702]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 15:39:48 bedroom autossh[4205]: received signal to exit (15) Nov 21 15:39:48 bedroom systemd[1]: Stopping MyVolumio SSH Tunnel... Nov 21 15:39:48 bedroom systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Nov 21 15:39:48 bedroom systemd[1]: sshtunnel.service: Succeeded. Nov 21 15:39:48 bedroom systemd[1]: Stopped MyVolumio SSH Tunnel. Nov 21 15:39:48 bedroom volumio[1174]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 21 15:39:48 bedroom volumio[1174]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 21 15:39:48 bedroom systemd[1]: Started MyVolumio SSH Tunnel. Nov 21 15:39:48 bedroom sudo[4702]: pam_unix(sudo:session): session closed for user root Nov 21 15:39:48 bedroom volumio[1174]: info: Remote SSH Started Nov 21 15:39:48 bedroom autossh[4707]: port set to 0, monitoring disabled Nov 21 15:39:48 bedroom autossh[4707]: starting ssh (count 1) Nov 21 15:39:48 bedroom autossh[4707]: ssh child pid is 4710 Nov 21 15:39:48 bedroom volumio[1174]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Nov 21 15:39:48 bedroom volumio[1174]: info: CoreCommandRouter::volumioGetState Nov 21 15:39:50 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 21 15:39:54 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 21 15:39:58 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 21 15:39:58 bedroom volumio[1174]: info: Enabling MyMusic plugin upnp Nov 21 15:39:58 bedroom volumio[1174]: info: Enabling plugin upnp Nov 21 15:39:58 bedroom volumio[1174]: info: Loading plugin "upnp"... Nov 21 15:39:58 bedroom volumio[1174]: info: [1732199998704] Starting Upmpd Daemon Nov 21 15:39:58 bedroom volumio[1174]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 21 15:39:58 bedroom volumio[1174]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 15:39:58 bedroom volumio[1174]: Error: listen EADDRINUSE: address already in use :::6599 Nov 21 15:39:58 bedroom volumio[1174]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 21 15:39:58 bedroom volumio[1174]: at listenInCluster (net.js:1366:12) Nov 21 15:39:58 bedroom volumio[1174]: at Server.listen (net.js:1452:7) Nov 21 15:39:58 bedroom volumio[1174]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Nov 21 15:39:58 bedroom volumio[1174]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Nov 21 15:39:58 bedroom volumio[1174]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Nov 21 15:39:58 bedroom volumio[1174]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Nov 21 15:39:58 bedroom volumio[1174]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Nov 21 15:39:58 bedroom volumio[1174]: code: 'EADDRINUSE', Nov 21 15:39:58 bedroom volumio[1174]: errno: -98, Nov 21 15:39:58 bedroom volumio[1174]: syscall: 'listen', Nov 21 15:39:58 bedroom volumio[1174]: address: '::', Nov 21 15:39:58 bedroom volumio[1174]: port: 6599 Nov 21 15:39:58 bedroom volumio[1174]: } Nov 21 15:39:58 bedroom volumio[1174]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 15:39:58 bedroom sudo[4739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-21 15:38 Nov 21 15:39:58 bedroom sudo[4739]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"