-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Thu 2025-05-22 15:50:28 MSK. --
May 22 15:49:04 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 15:49:04 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 15:49:04 volumio volumio[826]: info: Discovery: Getting this device information
May 22 15:49:04 volumio volumio[826]: info: CoreCommandRouter::volumioGetState
May 22 15:49:04 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 15:49:04 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 15:49:04 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 15:49:04 volumio volumio[826]: info: Discovery: Getting this device information
May 22 15:49:04 volumio volumio[826]: info: CoreCommandRouter::volumioGetState
May 22 15:49:04 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 15:49:13 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 22 15:49:13 volumio volumio[826]: info: CorePlayQueue::getTrack 10
May 22 15:49:13 volumio volumio[826]: info: Prefetching next song
May 22 15:49:13 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-170.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D04cb60a179f5bfad5eff345acd29de656e93dd01af53b71027a4375f5f12506d%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D683c5c34%2F0%2F1767417%2F1561921e.197751768.21.127084%2F320.mp3&ext=.mp3"
May 22 15:49:13 volumio volumio[826]: info:
May 22 15:49:13 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:49:13 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:49:13 volumio volumio[826]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-170.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D04cb60a179f5bfad5eff345acd29de656e93dd01af53b71027a4375f5f12506d%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D683c5c34%2F0%2F1767417%2F1561921e.197751768.21.127084%2F320.mp3&ext=.mp3" took 3 milliseconds
May 22 15:49:13 volumio volumio[826]: verbose: MPD COMMAND [object Object]
May 22 15:49:13 volumio volumio[826]: verbose: MPD COMMAND [object Object]
May 22 15:49:13 volumio volumio[826]: verbose: MPD COMMAND [object Object]
May 22 15:49:13 volumio volumio[826]: info:
May 22 15:49:13 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:49:13 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:49:13 volumio volumio[826]: info:
May 22 15:49:13 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:49:13 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:49:13 volumio volumio[826]: info: ------------------------------ 4ms
May 22 15:49:13 volumio volumio[826]: info: ------------------------------ 2ms
May 22 15:49:13 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand consume 1
May 22 15:49:13 volumio volumio[826]: info:
May 22 15:49:13 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:49:13 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:49:13 volumio volumio[826]: info: ------------------------------ 4ms
May 22 15:49:13 volumio volumio[826]: info: sendMpdCommand consume 1 took 3 milliseconds
May 22 15:49:13 volumio volumio[826]: info: ------------------------------ 2ms
May 22 15:49:14 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 22 15:49:14 volumio volumio[826]: info: Received Get System Info
May 22 15:49:14 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 15:49:14 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 15:49:14 volumio volumio[826]: info: Discovery: Getting this device information
May 22 15:49:14 volumio volumio[826]: info: CoreCommandRouter::volumioGetState
May 22 15:49:14 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 15:49:17 volumio volumio[826]: verbose: New Socket.io Connection to 192.168.68.183:3000 from 192.168.68.139 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10
May 22 15:49:17 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 15:49:17 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 15:49:17 volumio volumio[826]: info: Discovery: Getting this device information
May 22 15:49:17 volumio volumio[826]: info: CoreCommandRouter::volumioGetState
May 22 15:49:17 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 15:49:17 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 22 15:49:17 volumio volumio[826]: info: CorePlayQueue::getTrack 10
May 22 15:49:18 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:49:18 volumio volumio[826]: info: CorePlayQueue::getTrack 10
May 22 15:49:18 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 15:49:18 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:49:18 volumio volumio[826]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
May 22 15:49:28 volumio go-librespot[19221]: time="2025-05-22T15:49:28+03:00" level=trace msg="received accesspoint ping"
May 22 15:49:28 volumio go-librespot[19221]: time="2025-05-22T15:49:28+03:00" level=trace msg="received accesspoint pong ack"
May 22 15:49:28 volumio go-librespot[19221]: time="2025-05-22T15:49:28+03:00" level=trace msg="sent dealer ping"
May 22 15:49:28 volumio go-librespot[19221]: time="2025-05-22T15:49:28+03:00" level=trace msg="received dealer pong"
May 22 15:49:43 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 15:49:43 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 15:49:43 volumio volumio[826]: info: Discovery: Getting this device information
May 22 15:49:43 volumio volumio[826]: info: CoreCommandRouter::volumioGetState
May 22 15:49:43 volumio volumio[826]: info: CorePlayQueue::getTrack 10
May 22 15:49:43 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 15:49:58 volumio go-librespot[19221]: time="2025-05-22T15:49:58+03:00" level=trace msg="sent dealer ping"
May 22 15:49:58 volumio go-librespot[19221]: time="2025-05-22T15:49:58+03:00" level=trace msg="received dealer pong"
May 22 15:50:13 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 15:50:13 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 15:50:13 volumio volumio[826]: info: Discovery: Getting this device information
May 22 15:50:13 volumio volumio[826]: info: CoreCommandRouter::volumioGetState
May 22 15:50:13 volumio volumio[826]: info: CorePlayQueue::getTrack 10
May 22 15:50:13 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 15:50:16 volumio volumio[826]: info: CoreCommandRouter::volumioNext
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::next
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::stop
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::stPlaybackTimer
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrack 10
May 22 15:50:16 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 15:50:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::serviceStop
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrack 10
May 22 15:50:16 volumio volumio[826]: info: CoreCommandRouter::serviceStop
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService mpd
May 22 15:50:16 volumio volumio[826]: info: ControllerMpd::stop
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 22 15:50:16 volumio volumio[826]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
May 22 15:50:16 volumio volumio[826]: info:
May 22 15:50:16 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 22 15:50:16 volumio volumio[826]: info: sendMpdCommand stop took 12 milliseconds
May 22 15:50:16 volumio volumio[826]: info: ControllerMpd::getState
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::play index undefined
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 22 15:50:16 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 22 15:50:16 volumio volumio[826]: info: sendMpdCommand stop took 1 milliseconds
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::parseState
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand clear
May 22 15:50:16 volumio volumio[826]: info:
May 22 15:50:16 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 22 15:50:16 volumio volumio[826]: info: ControllerMpd::getState
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 22 15:50:16 volumio volumio[826]: info:
May 22 15:50:16 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:50:16 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:50:16 volumio volumio[826]: info: sendMpdCommand playlistinfo took 29 milliseconds
May 22 15:50:16 volumio volumio[826]: info: sendMpdCommand clear took 29 milliseconds
May 22 15:50:16 volumio volumio[826]: info: sendMpdCommand status took 27 milliseconds
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::parseState
May 22 15:50:16 volumio volumio[826]: info: ControllerMpd::pushState
May 22 15:50:16 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:16 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 15:50:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:16 volumio volumio[826]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd
May 22 15:50:16 volumio volumio[826]: info: ControllerMpd::pushState
May 22 15:50:16 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:50:16 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:16 volumio volumio[826]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd
May 22 15:50:16 volumio volumio[826]: info: ------------------------------ 47ms
May 22 15:50:16 volumio volumio[826]: info: ------------------------------ 41ms
May 22 15:50:16 volumio volumio[826]: info:
May 22 15:50:16 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:50:16 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:50:16 volumio volumio[826]: error: updateQueue error: null
May 22 15:50:16 volumio volumio[826]: info: ------------------------------ 23ms
May 22 15:50:16 volumio volumio[826]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
May 22 15:50:16 volumio volumio[826]: info: touch_display: Setting screensaver timeout to 3600 seconds.
May 22 15:50:16 volumio volumio[826]: error: updateQueue error: null
May 22 15:50:16 volumio volumio[826]: info: ------------------------------ 24ms
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-123.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3b543f7684c40e27588ed3e023dccd1ba6307aeea880668b17abd2470fabd515%2Clid%3D1520%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D683d306f%2F0%2F939901%2F145b8218.59872714.9.2381061%2F320.mp3&ext=.mp3"
May 22 15:50:16 volumio volumio[826]: info:
May 22 15:50:16 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:50:16 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:50:16 volumio volumio[826]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-123.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3b543f7684c40e27588ed3e023dccd1ba6307aeea880668b17abd2470fabd515%2Clid%3D1520%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D683d306f%2F0%2F939901%2F145b8218.59872714.9.2381061%2F320.mp3&ext=.mp3" took 1 milliseconds
May 22 15:50:16 volumio volumio[826]: verbose: MPD COMMAND [object Object]
May 22 15:50:16 volumio volumio[826]: verbose: MPD COMMAND [object Object]
May 22 15:50:16 volumio volumio[826]: verbose: MPD COMMAND [object Object]
May 22 15:50:16 volumio volumio[826]: info:
May 22 15:50:16 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:50:16 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:50:16 volumio volumio[826]: info:
May 22 15:50:16 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:50:16 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:50:16 volumio volumio[826]: info: ------------------------------ 3ms
May 22 15:50:16 volumio volumio[826]: info: ------------------------------ 2ms
May 22 15:50:16 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService mpd
May 22 15:50:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand play
May 22 15:50:16 volumio volumio[826]: info:
May 22 15:50:16 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 22 15:50:16 volumio volumio[826]: info: Ignoring MPD Status Update
May 22 15:50:16 volumio volumio[826]: info: ------------------------------ 3ms
May 22 15:50:16 volumio volumio[826]: info: sendMpdCommand play took 2 milliseconds
May 22 15:50:16 volumio volumio[826]: info: ------------------------------ 1ms
May 22 15:50:17 volumio volumio[826]: info:
May 22 15:50:17 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 22 15:50:17 volumio volumio[826]: info: ControllerMpd::getState
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 22 15:50:17 volumio volumio[826]: info:
May 22 15:50:17 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 22 15:50:17 volumio volumio[826]: info: ControllerMpd::getState
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 22 15:50:17 volumio volumio[826]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 22 15:50:17 volumio volumio[826]: info: FusionDsp - ---- read samplerate from file: 44100
May 22 15:50:17 volumio volumio[826]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 22 15:50:17 volumio volumio[826]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 22 15:50:17 volumio volumio[826]: info: FusionDsp - ---- read samplerate from file: 44100
May 22 15:50:17 volumio volumio[826]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 22 15:50:17 volumio volumio[826]: info:
May 22 15:50:17 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 22 15:50:17 volumio volumio[826]: info: sendMpdCommand status took 22 milliseconds
May 22 15:50:17 volumio volumio[826]: info: sendMpdCommand status took 22 milliseconds
May 22 15:50:17 volumio volumio[826]: info: ControllerMpd::getState
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::parseState
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::parseState
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 22 15:50:17 volumio volumio[826]: info:
May 22 15:50:17 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 22 15:50:17 volumio volumio[826]: info: ControllerMpd::getState
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 22 15:50:17 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 22 15:50:17 volumio volumio[826]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 22 15:50:17 volumio volumio[826]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 22 15:50:17 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::parseState
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::parseState
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 22 15:50:17 volumio volumio[826]: info: ControllerMpd::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:17 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":239,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Kisses And Tears (My One And Only)","artist":"Bad Boys Blue","album":"Super 20","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-123.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3b543f7684c40e27588ed3e023dccd1ba6307aeea880668b17abd2470fabd515%2Clid%3D1520%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D683d306f%2F0%2F939901%2F145b8218.59872714.9.2381061%2F320.mp3&ext=.mp3","trackType":"mp3"}
May 22 15:50:17 volumio volumio[826]: verbose: CURRENT POSITION 11
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 22 15:50:17 volumio volumio[826]: info: ControllerMpd::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:17 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":239,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Kisses And Tears (My One And Only)","artist":"Bad Boys Blue","album":"Super 20","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-123.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3b543f7684c40e27588ed3e023dccd1ba6307aeea880668b17abd2470fabd515%2Clid%3D1520%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D683d306f%2F0%2F939901%2F145b8218.59872714.9.2381061%2F320.mp3&ext=.mp3","trackType":"mp3"}
May 22 15:50:17 volumio volumio[826]: verbose: CURRENT POSITION 11
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 22 15:50:17 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:50:17 volumio volumio[826]: info: ------------------------------ 36ms
May 22 15:50:17 volumio volumio[826]: info: ------------------------------ 39ms
May 22 15:50:17 volumio volumio[826]: info: sendMpdCommand playlistinfo took 16 milliseconds
May 22 15:50:17 volumio volumio[826]: info: sendMpdCommand playlistinfo took 15 milliseconds
May 22 15:50:17 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 22 15:50:17 volumio volumio[826]: info: ControllerMpd::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:17 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1512,"duration":239,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Kisses And Tears (My One And Only)","artist":"Bad Boys Blue","album":"Super 20","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-123.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3b543f7684c40e27588ed3e023dccd1ba6307aeea880668b17abd2470fabd515%2Clid%3D1520%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D683d306f%2F0%2F939901%2F145b8218.59872714.9.2381061%2F320.mp3&ext=.mp3","trackType":"mp3"}
May 22 15:50:17 volumio volumio[826]: verbose: CURRENT POSITION 11
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 22 15:50:17 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:50:17 volumio volumio[826]: info: ControllerMpd::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getTrack 11
May 22 15:50:17 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1512,"duration":239,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Kisses And Tears (My One And Only)","artist":"Bad Boys Blue","album":"Super 20","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-123.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3b543f7684c40e27588ed3e023dccd1ba6307aeea880668b17abd2470fabd515%2Clid%3D1520%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D683d306f%2F0%2F939901%2F145b8218.59872714.9.2381061%2F320.mp3&ext=.mp3","trackType":"mp3"}
May 22 15:50:17 volumio volumio[826]: verbose: CURRENT POSITION 11
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 22 15:50:17 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::pushState
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 22 15:50:17 volumio volumio[826]: info: ------------------------------ 76ms
May 22 15:50:17 volumio volumio[826]: info: ------------------------------ 73ms
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioGetQueue
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::getQueue
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getQueue
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioGetQueue
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::getQueue
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getQueue
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioGetQueue
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::getQueue
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getQueue
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioGetQueue
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::getQueue
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getQueue
May 22 15:50:17 volumio volumio[826]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
May 22 15:50:17 volumio volumio[826]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
May 22 15:50:17 volumio volumio[826]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
May 22 15:50:17 volumio volumio[826]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
May 22 15:50:17 volumio volumio[826]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
May 22 15:50:17 volumio volumio[826]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 22 15:50:17 volumio volumio[826]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioGetQueue
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::getQueue
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getQueue
May 22 15:50:17 volumio volumio[826]: info: CoreCommandRouter::volumioGetQueue
May 22 15:50:17 volumio volumio[826]: info: CoreStateMachine::getQueue
May 22 15:50:17 volumio volumio[826]: info: CorePlayQueue::getQueue
May 22 15:50:17 volumio volumio[826]: info: touch_display: Setting screensaver timeout to 0 seconds.
May 22 15:50:28 volumio volumio[826]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 22 15:50:28 volumio volumio[826]: Error: read ECONNRESET
May 22 15:50:28 volumio volumio[826]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) {
May 22 15:50:28 volumio volumio[826]: errno: -104,
May 22 15:50:28 volumio volumio[826]: code: 'ECONNRESET',
May 22 15:50:28 volumio volumio[826]: syscall: 'read'
May 22 15:50:28 volumio volumio[826]: }
May 22 15:50:28 volumio volumio[826]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 22 15:50:28 volumio go-librespot[19221]: time="2025-05-22T15:50:28+03:00" level=trace msg="sent dealer ping"
May 22 15:50:28 volumio go-librespot[19221]: time="2025-05-22T15:50:28+03:00" level=trace msg="received dealer pong"
May 22 15:50:28 volumio sudo[15147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-22 15:49
May 22 15:50:28 volumio sudo[15147]: 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="f6610a1100d2380eef33bd3004af43153c786f96"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET"
VOLUMIO_VERSION="3.785"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"