-- Logs begin at Wed 2025-02-26 19:05:04 CET, end at Wed 2025-02-26 19:38:03 CET. -- Feb 26 19:37:00 margules-magenta volumio[728]: info: Feb 26 19:37:00 margules-magenta volumio[728]: ---------------------------- MPD announces system playlist update Feb 26 19:37:00 margules-magenta volumio[728]: info: Ignoring MPD Status Update Feb 26 19:37:00 margules-magenta volumio[728]: info: Feb 26 19:37:00 margules-magenta volumio[728]: ---------------------------- MPD announces state update: player Feb 26 19:37:00 margules-magenta volumio[728]: info: ControllerMpd::getState Feb 26 19:37:00 margules-magenta volumio[728]: verbose: ControllerMpd::sendMpdCommand status Feb 26 19:37:00 margules-magenta volumio[728]: info: ------------------------------ 2ms Feb 26 19:37:00 margules-magenta volumio[728]: info: sendMpdCommand status took 1 milliseconds Feb 26 19:37:00 margules-magenta volumio[728]: verbose: ControllerMpd::parseState Feb 26 19:37:00 margules-magenta volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 19:37:00 margules-magenta volumio[728]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 26 19:37:00 margules-magenta volumio[728]: verbose: ControllerMpd::parseTrackInfo Feb 26 19:37:00 margules-magenta volumio[728]: info: ControllerMpd::pushState Feb 26 19:37:00 margules-magenta volumio[728]: info: CoreCommandRouter::servicePushState Feb 26 19:37:00 margules-magenta volumio[728]: info: CorePlayQueue::getTrack 5 Feb 26 19:37:00 margules-magenta volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":77,"duration":176,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2302 Kbps","isStreaming":false,"title":"300023626","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/300023626","trackType":"qobuz"} Feb 26 19:37:00 margules-magenta volumio[728]: verbose: CURRENT POSITION 5 Feb 26 19:37:00 margules-magenta volumio[728]: info: CoreStateMachine::syncState stateService play Feb 26 19:37:00 margules-magenta volumio[728]: info: CoreStateMachine::syncState currentStatus play Feb 26 19:37:00 margules-magenta volumio[728]: info: Received an update from plugin. extracting info from payload Feb 26 19:37:00 margules-magenta volumio[728]: info: CoreStateMachine::pushState Feb 26 19:37:00 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 19:37:00 margules-magenta volumio[728]: info: CoreCommandRouter::volumioPushState Feb 26 19:37:00 margules-magenta volumio[728]: info: MRS: Pushing multiroomSync output update for this device Feb 26 19:37:00 margules-magenta volumio[728]: info: MRS: Pushing multiroomSync output Feb 26 19:37:00 margules-magenta volumio[728]: info: CoreStateMachine::pushState Feb 26 19:37:00 margules-magenta volumio[728]: info: CoreCommandRouter::volumioPushState Feb 26 19:37:00 margules-magenta volumio[728]: info: MRS: Pushing multiroomSync output update for this device Feb 26 19:37:00 margules-magenta volumio[728]: info: MRS: Pushing multiroomSync output Feb 26 19:37:00 margules-magenta volumio[728]: info: ------------------------------ 18ms Feb 26 19:37:03 margules-magenta volumio[728]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 19:37:03 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 26 19:37:03 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 26 19:37:03 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 26 19:37:04 margules-magenta volumio[728]: info: Received Get System Version Feb 26 19:37:04 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 19:37:04 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 19:37:23 margules-magenta volumio[728]: xcb_connection_has_error() returned true Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 26 19:37:23 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 26 19:37:23 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 26 19:37:23 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 26 19:37:23 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 26 19:37:23 margules-magenta volumio[728]: xcb_connection_has_error() returned true Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 26 19:37:23 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 19:37:39 margules-magenta volumio[728]: info: Retrieving Cloud Streaming UI Feb 26 19:37:39 margules-magenta volumio[728]: info: Getting Tidal Cloud Configuration Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 19:37:39 margules-magenta volumio[728]: info: Getting Qobuz Cloud Configuration Feb 26 19:37:39 margules-magenta volumio[728]: info: Asking plugin for UI Config Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 19:37:39 margules-magenta volumio[728]: info: Getting Spotify Cloud Configuration Feb 26 19:37:39 margules-magenta volumio[728]: info: Asking plugin for UI Config Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 19:37:39 margules-magenta volumio[728]: info: Saving Spotify Acccount Feb 26 19:37:39 margules-magenta volumio[728]: info: Got it Feb 26 19:37:39 margules-magenta volumio[728]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 26 19:37:39 margules-magenta volumio[728]: info: Got Tidal Cloud Configuration Feb 26 19:37:39 margules-magenta volumio[728]: info: Got it Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::volumioGetBrowseSources Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::volumioGetBrowseSources Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::volumioGetBrowseSources Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 19:37:39 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 26 19:37:43 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 19:37:47 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 19:37:51 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 19:37:55 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 19:37:59 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 19:38:00 margules-magenta volumio[728]: info: Disabling MyMusic plugin upnp Feb 26 19:38:00 margules-magenta sudo[3093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Feb 26 19:38:00 margules-magenta sudo[3093]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 19:38:00 margules-magenta systemd[1]: Stopping UPnP Renderer front-end to MPD... Feb 26 19:38:00 margules-magenta volumio[728]: error: Upnp client error: Error: This socket has been ended by the other party Feb 26 19:38:00 margules-magenta volumio[728]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 26 19:38:03 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 19:38:03 margules-magenta volumio[728]: info: Enabling MyMusic plugin upnp Feb 26 19:38:03 margules-magenta volumio[728]: info: Enabling plugin upnp Feb 26 19:38:03 margules-magenta volumio[728]: info: Loading plugin "upnp"... Feb 26 19:38:03 margules-magenta volumio[728]: info: [1740595083370] Starting Upmpd Daemon Feb 26 19:38:03 margules-magenta volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 26 19:38:03 margules-magenta volumio[728]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 19:38:03 margules-magenta volumio[728]: Error: listen EADDRINUSE: address already in use :::6599 Feb 26 19:38:03 margules-magenta volumio[728]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Feb 26 19:38:03 margules-magenta volumio[728]: at listenInCluster (net.js:1366:12) Feb 26 19:38:03 margules-magenta volumio[728]: at Server.listen (net.js:1452:7) Feb 26 19:38:03 margules-magenta volumio[728]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Feb 26 19:38:03 margules-magenta volumio[728]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Feb 26 19:38:03 margules-magenta volumio[728]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Feb 26 19:38:03 margules-magenta volumio[728]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 26 19:38:03 margules-magenta volumio[728]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Feb 26 19:38:03 margules-magenta volumio[728]: code: 'EADDRINUSE', Feb 26 19:38:03 margules-magenta volumio[728]: errno: -98, Feb 26 19:38:03 margules-magenta volumio[728]: syscall: 'listen', Feb 26 19:38:03 margules-magenta volumio[728]: address: '::', Feb 26 19:38:03 margules-magenta volumio[728]: port: 6599 Feb 26 19:38:03 margules-magenta volumio[728]: } Feb 26 19:38:03 margules-magenta volumio[728]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 19:38:03 margules-magenta sudo[3104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-26 19:37 Feb 26 19:38:03 margules-magenta sudo[3104]: 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="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="margules" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 25 Mar 2024 12:05:08 PM CET" VOLUMIO_VERSION="3.609" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_VENDOR_MODEL="Margules Magenta" VOLUMIO_VENDOR="Margules" VOLUMIO_MODEL="Margules Magenta" VOLUMIO_HASH="1fe05d36c107355d439846423b3dc483"