-- Logs begin at Sat 2025-05-24 18:48:26 CEST, end at Sat 2025-05-24 23:21:07 CEST. --
May 24 23:20:25 volumio go-librespot[1922]: time="2025-05-24T23:20:25+02:00" level=trace msg="sent dealer ping"
May 24 23:20:25 volumio go-librespot[1922]: time="2025-05-24T23:20:25+02:00" level=trace msg="received dealer pong"
May 24 23:20:33 volumio volumio[853]: error: Upnp client error: Error: This socket has been ended by the other party
May 24 23:20:35 volumio volumio[853]: info:
May 24 23:20:35 volumio volumio[853]: ---------------------------- MPD announces state update: player
May 24 23:20:35 volumio volumio[853]: info: ControllerMpd::getState
May 24 23:20:35 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:20:35 volumio volumio[853]: info: sendMpdCommand status took 0 milliseconds
May 24 23:20:35 volumio volumio[853]: verbose: ControllerMpd::parseState
May 24 23:20:35 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:20:35 volumio volumio[853]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 24 23:20:35 volumio volumio[853]: verbose: ControllerMpd::parseTrackInfo
May 24 23:20:35 volumio volumio[853]: info: ControllerMpd::pushState
May 24 23:20:35 volumio volumio[853]: info: CoreCommandRouter::servicePushState
May 24 23:20:35 volumio volumio[853]: info: CoreStateMachine::pushState
May 24 23:20:35 volumio volumio[853]: info: CoreCommandRouter::volumioPushState
May 24 23:20:35 volumio volumio[853]: info: CorePlayQueue::getTrack 0
May 24 23:20:35 volumio volumio[853]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Blues Garage","artist":"Marco Tansini","album":"Blues Garage","uri":"https://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEidlNTk4N2IwMzA2YjE2MjUyNTdhMDZhZGVhMTdlYjJlOV82MS5tcDQ/0.flac?token=1748124979~ODM4ZWE1YTEzZGI0MTk5MDlmNzQ1ZjA0NTA2N2VmODM2NGY0NjI4MQ==","trackType":"tidal"}
May 24 23:20:35 volumio volumio[853]: verbose: CURRENT POSITION 0
May 24 23:20:35 volumio volumio[853]: info: CoreStateMachine::syncState stateService stop
May 24 23:20:35 volumio volumio[853]: info: CoreStateMachine::syncState currentStatus play
May 24 23:20:35 volumio volumio[853]: info: CoreCommandRouter::volumioPushState
May 24 23:20:35 volumio volumio[853]: info: CoreStateMachine::stPlaybackTimer
May 24 23:20:35 volumio volumio[853]: info: ------------------------------ 2ms
May 24 23:20:35 volumio volumio[853]: info: CoreCommandRouter::volumioGetQueue
May 24 23:20:35 volumio volumio[853]: info: CoreStateMachine::getQueue
May 24 23:20:35 volumio volumio[853]: info: CorePlayQueue::getQueue
May 24 23:20:35 volumio volumio[853]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 24 23:20:35 volumio volumio[853]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 24 23:20:36 volumio volumio[853]: info: Clearing queue after UPNP request
May 24 23:20:36 volumio volumio[853]: info: CoreStateMachine::ClearQueue
May 24 23:20:36 volumio volumio[853]: info: CoreStateMachine::stop
May 24 23:20:36 volumio volumio[853]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 23:20:36 volumio volumio[853]: info: CorePlayQueue::clearPlayQueue
May 24 23:20:36 volumio volumio[853]: info: CorePlayQueue::saveQueue
May 24 23:20:36 volumio volumio[853]: info: CoreCommandRouter::volumioPushState
May 24 23:20:36 volumio volumio[853]: info: CoreCommandRouter::volumioPushQueue
May 24 23:20:36 volumio volumio[853]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 24 23:20:36 volumio volumio[853]: info:
May 24 23:20:36 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:36 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:36 volumio volumio[853]: error: updateQueue error: null
May 24 23:20:36 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:36 volumio volumio[853]: info: Starting UPNP Playback
May 24 23:20:36 volumio volumio[853]: info: Preparing playback through UPNP
May 24 23:20:36 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:36 volumio volumio[853]: info: CorePlayQueue::getTrack 0
May 24 23:20:36 volumio volumio[853]: info: CoreStateMachine::setConsumeUpdateService mpd
May 24 23:20:37 volumio volumio[853]: info:
May 24 23:20:37 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:37 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:37 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:37 volumio volumio[853]: info:
May 24 23:20:37 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:37 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:37 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:37 volumio volumio[853]: info:
May 24 23:20:37 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:37 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:37 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:37 volumio volumio[853]: info:
May 24 23:20:37 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:37 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:37 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:37 volumio volumio[853]: info:
May 24 23:20:37 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:37 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:37 volumio volumio[853]: info: ------------------------------ 1ms
May 24 23:20:37 volumio volumio[853]: info:
May 24 23:20:37 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:37 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:37 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:37 volumio volumio[853]: info:
May 24 23:20:37 volumio volumio[853]: ---------------------------- MPD announces state update: player
May 24 23:20:37 volumio volumio[853]: info: ControllerMpd::getState
May 24 23:20:37 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:20:37 volumio volumio[853]: info:
May 24 23:20:37 volumio volumio[853]: ---------------------------- MPD announces state update: player
May 24 23:20:37 volumio volumio[853]: info: sendMpdCommand status took 5 milliseconds
May 24 23:20:37 volumio volumio[853]: info: ControllerMpd::getState
May 24 23:20:37 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:20:37 volumio volumio[853]: verbose: ControllerMpd::parseState
May 24 23:20:37 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:20:37 volumio volumio[853]: info: sendMpdCommand status took 1 milliseconds
May 24 23:20:37 volumio volumio[853]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 24 23:20:37 volumio volumio[853]: verbose: ControllerMpd::parseState
May 24 23:20:37 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:20:37 volumio volumio[853]: verbose: ControllerMpd::parseTrackInfo
May 24 23:20:37 volumio volumio[853]: info: ControllerMpd::pushState
May 24 23:20:37 volumio volumio[853]: info: CoreCommandRouter::servicePushState
May 24 23:20:37 volumio volumio[853]: verbose: In UPNP mode
May 24 23:20:37 volumio volumio[853]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":377,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"This is Our Time","artist":"Chantal Chamberland","album":"This is Our Time","uri":"https://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEicwYjU5MDI2NWI2Nzc3OWJhM2JmZDQxMWY1MTMxMGJkYl82MS5tcDQ/0.flac?token=1748124980~MzhjNmUyMzM5M2U4YjZmMDdlM2YwMzE1YzU3NmMyOGViYmEwZjUzYw==","trackType":"tidal"}
May 24 23:20:37 volumio volumio[853]: verbose: CURRENT POSITION 0
May 24 23:20:37 volumio volumio[853]: info: CoreStateMachine::syncState stateService play
May 24 23:20:37 volumio volumio[853]: info: CoreStateMachine::syncState currentStatus stop
May 24 23:20:37 volumio volumio[853]: info: ------------------------------ 6ms
May 24 23:20:37 volumio volumio[853]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 23:20:37 volumio volumio[853]: verbose: ControllerMpd::parseTrackInfo
May 24 23:20:37 volumio volumio[853]: info: ControllerMpd::pushState
May 24 23:20:37 volumio volumio[853]: info: CoreCommandRouter::servicePushState
May 24 23:20:37 volumio volumio[853]: verbose: In UPNP mode
May 24 23:20:37 volumio volumio[853]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":377,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"673 Kbps","isStreaming":false,"title":"This is Our Time","artist":"Chantal Chamberland","album":"This is Our Time","uri":"https://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEicwYjU5MDI2NWI2Nzc3OWJhM2JmZDQxMWY1MTMxMGJkYl82MS5tcDQ/0.flac?token=1748124980~MzhjNmUyMzM5M2U4YjZmMDdlM2YwMzE1YzU3NmMyOGViYmEwZjUzYw==","trackType":"tidal"}
May 24 23:20:37 volumio volumio[853]: verbose: CURRENT POSITION 0
May 24 23:20:37 volumio volumio[853]: info: CoreStateMachine::syncState stateService play
May 24 23:20:37 volumio volumio[853]: info: CoreStateMachine::syncState currentStatus play
May 24 23:20:37 volumio volumio[853]: info: Received an update from plugin. extracting info from payload
May 24 23:20:37 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 24 23:20:37 volumio volumio[853]: info: CoreStateMachine::pushState
May 24 23:20:37 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 23:20:37 volumio volumio[853]: info: CoreCommandRouter::volumioPushState
May 24 23:20:37 volumio volumio[853]: info: CoreStateMachine::pushState
May 24 23:20:37 volumio volumio[853]: info: CoreCommandRouter::volumioPushState
May 24 23:20:37 volumio volumio[853]: info: ------------------------------ 4ms
May 24 23:20:37 volumio volumio[853]: info: CoreCommandRouter::volumioGetQueue
May 24 23:20:37 volumio volumio[853]: info: CoreStateMachine::getQueue
May 24 23:20:37 volumio volumio[853]: info: CorePlayQueue::getQueue
May 24 23:20:37 volumio volumio[853]: info: CoreCommandRouter::volumioGetQueue
May 24 23:20:37 volumio volumio[853]: info: CoreStateMachine::getQueue
May 24 23:20:37 volumio volumio[853]: info: CorePlayQueue::getQueue
May 24 23:20:37 volumio volumio[853]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 24 23:20:37 volumio volumio[853]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 24 23:20:38 volumio volumio[853]: info: Starting UPNP Playback
May 24 23:20:38 volumio volumio[853]: info: Preparing playback through UPNP
May 24 23:20:38 volumio volumio[853]: info: Consume mode
May 24 23:20:38 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:38 volumio volumio[853]: info: CoreStateMachine::setConsumeUpdateService mpd
May 24 23:20:38 volumio volumio[853]: info:
May 24 23:20:38 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:38 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:38 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:38 volumio volumio[853]: info:
May 24 23:20:38 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:38 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:38 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:38 volumio volumio[853]: info:
May 24 23:20:38 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:38 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:38 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:38 volumio volumio[853]: info:
May 24 23:20:38 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:38 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:38 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:38 volumio volumio[853]: info:
May 24 23:20:38 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:38 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:38 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:38 volumio volumio[853]: info:
May 24 23:20:38 volumio volumio[853]: ---------------------------- MPD announces system playlist update
May 24 23:20:38 volumio volumio[853]: info: Ignoring MPD Status Update
May 24 23:20:38 volumio volumio[853]: info: ------------------------------ 0ms
May 24 23:20:45 volumio volumio[853]: info:
May 24 23:20:45 volumio volumio[853]: ---------------------------- MPD announces state update: player
May 24 23:20:45 volumio volumio[853]: info: ControllerMpd::getState
May 24 23:20:45 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:20:45 volumio volumio[853]: info: sendMpdCommand status took 0 milliseconds
May 24 23:20:45 volumio volumio[853]: verbose: ControllerMpd::parseState
May 24 23:20:45 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:20:45 volumio volumio[853]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 24 23:20:45 volumio volumio[853]: verbose: ControllerMpd::parseTrackInfo
May 24 23:20:45 volumio volumio[853]: info: ControllerMpd::pushState
May 24 23:20:45 volumio volumio[853]: info: CoreCommandRouter::servicePushState
May 24 23:20:45 volumio volumio[853]: verbose: In UPNP mode
May 24 23:20:45 volumio volumio[853]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9334,"duration":377,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"781 Kbps","isStreaming":false,"title":"This is Our Time","artist":"Chantal Chamberland","album":"This is Our Time","uri":"https://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEicwYjU5MDI2NWI2Nzc3OWJhM2JmZDQxMWY1MTMxMGJkYl82MS5tcDQ/0.flac?token=1748124980~MzhjNmUyMzM5M2U4YjZmMDdlM2YwMzE1YzU3NmMyOGViYmEwZjUzYw==","trackType":"tidal"}
May 24 23:20:45 volumio volumio[853]: verbose: CURRENT POSITION 0
May 24 23:20:45 volumio volumio[853]: info: CoreStateMachine::syncState stateService pause
May 24 23:20:45 volumio volumio[853]: info: CoreStateMachine::syncState currentStatus play
May 24 23:20:45 volumio volumio[853]: info: CoreStateMachine::pushState
May 24 23:20:45 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 23:20:45 volumio volumio[853]: info: CoreCommandRouter::volumioPushState
May 24 23:20:45 volumio volumio[853]: info: CoreStateMachine::stPlaybackTimer
May 24 23:20:45 volumio volumio[853]: info: ------------------------------ 2ms
May 24 23:20:45 volumio volumio[853]: info: CoreCommandRouter::volumioGetQueue
May 24 23:20:45 volumio volumio[853]: info: CoreStateMachine::getQueue
May 24 23:20:45 volumio volumio[853]: info: CorePlayQueue::getQueue
May 24 23:20:45 volumio volumio[853]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 24 23:20:52 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 24 23:20:52 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 23:20:52 volumio volumio[853]: info: Discovery: Getting this device information
May 24 23:20:52 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:52 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 23:20:52 volumio volumio[853]: verbose: New Socket.io Connection to 192.168.1.16:3000 from 192.168.1.22 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
May 24 23:20:52 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:52 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 24 23:20:52 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 24 23:20:53 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 24 23:20:53 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 23:20:53 volumio volumio[853]: info: Discovery: Getting this device information
May 24 23:20:53 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:53 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 23:20:54 volumio go-librespot[1922]: time="2025-05-24T23:20:54+02:00" level=trace msg="received accesspoint ping"
May 24 23:20:54 volumio go-librespot[1922]: time="2025-05-24T23:20:54+02:00" level=trace msg="received accesspoint pong ack"
May 24 23:20:55 volumio go-librespot[1922]: time="2025-05-24T23:20:55+02:00" level=trace msg="sent dealer ping"
May 24 23:20:55 volumio go-librespot[1922]: time="2025-05-24T23:20:55+02:00" level=trace msg="received dealer pong"
May 24 23:20:55 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:55 volumio volumio[853]: verbose: New Socket.io Connection to 192.168.1.16:3000 from 192.168.1.22 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
May 24 23:20:55 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:55 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 24 23:20:55 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 24 23:20:55 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:56 volumio sudo[8536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 24 23:20:56 volumio sudo[8536]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:20:56 volumio sudo[8536]: pam_unix(sudo:session): session closed for user root
May 24 23:20:56 volumio sudo[8539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 24 23:20:56 volumio sudo[8539]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:20:56 volumio sudo[8539]: pam_unix(sudo:session): session closed for user root
May 24 23:20:56 volumio volumio[853]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.22 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
May 24 23:20:57 volumio sudo[8545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 24 23:20:57 volumio sudo[8545]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:20:57 volumio sudo[8545]: pam_unix(sudo:session): session closed for user root
May 24 23:20:57 volumio sudo[8548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 24 23:20:57 volumio sudo[8548]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:20:57 volumio sudo[8548]: pam_unix(sudo:session): session closed for user root
May 24 23:20:57 volumio volumio[853]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.22 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::volumioGetVisibleSources
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 24 23:20:57 volumio volumio[853]: info: Received Get System Info
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 23:20:57 volumio volumio[853]: info: Discovery: Getting this device information
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:57 volumio volumio[853]: info: Listing playlists
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 24 23:20:57 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 24 23:20:59 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 24 23:20:59 volumio volumio[853]: info: Received Get System Info
May 24 23:20:59 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 24 23:20:59 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 23:20:59 volumio volumio[853]: info: Discovery: Getting this device information
May 24 23:20:59 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:20:59 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 23:20:59 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::getUIConfigOnPlugin
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::getUIConfigOnPlugin
May 24 23:21:00 volumio volumio[853]: info: Retrieving Cloud Streaming UI
May 24 23:21:00 volumio volumio[853]: info: Getting Tidal Cloud Configuration
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::getUIConfigOnPlugin
May 24 23:21:00 volumio volumio[853]: info: Getting Qobuz Cloud Configuration
May 24 23:21:00 volumio volumio[853]: info: Asking plugin for UI Config
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::getUIConfigOnPlugin
May 24 23:21:00 volumio volumio[853]: info: Getting Spotify Cloud Configuration
May 24 23:21:00 volumio volumio[853]: info: Asking plugin for UI Config
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::getUIConfigOnPlugin
May 24 23:21:00 volumio volumio[853]: info: Saving Spotify Acccount
May 24 23:21:00 volumio volumio[853]: info: Got Tidal Cloud Configuration
May 24 23:21:00 volumio volumio[853]: info: Got it
May 24 23:21:00 volumio volumio[853]: info: Got it
May 24 23:21:00 volumio volumio[853]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::getUIConfigOnPlugin
May 24 23:21:00 volumio volumio[853]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::volumioGetBrowseSources
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::volumioGetBrowseSources
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::volumioGetBrowseSources
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 24 23:21:00 volumio volumio[853]: info: Received Get System Info
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 23:21:00 volumio volumio[853]: info: Discovery: Getting this device information
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
May 24 23:21:00 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 23:21:01 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 24 23:21:01 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 24 23:21:05 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 24 23:21:05 volumio volumio[853]: info: Disabling MyMusic plugin upnp
May 24 23:21:05 volumio sudo[8567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
May 24 23:21:05 volumio sudo[8567]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:21:05 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
May 24 23:21:05 volumio volumio[853]: error: Upnp client error: Error: This socket has been ended by the other party
May 24 23:21:07 volumio volumio[853]: info: Enabling MyMusic plugin upnp
May 24 23:21:07 volumio volumio[853]: info: Enabling plugin upnp
May 24 23:21:07 volumio volumio[853]: info: Loading plugin "upnp"...
May 24 23:21:07 volumio volumio[853]: info: [1748121667048] Starting Upmpd Daemon
May 24 23:21:07 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 24 23:21:07 volumio volumio[853]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 24 23:21:07 volumio volumio[853]: Error: listen EADDRINUSE: address already in use :::6599
May 24 23:21:07 volumio volumio[853]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
May 24 23:21:07 volumio volumio[853]: at listenInCluster (net.js:1379:12)
May 24 23:21:07 volumio volumio[853]: at Server.listen (net.js:1465:7)
May 24 23:21:07 volumio volumio[853]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
May 24 23:21:07 volumio volumio[853]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
May 24 23:21:07 volumio volumio[853]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
May 24 23:21:07 volumio volumio[853]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
May 24 23:21:07 volumio volumio[853]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
May 24 23:21:07 volumio volumio[853]: code: 'EADDRINUSE',
May 24 23:21:07 volumio volumio[853]: errno: -98,
May 24 23:21:07 volumio volumio[853]: syscall: 'listen',
May 24 23:21:07 volumio volumio[853]: address: '::',
May 24 23:21:07 volumio volumio[853]: port: 6599
May 24 23:21:07 volumio volumio[853]: }
May 24 23:21:07 volumio volumio[853]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 24 23:21:07 volumio sudo[8578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-24 23:20
May 24 23:21:07 volumio sudo[8578]: 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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"