-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2025-04-23 12:19:09 CEST. -- Apr 23 12:18:00 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:00 volumio volumio[829]: info: TidalConnect service started! Apr 23 12:18:04 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:08 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::volumioGetState Apr 23 12:18:10 volumio volumio[829]: info: CorePlayQueue::getTrack 13 Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::volumioGetState Apr 23 12:18:10 volumio volumio[829]: info: CorePlayQueue::getTrack 13 Apr 23 12:18:10 volumio volumio[829]: info: Currently active: mpd Apr 23 12:18:10 volumio volumio[829]: info: Stopping currently active service Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::volumioStop Apr 23 12:18:10 volumio volumio[829]: info: CoreStateMachine::stop Apr 23 12:18:10 volumio volumio[829]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 12:18:10 volumio volumio[829]: info: CoreStateMachine::stPlaybackTimer Apr 23 12:18:10 volumio volumio[829]: info: CoreStateMachine::updateTrackBlock Apr 23 12:18:10 volumio volumio[829]: info: CorePlayQueue::getTrackBlock Apr 23 12:18:10 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:10 volumio volumio[829]: info: CorePlayQueue::getTrack 13 Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:10 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:10 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:10 volumio volumio[829]: info: CoreStateMachine::serviceStop Apr 23 12:18:10 volumio volumio[829]: info: CorePlayQueue::getTrack 13 Apr 23 12:18:10 volumio volumio[829]: info: ControllerMpd::stop Apr 23 12:18:10 volumio volumio[829]: verbose: ControllerMpd::sendMpdCommand stop Apr 23 12:18:10 volumio volumio[829]: info: sendMpdCommand stop took 7 milliseconds Apr 23 12:18:10 volumio volumio[829]: info: TidalConnect Active Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::volumioGetState Apr 23 12:18:10 volumio volumio[829]: info: CorePlayQueue::getTrack 13 Apr 23 12:18:10 volumio volumio[829]: info: Currently active: mpd Apr 23 12:18:10 volumio volumio[829]: info: Setting Volatile state to tidalconnect Apr 23 12:18:10 volumio volumio[829]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:10 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:10 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:10 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:10 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:10 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:10 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:10 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:11 volumio vtcs[23511]: [2025-04-23 12:18:11.311] [tisoc] [warning] [PlaybackControllerImpl.cpp:520] Illegal state:1 Apr 23 12:18:11 volumio vtcs[23511]: [2025-04-23 12:18:11.311] [tisoc] [warning] [PlaybackControllerImpl.cpp:213] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Apr 23 12:18:11 volumio volumio[829]: info: Pushing metadata Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:11 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:11 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:11 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:11 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:11 volumio volumio[829]: info: Pushing metadata Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:11 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:11 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:11 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:11 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:11 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:11 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:11 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:12 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:12 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:12 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:12 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:12 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:12 volumio vtcs[23511]: [2025-04-23 12:18:12.333] [tisoc] [warning] [flac_decoder.cpp:302] FLACDecoder::error_callback FLAC__STREAM_DECODER_ERROR_STATUS_LOST_SYNC Apr 23 12:18:12 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:12 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:12 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:12 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:12 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:12 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:12 volumio volumio[829]: info: CoreCommandRouter::servicePushState Apr 23 12:18:12 volumio volumio[829]: info: CoreStateMachine::pushState Apr 23 12:18:12 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 12:18:12 volumio volumio[829]: info: CoreCommandRouter::volumioPushState Apr 23 12:18:12 volumio volumio[829]: info: MRS: Pushing multiroomSync output update for this device Apr 23 12:18:12 volumio volumio[829]: info: MRS: Pushing multiroomSync output Apr 23 12:18:16 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:20 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:24 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:28 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:29 volumio volumio[829]: info: Disabling MyMusic plugin bluetooth Apr 23 12:18:29 volumio volumio[829]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface bluetooth Apr 23 12:18:29 volumio sudo[23593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Apr 23 12:18:29 volumio sudo[23593]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 12:18:29 volumio systemd[1]: Stopping Volumio Bluetooth Module... Apr 23 12:18:29 volumio volumiobt[23595]: Killing pulse Apr 23 12:18:29 volumio volumio[829]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 23 12:18:29 volumio volumiobt[23595]: Killing BT Pair agent Apr 23 12:18:29 volumio bluetoothd[755]: Endpoint unregistered: sender=:1.42 path=/MediaEndpoint/A2DPSource Apr 23 12:18:29 volumio bluetoothd[755]: Endpoint unregistered: sender=:1.42 path=/MediaEndpoint/A2DPSink Apr 23 12:18:29 volumio volumiobt[1329]: Terminated Apr 23 12:18:29 volumio systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM Apr 23 12:18:29 volumio systemd[1]: volumiobt.service: Succeeded. Apr 23 12:18:29 volumio systemd[1]: Stopped Volumio Bluetooth Module. Apr 23 12:18:29 volumio sudo[23593]: pam_unix(sudo:session): session closed for user root Apr 23 12:18:29 volumio volumio[829]: info: Volumio BT Module successfully stopped Apr 23 12:18:29 volumio volumio[829]: info: Disabling plugin bluetooth Apr 23 12:18:32 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:36 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:40 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:43 volumio volumio[829]: info: Disabling MyMusic plugin airplay_emulation Apr 23 12:18:43 volumio volumio[829]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Apr 23 12:18:43 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 12:18:43 volumio volumio[829]: info: Disabling plugin airplay_emulation Apr 23 12:18:43 volumio volumio[829]: info: Done. Apr 23 12:18:43 volumio sudo[23637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Apr 23 12:18:43 volumio sudo[23637]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 12:18:43 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 23 12:18:43 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 23 12:18:43 volumio volumio[829]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 23 12:18:43 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 23 12:18:43 volumio sudo[23637]: pam_unix(sudo:session): session closed for user root Apr 23 12:18:43 volumio volumio[829]: info: Shairport-Sync Stopped Apr 23 12:18:44 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:48 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:50 volumio volumio[829]: info: Disabling MyMusic plugin upnp_browser Apr 23 12:18:50 volumio volumio[829]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSerwery Mediów Apr 23 12:18:50 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 12:18:50 volumio volumio[829]: info: Disabling plugin upnp_browser Apr 23 12:18:50 volumio volumio[829]: info: Done. Apr 23 12:18:52 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:18:56 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:19:00 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:19:04 volumio volumio[829]: info: Disabling MyMusic plugin upnp Apr 23 12:19:04 volumio sudo[23714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 23 12:19:04 volumio sudo[23714]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 12:19:04 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 23 12:19:04 volumio volumio[829]: error: Upnp client error: Error: This socket has been ended by the other party Apr 23 12:19:04 volumio volumio[829]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 23 12:19:04 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:19:08 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 23 12:19:09 volumio volumio[829]: info: Enabling MyMusic plugin upnp Apr 23 12:19:09 volumio volumio[829]: info: Enabling plugin upnp Apr 23 12:19:09 volumio volumio[829]: info: Loading plugin "upnp"... Apr 23 12:19:09 volumio volumio[829]: info: [1745403549439] Starting Upmpd Daemon Apr 23 12:19:09 volumio volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 23 12:19:09 volumio volumio[829]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 12:19:09 volumio volumio[829]: Error: listen EADDRINUSE: address already in use :::6599 Apr 23 12:19:09 volumio volumio[829]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Apr 23 12:19:09 volumio volumio[829]: at listenInCluster (net.js:1366:12) Apr 23 12:19:09 volumio volumio[829]: at Server.listen (net.js:1452:7) Apr 23 12:19:09 volumio volumio[829]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 23 12:19:09 volumio volumio[829]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 23 12:19:09 volumio volumio[829]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 23 12:19:09 volumio volumio[829]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 23 12:19:09 volumio volumio[829]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 23 12:19:09 volumio volumio[829]: code: 'EADDRINUSE', Apr 23 12:19:09 volumio volumio[829]: errno: -98, Apr 23 12:19:09 volumio volumio[829]: syscall: 'listen', Apr 23 12:19:09 volumio volumio[829]: address: '::', Apr 23 12:19:09 volumio volumio[829]: port: 6599 Apr 23 12:19:09 volumio volumio[829]: } Apr 23 12:19:09 volumio volumio[829]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 12:19:09 volumio sudo[23740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-23 12:18 Apr 23 12:19:09 volumio sudo[23740]: 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"