-- Logs begin at Tue 2025-05-27 09:57:04 +07, end at Tue 2025-05-27 11:40:06 +07. --
May 27 11:39:00 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:39:01 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:01 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:04 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:04 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:07 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:07 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:09 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState
May 27 11:39:10 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:10 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:11 volumio volumio[1123]: verbose: New Socket.io Connection to 192.168.31.219 from 192.168.31.218 UA: Mozilla/5.0 (iPad; CPU OS 18_5_0 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) CriOS/136.0.7103.91 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 9
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::volumioGetVisibleSources
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 27 11:39:11 volumio volumio[1123]: info: Received Get System Info
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 27 11:39:11 volumio volumio[1123]: info: Discovery: Getting this device information
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState
May 27 11:39:11 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 27 11:39:12 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState
May 27 11:39:12 volumio volumio[1123]: info: Listing playlists
May 27 11:39:12 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 27 11:39:13 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:13 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:16 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:16 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:39:18 volumio volumio[1123]: info: Retrieving Cloud Streaming UI
May 27 11:39:18 volumio volumio[1123]: info: Getting Tidal Cloud Configuration
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:39:18 volumio volumio[1123]: info: Getting Qobuz Cloud Configuration
May 27 11:39:18 volumio volumio[1123]: info: Asking plugin for UI Config
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:39:18 volumio volumio[1123]: info: Getting Spotify Cloud Configuration
May 27 11:39:18 volumio volumio[1123]: info: Asking plugin for UI Config
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:39:18 volumio volumio[1123]: info: Saving Spotify Acccount
May 27 11:39:18 volumio volumio[1123]: info: Got Tidal Cloud Configuration
May 27 11:39:18 volumio volumio[1123]: info: Got it
May 27 11:39:18 volumio volumio[1123]: info: Got it
May 27 11:39:18 volumio volumio[1123]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:39:18 volumio volumio[1123]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::volumioGetBrowseSources
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::volumioGetBrowseSources
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::volumioGetBrowseSources
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 27 11:39:18 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 27 11:39:19 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:19 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:22 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:22 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:23 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
May 27 11:39:24 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 27 11:39:25 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:25 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:28 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:28 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:31 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:31 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:34 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:34 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:37 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:37 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:38 volumio volumio[1123]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object]
May 27 11:39:38 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions
May 27 11:39:38 volumio sudo[28415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 27 11:39:38 volumio sudo[28415]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 11:39:38 volumio sudo[28415]: pam_unix(sudo:session): session closed for user root
May 27 11:39:38 volumio volumio[1123]: info: MPD Permissions set
May 27 11:39:38 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:38 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:38 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:38 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:38 volumio sudo[28419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 27 11:39:38 volumio sudo[28419]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 11:39:38 volumio systemd[1]: Stopping Music Player Daemon...
May 27 11:39:38 volumio systemd[1]: mpd.service: Succeeded.
May 27 11:39:38 volumio systemd[1]: Stopped Music Player Daemon.
May 27 11:39:38 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 27 11:39:38 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 27 11:39:38 volumio systemd[1]: Starting Music Player Daemon...
May 27 11:39:38 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:38 volumio sudo[28425]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 27 11:39:38 volumio sudo[28425]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 11:39:38 volumio sudo[28425]: pam_unix(sudo:session): session closed for user root
May 27 11:39:38 volumio mpd[28430]: May 27 11:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 27 11:39:38 volumio systemd[1]: Started Music Player Daemon.
May 27 11:39:38 volumio sudo[28419]: pam_unix(sudo:session): session closed for user root
May 27 11:39:38 volumio volumio[1123]: error: updateQueue error: null
May 27 11:39:39 volumio volumio[1123]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object]
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions
May 27 11:39:39 volumio sudo[28435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 27 11:39:39 volumio sudo[28435]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 11:39:39 volumio sudo[28435]: pam_unix(sudo:session): session closed for user root
May 27 11:39:39 volumio volumio[1123]: info: MPD Permissions set
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio sudo[28438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 27 11:39:39 volumio sudo[28438]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 11:39:39 volumio systemd[1]: Stopping Music Player Daemon...
May 27 11:39:39 volumio systemd[1]: mpd.service: Succeeded.
May 27 11:39:39 volumio systemd[1]: Stopped Music Player Daemon.
May 27 11:39:39 volumio systemd[1]: Starting Music Player Daemon...
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio sudo[28441]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 27 11:39:39 volumio sudo[28441]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 11:39:39 volumio sudo[28441]: pam_unix(sudo:session): session closed for user root
May 27 11:39:39 volumio volumio[1123]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object]
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions
May 27 11:39:39 volumio sudo[28451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 27 11:39:39 volumio sudo[28451]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio sudo[28451]: pam_unix(sudo:session): session closed for user root
May 27 11:39:39 volumio sudo[28453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 27 11:39:39 volumio sudo[28453]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 11:39:39 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
May 27 11:39:39 volumio systemd[1]: mpd.service: Succeeded.
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 27 11:39:39 volumio systemd[1]: Stopped Music Player Daemon.
May 27 11:39:39 volumio systemd[1]: Starting Music Player Daemon...
May 27 11:39:39 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 27 11:39:39 volumio volumio[1123]: info: MPD Permissions set
May 27 11:39:39 volumio sudo[28460]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 27 11:39:39 volumio sudo[28460]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 27 11:39:39 volumio sudo[28460]: pam_unix(sudo:session): session closed for user root
May 27 11:39:40 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:40 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:40 volumio mpd[28464]: May 27 11:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 27 11:39:40 volumio systemd[1]: Started Music Player Daemon.
May 27 11:39:40 volumio sudo[28438]: pam_unix(sudo:session): session closed for user root
May 27 11:39:40 volumio sudo[28453]: pam_unix(sudo:session): session closed for user root
May 27 11:39:40 volumio volumio[1123]: error: MPD error: The expression evaluated to a falsy value:
May 27 11:39:40 volumio volumio[1123]: assert.ok(self.idling)
May 27 11:39:40 volumio volumio[1123]: error: The expression evaluated to a falsy value:
May 27 11:39:40 volumio volumio[1123]: assert.ok(self.idling)
May 27 11:39:40 volumio volumio[1123]: error: updateQueue error: null
May 27 11:39:43 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:43 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:43 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState
May 27 11:39:45 volumio volumio[1123]: info: CoreCommandRouter::volumioPlay
May 27 11:39:45 volumio volumio[1123]: info: CoreStateMachine::play index undefined
May 27 11:39:45 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined
May 27 11:39:45 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:39:45 volumio volumio[1123]: info: CoreStateMachine::startPlaybackTimer
May 27 11:39:45 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:39:45 volumio volumio[1123]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Die%20With%20A%20Smile%20(Live%20in%20Las%20Vegas)%22%2C%22artist%22%3A%22Lady%20Gaga%20%26%20Bruno%20Mars%22%2C%22album%22%3A%22Die%20With%20A%20Smile%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2Fx5ST0wHIxD__IIxHF1UqUgXP4QW58ouj1EHROC9I5yHIb8cmoNr9rL54RfA-BnYay_eWmmOJfXNuFqmPEA%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22ioNYKflP4RY%22%2C%22playlistId%22%3A%22RDAMVMioNYKflP4RY%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22ioNYKflP4RY%22%2C%22playlistId%22%3A%22RDAMVMioNYKflP4RY%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
May 27 11:39:45 volumio volumio[1123]: info: [ytmusic] Preferred format is Opus
May 27 11:39:45 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:39:45 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop
May 27 11:39:45 volumio volumio[1123]: info: sendMpdCommand stop took 6 milliseconds
May 27 11:39:45 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear
May 27 11:39:45 volumio volumio[1123]: info:
May 27 11:39:45 volumio volumio[1123]: ---------------------------- MPD announces system playlist update
May 27 11:39:45 volumio volumio[1123]: info: Ignoring MPD Status Update
May 27 11:39:45 volumio volumio[1123]: info: sendMpdCommand clear took 7 milliseconds
May 27 11:39:45 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand addid "https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube"
May 27 11:39:45 volumio volumio[1123]: info:
May 27 11:39:45 volumio volumio[1123]: ---------------------------- MPD announces system playlist update
May 27 11:39:45 volumio volumio[1123]: info: Ignoring MPD Status Update
May 27 11:39:45 volumio volumio[1123]: error: updateQueue error: null
May 27 11:39:45 volumio volumio[1123]: info:
May 27 11:39:45 volumio volumio[1123]: ---------------------------- MPD announces system playlist update
May 27 11:39:45 volumio volumio[1123]: info: Ignoring MPD Status Update
May 27 11:39:45 volumio volumio[1123]: info: ------------------------------ 6ms
May 27 11:39:45 volumio volumio[1123]: info: sendMpdCommand addid "https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube" took 5 milliseconds
May 27 11:39:45 volumio volumio[1123]: info: ------------------------------ 4ms
May 27 11:39:45 volumio volumio[1123]: verbose: MPD COMMAND [object Object]
May 27 11:39:45 volumio volumio[1123]: verbose: MPD COMMAND [object Object]
May 27 11:39:45 volumio volumio[1123]: info:
May 27 11:39:45 volumio volumio[1123]: ---------------------------- MPD announces system playlist update
May 27 11:39:45 volumio volumio[1123]: info: Ignoring MPD Status Update
May 27 11:39:45 volumio volumio[1123]: info:
May 27 11:39:45 volumio volumio[1123]: ---------------------------- MPD announces system playlist update
May 27 11:39:45 volumio volumio[1123]: info: Ignoring MPD Status Update
May 27 11:39:45 volumio volumio[1123]: info: ------------------------------ 6ms
May 27 11:39:45 volumio volumio[1123]: info: ------------------------------ 2ms
May 27 11:39:45 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService mpd
May 27 11:39:45 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand play
May 27 11:39:45 volumio volumio[1123]: info:
May 27 11:39:45 volumio volumio[1123]: ---------------------------- MPD announces system playlist update
May 27 11:39:45 volumio volumio[1123]: info: Ignoring MPD Status Update
May 27 11:39:45 volumio volumio[1123]: info: ------------------------------ 7ms
May 27 11:39:45 volumio volumio[1123]: info: sendMpdCommand play took 5 milliseconds
May 27 11:39:45 volumio volumio[1123]: info: ------------------------------ 4ms
May 27 11:39:46 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:46 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:46 volumio volumio[1123]: info:
May 27 11:39:46 volumio volumio[1123]: ---------------------------- MPD announces state update: player
May 27 11:39:46 volumio volumio[1123]: info: ControllerMpd::getState
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:39:46 volumio volumio[1123]: info:
May 27 11:39:46 volumio volumio[1123]: ---------------------------- MPD announces state update: player
May 27 11:39:46 volumio volumio[1123]: info: ControllerMpd::getState
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand clearerror
May 27 11:39:46 volumio volumio[1123]: info: sendMpdCommand status took 11 milliseconds
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand clearerror
May 27 11:39:46 volumio volumio[1123]: info: sendMpdCommand status took 11 milliseconds
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 27 11:39:46 volumio volumio[1123]: info: sendMpdCommand clearerror took 5 milliseconds
May 27 11:39:46 volumio volumio[1123]: info: sendMpdCommand clearerror took 4 milliseconds
May 27 11:39:46 volumio volumio[1123]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 27 11:39:46 volumio volumio[1123]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::parseTrackInfo
May 27 11:39:46 volumio volumio[1123]: verbose: ControllerMpd::parseTrackInfo
May 27 11:39:46 volumio volumio[1123]: info: ControllerMpd::pushState
May 27 11:39:46 volumio volumio[1123]: info: CoreCommandRouter::servicePushState
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:39:46 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 27 11:39:46 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:39:46 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:39:46 volumio volumio[1123]: 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":"Die With A Smile (Live in Las Vegas)","artist":"Lady Gaga & Bruno Mars","album":"Die With A Smile","uri":"https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
May 27 11:39:46 volumio volumio[1123]: verbose: CURRENT POSITION 0
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:39:46 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:39:46 volumio volumio[1123]: info: No code
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:39:46 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:39:46 volumio volumio[1123]: info: ControllerMpd::pushState
May 27 11:39:46 volumio volumio[1123]: info: CoreCommandRouter::servicePushState
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:39:46 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:39:46 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:39:46 volumio volumio[1123]: 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":"Die With A Smile (Live in Las Vegas)","artist":"Lady Gaga & Bruno Mars","album":"Die With A Smile","uri":"https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
May 27 11:39:46 volumio volumio[1123]: verbose: CURRENT POSITION 0
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:39:46 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:39:46 volumio volumio[1123]: info: No code
May 27 11:39:46 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:39:46 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:39:46 volumio volumio[1123]: info: ------------------------------ 35ms
May 27 11:39:46 volumio volumio[1123]: info: ------------------------------ 35ms
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:46 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:39:49 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:49 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:49 volumio volumio[1123]: info: CoreCommandRouter::volumioGetQueue
May 27 11:39:49 volumio volumio[1123]: info: CoreStateMachine::getQueue
May 27 11:39:49 volumio volumio[1123]: info: CorePlayQueue::getQueue
May 27 11:39:52 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:52 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:55 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:55 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:56 volumio volumio[1123]: info: Preload queue cleared
May 27 11:39:58 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:39:58 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:39:59 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:40:00 volumio volumio[1123]: info: Retrieving Cloud Streaming UI
May 27 11:40:00 volumio volumio[1123]: info: Getting Tidal Cloud Configuration
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:40:00 volumio volumio[1123]: info: Getting Qobuz Cloud Configuration
May 27 11:40:00 volumio volumio[1123]: info: Asking plugin for UI Config
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:40:00 volumio volumio[1123]: info: Getting Spotify Cloud Configuration
May 27 11:40:00 volumio volumio[1123]: info: Asking plugin for UI Config
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:40:00 volumio volumio[1123]: info: Saving Spotify Acccount
May 27 11:40:00 volumio volumio[1123]: info: Got Tidal Cloud Configuration
May 27 11:40:00 volumio volumio[1123]: info: Got it
May 27 11:40:00 volumio volumio[1123]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin
May 27 11:40:00 volumio volumio[1123]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::volumioGetBrowseSources
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::volumioGetBrowseSources
May 27 11:40:00 volumio volumio[1123]: info: CoreCommandRouter::volumioGetBrowseSources
May 27 11:40:01 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:40:01 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:40:02 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 27 11:40:02 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 27 11:40:04 volumio volumio[1123]: info: Initializing connection to go-librespot Websocket
May 27 11:40:04 volumio volumio[1123]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 27 11:40:04 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
May 27 11:40:04 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand rescan
May 27 11:40:04 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:04 volumio volumio[1123]: info:
May 27 11:40:04 volumio volumio[1123]: ---------------------------- MPD announces state update: update
May 27 11:40:04 volumio volumio[1123]: info: sendMpdCommand rescan took 17 milliseconds
May 27 11:40:04 volumio volumio[1123]: info: ControllerMpd::getState
May 27 11:40:04 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:04 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:04 volumio volumio[1123]: info:
May 27 11:40:04 volumio volumio[1123]: ---------------------------- MPD announces state update: update
May 27 11:40:04 volumio volumio[1123]: info: ControllerMpd::getState
May 27 11:40:04 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:04 volumio volumio[1123]: info: sendMpdCommand status took 7 milliseconds
May 27 11:40:04 volumio volumio[1123]: info: sendMpdCommand status took 7 milliseconds
May 27 11:40:04 volumio volumio[1123]: info: sendMpdCommand status took 7 milliseconds
May 27 11:40:04 volumio volumio[1123]: info: sendMpdCommand status took 6 milliseconds
May 27 11:40:04 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 27 11:40:05 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed
May 27 11:40:05 volumio volumio[1123]: info:
May 27 11:40:05 volumio volumio[1123]: ---------------------------- MPD announces state update: database
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:05 volumio volumio[1123]: info:
May 27 11:40:05 volumio volumio[1123]: ---------------------------- MPD announces state update: update
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::getState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::getState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand playlistinfo took 50 milliseconds
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand playlistinfo took 14 milliseconds
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseTrackInfo
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::servicePushState
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:40:05 volumio volumio[1123]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Die With A Smile (Live in Las Vegas)","artist":"Lady Gaga & Bruno Mars","album":"Die With A Smile","uri":"https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
May 27 11:40:05 volumio volumio[1123]: verbose: CURRENT POSITION 0
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: No code
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::servicePushState
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:40:05 volumio volumio[1123]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Die With A Smile (Live in Las Vegas)","artist":"Lady Gaga & Bruno Mars","album":"Die With A Smile","uri":"https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
May 27 11:40:05 volumio volumio[1123]: verbose: CURRENT POSITION 0
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: No code
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: ------------------------------ 197ms
May 27 11:40:05 volumio volumio[1123]: info: ------------------------------ 196ms
May 27 11:40:05 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed
May 27 11:40:05 volumio volumio[1123]: info:
May 27 11:40:05 volumio volumio[1123]: ---------------------------- MPD announces state update: database
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:05 volumio volumio[1123]: info:
May 27 11:40:05 volumio volumio[1123]: ---------------------------- MPD announces state update: update
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::getState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::getState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand status took 49 milliseconds
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand status took 47 milliseconds
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand status took 47 milliseconds
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand status took 25 milliseconds
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand status took 24 milliseconds
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand status took 23 milliseconds
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseState
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand playlistinfo took 96 milliseconds
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand playlistinfo took 96 milliseconds
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand playlistinfo took 20 milliseconds
May 27 11:40:05 volumio volumio[1123]: info: sendMpdCommand playlistinfo took 20 milliseconds
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseTrackInfo
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseTrackInfo
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseTrackInfo
May 27 11:40:05 volumio volumio[1123]: verbose: ControllerMpd::parseTrackInfo
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::servicePushState
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:40:05 volumio volumio[1123]: 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":"Die With A Smile (Live in Las Vegas)","artist":"Lady Gaga & Bruno Mars","album":"Die With A Smile","uri":"https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
May 27 11:40:05 volumio volumio[1123]: verbose: CURRENT POSITION 0
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: No code
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::servicePushState
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:40:05 volumio volumio[1123]: 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":"Die With A Smile (Live in Las Vegas)","artist":"Lady Gaga & Bruno Mars","album":"Die With A Smile","uri":"https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
May 27 11:40:05 volumio volumio[1123]: verbose: CURRENT POSITION 0
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: No code
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::servicePushState
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:40:05 volumio volumio[1123]: 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":"Die With A Smile (Live in Las Vegas)","artist":"Lady Gaga & Bruno Mars","album":"Die With A Smile","uri":"https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
May 27 11:40:05 volumio volumio[1123]: verbose: CURRENT POSITION 0
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: No code
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: ControllerMpd::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::servicePushState
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: CorePlayQueue::getTrack 0
May 27 11:40:05 volumio volumio[1123]: 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":"Die With A Smile (Live in Las Vegas)","artist":"Lady Gaga & Bruno Mars","album":"Die With A Smile","uri":"https://rr8---sn-5np5po4v-c33sk.googlevideo.com/videoplayback?expire=1748342385&ei=EUI1aNDZMvWO9fwP0NTvuAs&ip=49.237.46.36&id=o-AO2iaY8Ae3dZLm_tRHrPLe2Z8MpQ3wRzgquPs8Gz9kGB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748320785%2C&mh=cW&mm=31%2C26&mn=sn-5np5po4v-c33sk%2Csn-npoldn7y&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&gcr=th&initcwndbps=460000&bui=AY1jyLMLFlRtnzEKrV3qF3tizlztMs1_R_UDYNtxM45ZyWKeCCZlbnB0xf9tPsbSNQDyqi-1Cp9nASuk&spc=l3OVKdFM4r5uZNwDu4tgRufUvf7iaJEyLAuln3wSsoRiTLzFke-Hxj_rUBMZts1ZLXY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=0Wu2KD7GsKWg-1IdOEBYqTMQ&rqh=1&gir=yes&clen=4484234&dur=280.481&lmt=1731962977359552&mt=1748320379&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=smRLl34tByYhJ4B--H-_w8_wxO8UuJdPMjHlvzfownZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgdh66dlpFE4PFPCpzDg-2tk_qeKH-4mJ57lBACPGje7YCICf9ppWDnTmKUAAFdxxUXWICWb2utkh6NouBBar8ZD7s&pot=MniqnMzDn8zB5aqgj4nOeeEi--lJK-XkWjyO1E5R8b3Mn0WYI8RSauaVhPA3Yz6-TtxdWaFkfvlSYh-DVEPBcoAJpf2dw9jsqbqBzPpB4vdWiQmZGwJlHvJWSVH_QTNddIka4s8-GG2JfGLhoBc85OIeESuI6C6AGEY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
May 27 11:40:05 volumio volumio[1123]: verbose: CURRENT POSITION 0
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: No code
May 27 11:40:05 volumio volumio[1123]: info: CoreStateMachine::pushState
May 27 11:40:05 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState
May 27 11:40:05 volumio volumio[1123]: info: ------------------------------ 250ms
May 27 11:40:05 volumio volumio[1123]: info: ------------------------------ 249ms
May 27 11:40:05 volumio volumio[1123]: info: ------------------------------ 225ms
May 27 11:40:05 volumio volumio[1123]: info: ------------------------------ 226ms
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:05 volumio volumio[1123]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
May 27 11:40:06 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
May 27 11:40:06 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
May 27 11:40:06 volumio volumio[1123]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 27 11:40:06 volumio volumio[1123]: Error: getaddrinfo -3007
May 27 11:40:06 volumio volumio[1123]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
May 27 11:40:06 volumio volumio[1123]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
May 27 11:40:06 volumio volumio[1123]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
May 27 11:40:06 volumio volumio[1123]: code: -3007,
May 27 11:40:06 volumio volumio[1123]: errno: -3007,
May 27 11:40:06 volumio volumio[1123]: syscall: 'getaddrinfo'
May 27 11:40:06 volumio volumio[1123]: }
May 27 11:40:06 volumio volumio[1123]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 27 11:40:06 volumio sudo[28537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-27 11:39
May 27 11:40:06 volumio sudo[28537]: 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="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 12:21:23 PM CEST"
VOLUMIO_VERSION="3.807"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="a9588e47e4b05f1a05bf70b4acc7555c"