-- Logs begin at Sun 2025-05-11 08:28:26 MSK, end at Sat 2025-06-28 11:28:40 MSK. --
Jun 28 11:27:02 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:02 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:05 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:05 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:05 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:08 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:08 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:08 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 28 11:27:08 volumio volumio[901]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jun 28 11:27:08 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jun 28 11:27:08 volumio volumio[901]: info: Received Get System Version
Jun 28 11:27:08 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 28 11:27:08 volumio volumio[901]: info: Received Get System Info
Jun 28 11:27:08 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 28 11:27:08 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 28 11:27:08 volumio volumio[901]: info: Discovery: Getting this device information
Jun 28 11:27:08 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Jun 28 11:27:08 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 28 11:27:11 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:11 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:11 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:14 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:14 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:17 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:17 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:17 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:20 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:20 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:23 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:23 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:23 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:26 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:26 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:29 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:29 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:29 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:32 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:32 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:35 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:35 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:35 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:38 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:38 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:40 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:41 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:41 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:44 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:44 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:46 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:47 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:47 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:50 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:50 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:51 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jun 28 11:27:51 volumio volumio[901]: info: CURURI: music-library
Jun 28 11:27:51 volumio volumio[901]: error: Failed LSINFO: null
Jun 28 11:27:51 volumio volumio[901]: info: CoreCommandRouter::volumioGetQueue
Jun 28 11:27:51 volumio volumio[901]: info: CoreStateMachine::getQueue
Jun 28 11:27:51 volumio volumio[901]: info: CorePlayQueue::getQueue
Jun 28 11:27:51 volumio volumio[901]: info: Listing playlists
Jun 28 11:27:51 volumio volumio[901]: info: Preload queue cleared
Jun 28 11:27:52 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:53 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:53 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:53 volumio volumio[901]: info: Preload queue cleared
Jun 28 11:27:56 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:56 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:27:58 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:27:59 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:27:59 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 28 11:28:01 volumio volumio[901]: info: Retrieving Cloud Streaming UI
Jun 28 11:28:01 volumio volumio[901]: info: Getting Tidal Cloud Configuration
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 28 11:28:01 volumio volumio[901]: info: Getting Qobuz Cloud Configuration
Jun 28 11:28:01 volumio volumio[901]: info: Asking plugin for UI Config
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 28 11:28:01 volumio volumio[901]: info: Getting Spotify Cloud Configuration
Jun 28 11:28:01 volumio volumio[901]: info: Asking plugin for UI Config
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 28 11:28:01 volumio volumio[901]: info: Saving Spotify Acccount
Jun 28 11:28:01 volumio volumio[901]: info: Got Tidal Cloud Configuration
Jun 28 11:28:01 volumio volumio[901]: info: Got it
Jun 28 11:28:01 volumio volumio[901]: info: Got it
Jun 28 11:28:01 volumio volumio[901]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 28 11:28:01 volumio volumio[901]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 28 11:28:01 volumio volumio[901]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 28 11:28:02 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:02 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jun 28 11:28:02 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:02 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:04 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:28:05 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:05 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:06 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:08 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:08 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:10 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:10 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:28:11 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:11 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:11 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Jun 28 11:28:11 volumio volumio[901]: info: CorePlayQueue::getTrack 1
Jun 28 11:28:11 volumio volumio[901]: info: Prefetching next song
Jun 28 11:28:12 volumio volumio[901]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-100.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6586c7ae76eec132fff96437fa598e6f7ca1e61bac295b57cbf4b7ac801dad09%2Clid%3D236%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D686dc4da%2F26659%2F5236569%2F353e209b.96755946.13.64457852%2F320.mp3&ext=.mp3"
Jun 28 11:28:12 volumio volumio[901]: info:
Jun 28 11:28:12 volumio volumio[901]: ---------------------------- MPD announces system playlist update
Jun 28 11:28:12 volumio volumio[901]: info: Ignoring MPD Status Update
Jun 28 11:28:12 volumio volumio[901]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-100.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6586c7ae76eec132fff96437fa598e6f7ca1e61bac295b57cbf4b7ac801dad09%2Clid%3D236%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D686dc4da%2F26659%2F5236569%2F353e209b.96755946.13.64457852%2F320.mp3&ext=.mp3" took 2 milliseconds
Jun 28 11:28:12 volumio volumio[901]: verbose: MPD COMMAND [object Object]
Jun 28 11:28:12 volumio volumio[901]: verbose: MPD COMMAND [object Object]
Jun 28 11:28:12 volumio volumio[901]: info:
Jun 28 11:28:12 volumio volumio[901]: ---------------------------- MPD announces system playlist update
Jun 28 11:28:12 volumio volumio[901]: info: Ignoring MPD Status Update
Jun 28 11:28:12 volumio volumio[901]: info:
Jun 28 11:28:12 volumio volumio[901]: ---------------------------- MPD announces system playlist update
Jun 28 11:28:12 volumio volumio[901]: info: Ignoring MPD Status Update
Jun 28 11:28:12 volumio volumio[901]: info: ------------------------------ 4ms
Jun 28 11:28:12 volumio volumio[901]: info: ------------------------------ 2ms
Jun 28 11:28:12 volumio volumio[901]: verbose: ControllerMpd::sendMpdCommand consume 1
Jun 28 11:28:12 volumio volumio[901]: info:
Jun 28 11:28:12 volumio volumio[901]: ---------------------------- MPD announces system playlist update
Jun 28 11:28:12 volumio volumio[901]: info: Ignoring MPD Status Update
Jun 28 11:28:12 volumio volumio[901]: info: ------------------------------ 3ms
Jun 28 11:28:12 volumio volumio[901]: info: sendMpdCommand consume 1 took 2 milliseconds
Jun 28 11:28:12 volumio volumio[901]: info: ------------------------------ 1ms
Jun 28 11:28:12 volumio volumio[901]: info: CoreCommandRouter::volumioAddQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: CoreStateMachine::addQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::addQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: Preload queue cleared
Jun 28 11:28:12 volumio volumio[901]: info: Adding Item to queue: yandex_music/track/1269123:4717003@user:onyourwave
Jun 28 11:28:12 volumio volumio[901]: info: Exploding uri yandex_music/track/1269123:4717003@user:onyourwave in service yandex_music
Jun 28 11:28:12 volumio volumio[901]: info: CoreCommandRouter::volumioAddQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: CoreStateMachine::addQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::addQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: Preload queue cleared
Jun 28 11:28:12 volumio volumio[901]: info: Adding Item to queue: yandex_music/track/121356156:29144636@user:onyourwave
Jun 28 11:28:12 volumio volumio[901]: info: Exploding uri yandex_music/track/121356156:29144636@user:onyourwave in service yandex_music
Jun 28 11:28:12 volumio volumio[901]: info: CoreCommandRouter::volumioAddQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: CoreStateMachine::addQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::addQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: Preload queue cleared
Jun 28 11:28:12 volumio volumio[901]: info: Adding Item to queue: yandex_music/track/102413176:21734801@user:onyourwave
Jun 28 11:28:12 volumio volumio[901]: info: Exploding uri yandex_music/track/102413176:21734801@user:onyourwave in service yandex_music
Jun 28 11:28:12 volumio volumio[901]: info: CoreCommandRouter::volumioAddQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: CoreStateMachine::addQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::addQueueItems
Jun 28 11:28:12 volumio volumio[901]: info: Preload queue cleared
Jun 28 11:28:12 volumio volumio[901]: info: Adding Item to queue: yandex_music/track/139901811:36945234@user:onyourwave
Jun 28 11:28:12 volumio volumio[901]: info: Exploding uri yandex_music/track/139901811:36945234@user:onyourwave in service yandex_music
Jun 28 11:28:12 volumio volumio[901]: info: CoreCommandRouter::volumioPushQueue
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::saveQueue
Jun 28 11:28:12 volumio volumio[901]: info: CoreCommandRouter::volumioPushQueue
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::saveQueue
Jun 28 11:28:12 volumio volumio[901]: info: CoreCommandRouter::volumioPushQueue
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::saveQueue
Jun 28 11:28:12 volumio volumio[901]: info: CoreCommandRouter::volumioPushQueue
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::saveQueue
Jun 28 11:28:12 volumio volumio[901]: info: CoreStateMachine::updateTrackBlock
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::getTrackBlock
Jun 28 11:28:12 volumio volumio[901]: info: CoreStateMachine::updateTrackBlock
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::getTrackBlock
Jun 28 11:28:12 volumio volumio[901]: info: CoreStateMachine::updateTrackBlock
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::getTrackBlock
Jun 28 11:28:12 volumio volumio[901]: info: CoreStateMachine::updateTrackBlock
Jun 28 11:28:12 volumio volumio[901]: info: CorePlayQueue::getTrackBlock
Jun 28 11:28:14 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:14 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:14 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::startPlaybackTimer
Jun 28 11:28:16 volumio volumio[901]: info: CorePlayQueue::getTrack 1
Jun 28 11:28:16 volumio volumio[901]: info:
Jun 28 11:28:16 volumio volumio[901]: ---------------------------- MPD announces system playlist update
Jun 28 11:28:16 volumio volumio[901]: info: Ignoring MPD Status Update
Jun 28 11:28:16 volumio volumio[901]: info:
Jun 28 11:28:16 volumio volumio[901]: ---------------------------- MPD announces state update: player
Jun 28 11:28:16 volumio volumio[901]: info: ControllerMpd::getState
Jun 28 11:28:16 volumio volumio[901]: verbose: ControllerMpd::sendMpdCommand status
Jun 28 11:28:16 volumio volumio[901]: info:
Jun 28 11:28:16 volumio volumio[901]: ---------------------------- MPD announces system playlist update
Jun 28 11:28:16 volumio volumio[901]: info: Ignoring MPD Status Update
Jun 28 11:28:16 volumio volumio[901]: info:
Jun 28 11:28:16 volumio volumio[901]: ---------------------------- MPD announces state update: player
Jun 28 11:28:16 volumio volumio[901]: info: ControllerMpd::getState
Jun 28 11:28:16 volumio volumio[901]: verbose: ControllerMpd::sendMpdCommand status
Jun 28 11:28:16 volumio volumio[901]: info: ------------------------------ 4ms
Jun 28 11:28:16 volumio volumio[901]: info: sendMpdCommand status took 4 milliseconds
Jun 28 11:28:16 volumio volumio[901]: info: ------------------------------ 3ms
Jun 28 11:28:16 volumio volumio[901]: info: sendMpdCommand status took 3 milliseconds
Jun 28 11:28:16 volumio volumio[901]: verbose: ControllerMpd::parseState
Jun 28 11:28:16 volumio volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 28 11:28:16 volumio volumio[901]: verbose: ControllerMpd::parseState
Jun 28 11:28:16 volumio volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 28 11:28:16 volumio volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 28 11:28:16 volumio volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 28 11:28:16 volumio volumio[901]: verbose: ControllerMpd::parseTrackInfo
Jun 28 11:28:16 volumio volumio[901]: verbose: ControllerMpd::parseTrackInfo
Jun 28 11:28:16 volumio volumio[901]: info: ControllerMpd::pushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::servicePushState
Jun 28 11:28:16 volumio volumio[901]: info: CorePlayQueue::getTrack 1
Jun 28 11:28:16 volumio volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":169,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Side of the Light","artist":"Andy Jay Powell","album":"Side of the Light","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-100.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6586c7ae76eec132fff96437fa598e6f7ca1e61bac295b57cbf4b7ac801dad09%2Clid%3D236%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D686dc4da%2F26659%2F5236569%2F353e209b.96755946.13.64457852%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jun 28 11:28:16 volumio volumio[901]: verbose: CURRENT POSITION 1
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::syncState stateService play
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::syncState currentStatus play
Jun 28 11:28:16 volumio volumio[901]: info: Received an update from plugin. extracting info from payload
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::pushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::pushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Jun 28 11:28:16 volumio volumio[901]: info: ControllerMpd::pushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::servicePushState
Jun 28 11:28:16 volumio volumio[901]: info: CorePlayQueue::getTrack 1
Jun 28 11:28:16 volumio volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":169,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Side of the Light","artist":"Andy Jay Powell","album":"Side of the Light","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-100.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6586c7ae76eec132fff96437fa598e6f7ca1e61bac295b57cbf4b7ac801dad09%2Clid%3D236%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D686dc4da%2F26659%2F5236569%2F353e209b.96755946.13.64457852%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jun 28 11:28:16 volumio volumio[901]: verbose: CURRENT POSITION 1
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::syncState stateService play
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::syncState currentStatus play
Jun 28 11:28:16 volumio volumio[901]: info: Received an update from plugin. extracting info from payload
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::pushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::pushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Jun 28 11:28:16 volumio volumio[901]: info: ------------------------------ 28ms
Jun 28 11:28:16 volumio volumio[901]: info: ------------------------------ 27ms
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioGetQueue
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::getQueue
Jun 28 11:28:16 volumio volumio[901]: info: CorePlayQueue::getQueue
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioGetQueue
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::getQueue
Jun 28 11:28:16 volumio volumio[901]: info: CorePlayQueue::getQueue
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioGetQueue
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::getQueue
Jun 28 11:28:16 volumio volumio[901]: info: CorePlayQueue::getQueue
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioGetQueue
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::getQueue
Jun 28 11:28:16 volumio volumio[901]: info: CorePlayQueue::getQueue
Jun 28 11:28:16 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::pushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Jun 28 11:28:16 volumio volumio[901]: info: CoreCommandRouter::volumioGetQueue
Jun 28 11:28:16 volumio volumio[901]: info: CoreStateMachine::getQueue
Jun 28 11:28:16 volumio volumio[901]: info: CorePlayQueue::getQueue
Jun 28 11:28:17 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:17 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:20 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:20 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:22 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:22 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:28:23 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:23 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:26 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:26 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:26 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:28 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:28:29 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:29 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:30 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:32 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:32 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:34 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:34 volumio wpa_supplicant[746]: wlan0: Failed to initiate sched scan
Jun 28 11:28:35 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:35 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:38 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 28 11:28:38 volumio volumio[901]: info: Initializing connection to go-librespot Websocket
Jun 28 11:28:38 volumio volumio[901]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Jun 28 11:28:39 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Jun 28 11:28:39 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Jun 28 11:28:39 volumio volumio[901]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 28 11:28:39 volumio volumio[901]: Error: getaddrinfo -3007
Jun 28 11:28:39 volumio volumio[901]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Jun 28 11:28:39 volumio volumio[901]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Jun 28 11:28:39 volumio volumio[901]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Jun 28 11:28:39 volumio volumio[901]: code: -3007,
Jun 28 11:28:39 volumio volumio[901]: errno: -3007,
Jun 28 11:28:39 volumio volumio[901]: syscall: 'getaddrinfo'
Jun 28 11:28:39 volumio volumio[901]: }
Jun 28 11:28:39 volumio volumio[901]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 28 11:28:40 volumio sudo[11840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-28 11:27
Jun 28 11:28:40 volumio sudo[11840]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="f8baf7ad070f376535a93fcc6590774528ddb153"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET"
VOLUMIO_VERSION="3.611"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"