-- Logs begin at Sat 2025-01-11 13:51:09 MSK, end at Sat 2025-01-11 14:26:17 MSK. --
Jan 11 14:25:32 volumio sudo[1564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 11 14:25:32 volumio sudo[1564]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 11 14:25:32 volumio sudo[1564]: pam_unix(sudo:session): session closed for user root
Jan 11 14:25:32 volumio sudo[1567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 11 14:25:32 volumio sudo[1567]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 11 14:25:32 volumio sudo[1567]: pam_unix(sudo:session): session closed for user root
Jan 11 14:25:32 volumio volumio[988]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jan 11 14:25:32 volumio volumio[988]: info: CoreCommandRouter::volumioGetState
Jan 11 14:25:32 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 11 14:25:32 volumio volumio[988]: info: Listing playlists
Jan 11 14:25:32 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 11 14:25:32 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jan 11 14:25:32 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jan 11 14:25:32 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 11 14:25:34 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 11 14:25:34 volumio volumio[988]: info: Received Get System Info
Jan 11 14:25:34 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 11 14:25:34 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 11 14:25:34 volumio volumio[988]: info: Discovery: Getting this device information
Jan 11 14:25:34 volumio volumio[988]: info: CoreCommandRouter::volumioGetState
Jan 11 14:25:34 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 11 14:25:36 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 11 14:25:36 volumio volumio[988]: info: Received Get System Info
Jan 11 14:25:36 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 11 14:25:36 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 11 14:25:36 volumio volumio[988]: info: Discovery: Getting this device information
Jan 11 14:25:36 volumio volumio[988]: info: CoreCommandRouter::volumioGetState
Jan 11 14:25:36 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 11 14:25:39 volumio volumio[988]: info: CoreCommandRouter::volumioNext
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::next
Jan 11 14:25:39 volumio volumio[988]: info: ControllerMpd::next
Jan 11 14:25:39 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand next
Jan 11 14:25:39 volumio volumio[988]: info:
Jan 11 14:25:39 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:25:39 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:25:39 volumio volumio[988]: info:
Jan 11 14:25:39 volumio volumio[988]: ---------------------------- MPD announces state update: player
Jan 11 14:25:39 volumio volumio[988]: info: sendMpdCommand next took 4 milliseconds
Jan 11 14:25:39 volumio volumio[988]: info: ControllerMpd::getState
Jan 11 14:25:39 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 14:25:39 volumio volumio[988]: error: updateQueue error: null
Jan 11 14:25:39 volumio volumio[988]: info: ------------------------------ 1ms
Jan 11 14:25:39 volumio volumio[988]: info: sendMpdCommand status took 0 milliseconds
Jan 11 14:25:39 volumio volumio[988]: verbose: ControllerMpd::parseState
Jan 11 14:25:39 volumio volumio[988]: info: ControllerMpd::pushState
Jan 11 14:25:39 volumio volumio[988]: info: CoreCommandRouter::servicePushState
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:25:39 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 14:25:39 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:25:39 volumio volumio[988]: info: CorePlayQueue::getTrack 135
Jan 11 14:25:39 volumio volumio[988]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 11 14:25:39 volumio volumio[988]: verbose: CURRENT POSITION 135
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::syncState stateService stop
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::syncState currentStatus play
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::play index undefined
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:25:39 volumio volumio[988]: info: CorePlayQueue::getTrack 136
Jan 11 14:25:39 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 14:25:39 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:25:39 volumio volumio[988]: info: CorePlayQueue::getTrack 136
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::startPlaybackTimer
Jan 11 14:25:39 volumio volumio[988]: info: CorePlayQueue::getTrack 136
Jan 11 14:25:39 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 14:25:39 volumio volumio[988]: info: ------------------------------ 12ms
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:25:39 volumio volumio[988]: info: CorePlayQueue::getTrack 136
Jan 11 14:25:39 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 14:25:39 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:25:39 volumio volumio[988]: info: sendMpdCommand stop took 5 milliseconds
Jan 11 14:25:39 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand clear
Jan 11 14:25:39 volumio volumio[988]: info: CoreCommandRouter::volumioGetQueue
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::getQueue
Jan 11 14:25:39 volumio volumio[988]: info: CorePlayQueue::getQueue
Jan 11 14:25:39 volumio volumio[988]: info:
Jan 11 14:25:39 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:25:39 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:25:39 volumio volumio[988]: info: sendMpdCommand clear took 7 milliseconds
Jan 11 14:25:39 volumio volumio[988]: error: updateQueue error: null
Jan 11 14:25:39 volumio volumio[988]: info: ------------------------------ 5ms
Jan 11 14:25:39 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-10.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D916182c1620b209213917905d97afc2934cb977d749af84ebf6df3642421e8b9%2Clid%3D1519%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67906d1d%2F0%2F13262272%2Face30538.104609818.12.6686004%2Fflac&ext=.flac"
Jan 11 14:25:39 volumio volumio[988]: info:
Jan 11 14:25:39 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:25:39 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:25:39 volumio volumio[988]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-10.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D916182c1620b209213917905d97afc2934cb977d749af84ebf6df3642421e8b9%2Clid%3D1519%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67906d1d%2F0%2F13262272%2Face30538.104609818.12.6686004%2Fflac&ext=.flac" took 2 milliseconds
Jan 11 14:25:39 volumio volumio[988]: verbose: MPD COMMAND [object Object]
Jan 11 14:25:39 volumio volumio[988]: verbose: MPD COMMAND [object Object]
Jan 11 14:25:39 volumio volumio[988]: info:
Jan 11 14:25:39 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:25:39 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:25:39 volumio volumio[988]: info: ------------------------------ 1ms
Jan 11 14:25:39 volumio volumio[988]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 11 14:25:39 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand play
Jan 11 14:25:39 volumio volumio[988]: info: ------------------------------ 1ms
Jan 11 14:25:39 volumio volumio[988]: info: sendMpdCommand play took 1 milliseconds
Jan 11 14:25:39 volumio volumio[988]: info: camilladsp spawned new process with pid 1602, instance 1, run: true
Jan 11 14:25:42 volumio volumio[988]: info:
Jan 11 14:25:42 volumio volumio[988]: ---------------------------- MPD announces state update: player
Jan 11 14:25:42 volumio volumio[988]: info: ControllerMpd::getState
Jan 11 14:25:42 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 14:25:42 volumio volumio[988]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jan 11 14:25:42 volumio volumio[988]: info: FusionDsp - ---- read samplerate from file: 44100
Jan 11 14:25:42 volumio volumio[988]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jan 11 14:25:42 volumio volumio[988]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jan 11 14:25:42 volumio volumio[988]: info: FusionDsp - ---- read samplerate from file: 44100
Jan 11 14:25:42 volumio volumio[988]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jan 11 14:25:42 volumio volumio[988]: info:
Jan 11 14:25:42 volumio volumio[988]: ---------------------------- MPD announces state update: player
Jan 11 14:25:42 volumio volumio[988]: info: sendMpdCommand status took 20 milliseconds
Jan 11 14:25:42 volumio volumio[988]: info: ControllerMpd::getState
Jan 11 14:25:42 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 14:25:42 volumio volumio[988]: verbose: ControllerMpd::parseState
Jan 11 14:25:42 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 14:25:42 volumio volumio[988]: info: sendMpdCommand status took 1 milliseconds
Jan 11 14:25:42 volumio volumio[988]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 14:25:42 volumio volumio[988]: verbose: ControllerMpd::parseState
Jan 11 14:25:42 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 14:25:42 volumio volumio[988]: verbose: ControllerMpd::parseTrackInfo
Jan 11 14:25:42 volumio volumio[988]: info: ControllerMpd::pushState
Jan 11 14:25:42 volumio volumio[988]: info: CoreCommandRouter::servicePushState
Jan 11 14:25:42 volumio volumio[988]: info: CorePlayQueue::getTrack 136
Jan 11 14:25:42 volumio volumio[988]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"If You Wanna Know","artist":"Ugly Duckling","album":"Journey to Anywhere","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-10.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D916182c1620b209213917905d97afc2934cb977d749af84ebf6df3642421e8b9%2Clid%3D1519%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67906d1d%2F0%2F13262272%2Face30538.104609818.12.6686004%2Fflac&ext=.flac","trackType":"flac"}
Jan 11 14:25:42 volumio volumio[988]: verbose: CURRENT POSITION 136
Jan 11 14:25:42 volumio volumio[988]: info: CoreStateMachine::syncState stateService play
Jan 11 14:25:42 volumio volumio[988]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 14:25:42 volumio volumio[988]: info: ------------------------------ 24ms
Jan 11 14:25:42 volumio volumio[988]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 11 14:25:42 volumio volumio[988]: verbose: ControllerMpd::parseTrackInfo
Jan 11 14:25:42 volumio volumio[988]: info: ControllerMpd::pushState
Jan 11 14:25:42 volumio volumio[988]: info: CoreCommandRouter::servicePushState
Jan 11 14:25:42 volumio volumio[988]: info: CorePlayQueue::getTrack 136
Jan 11 14:25:42 volumio volumio[988]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"If You Wanna Know","artist":"Ugly Duckling","album":"Journey to Anywhere","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-10.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D916182c1620b209213917905d97afc2934cb977d749af84ebf6df3642421e8b9%2Clid%3D1519%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67906d1d%2F0%2F13262272%2Face30538.104609818.12.6686004%2Fflac&ext=.flac","trackType":"flac"}
Jan 11 14:25:42 volumio volumio[988]: verbose: CURRENT POSITION 136
Jan 11 14:25:42 volumio volumio[988]: info: CoreStateMachine::syncState stateService play
Jan 11 14:25:42 volumio volumio[988]: info: CoreStateMachine::syncState currentStatus play
Jan 11 14:25:42 volumio volumio[988]: info: Received an update from plugin. extracting info from payload
Jan 11 14:25:42 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:25:42 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 14:25:42 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:25:42 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:25:42 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:25:42 volumio volumio[988]: info: ------------------------------ 21ms
Jan 11 14:25:42 volumio volumio[988]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Jan 11 14:25:42 volumio volumio[988]: info: CoreCommandRouter::volumioGetQueue
Jan 11 14:25:42 volumio volumio[988]: info: CoreStateMachine::getQueue
Jan 11 14:25:42 volumio volumio[988]: info: CorePlayQueue::getQueue
Jan 11 14:25:42 volumio volumio[988]: info: CoreCommandRouter::volumioGetQueue
Jan 11 14:25:42 volumio volumio[988]: info: CoreStateMachine::getQueue
Jan 11 14:25:42 volumio volumio[988]: info: CorePlayQueue::getQueue
Jan 11 14:25:42 volumio volumio[988]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Jan 11 14:25:51 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 11 14:25:51 volumio volumio[988]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jan 11 14:25:51 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jan 11 14:25:51 volumio volumio[988]: info: Received Get System Version
Jan 11 14:25:51 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 11 14:25:51 volumio volumio[988]: info: Received Get System Info
Jan 11 14:25:51 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 11 14:25:51 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 11 14:25:51 volumio volumio[988]: info: Discovery: Getting this device information
Jan 11 14:25:51 volumio volumio[988]: info: CoreCommandRouter::volumioGetState
Jan 11 14:25:51 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 11 14:26:05 volumio volumio[988]: info: CoreCommandRouter::volumioNext
Jan 11 14:26:05 volumio volumio[988]: info: CoreStateMachine::next
Jan 11 14:26:05 volumio volumio[988]: info: ControllerMpd::next
Jan 11 14:26:05 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand next
Jan 11 14:26:05 volumio volumio[988]: info:
Jan 11 14:26:05 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:26:05 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:26:05 volumio volumio[988]: info:
Jan 11 14:26:05 volumio volumio[988]: ---------------------------- MPD announces state update: player
Jan 11 14:26:05 volumio volumio[988]: info: sendMpdCommand next took 2 milliseconds
Jan 11 14:26:05 volumio volumio[988]: info: ControllerMpd::getState
Jan 11 14:26:05 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 14:26:05 volumio volumio[988]: error: updateQueue error: null
Jan 11 14:26:05 volumio volumio[988]: info: ------------------------------ 2ms
Jan 11 14:26:05 volumio volumio[988]: info: sendMpdCommand status took 1 milliseconds
Jan 11 14:26:05 volumio volumio[988]: verbose: ControllerMpd::parseState
Jan 11 14:26:05 volumio volumio[988]: info: ControllerMpd::pushState
Jan 11 14:26:05 volumio volumio[988]: info: CoreCommandRouter::servicePushState
Jan 11 14:26:05 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:26:05 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 14:26:05 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:26:05 volumio volumio[988]: info: CorePlayQueue::getTrack 136
Jan 11 14:26:05 volumio volumio[988]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 11 14:26:05 volumio volumio[988]: verbose: CURRENT POSITION 136
Jan 11 14:26:05 volumio volumio[988]: info: CoreStateMachine::syncState stateService stop
Jan 11 14:26:05 volumio volumio[988]: info: CoreStateMachine::syncState currentStatus play
Jan 11 14:26:05 volumio volumio[988]: info: CoreStateMachine::play index undefined
Jan 11 14:26:05 volumio volumio[988]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 14:26:05 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:26:05 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:05 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 14:26:05 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:26:05 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:05 volumio volumio[988]: info: CoreStateMachine::startPlaybackTimer
Jan 11 14:26:05 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:05 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 14:26:05 volumio volumio[988]: info: ------------------------------ 7ms
Jan 11 14:26:05 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:26:05 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:05 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 14:26:05 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:26:05 volumio volumio[988]: info: sendMpdCommand stop took 3 milliseconds
Jan 11 14:26:05 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand clear
Jan 11 14:26:05 volumio volumio[988]: info:
Jan 11 14:26:05 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:26:05 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:26:05 volumio volumio[988]: info: sendMpdCommand clear took 0 milliseconds
Jan 11 14:26:05 volumio volumio[988]: error: updateQueue error: null
Jan 11 14:26:05 volumio volumio[988]: info: ------------------------------ 4ms
Jan 11 14:26:06 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-21.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D89357004d6b9520ddfdbe4824e177bf05cd157f19b5e31909fb3cfec3593fe72%2Clid%3D1536%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D678ff79e%2F42459%2F53660%2F143ec2d5.117972416.5.77684881%2F320.mp3&ext=.mp3"
Jan 11 14:26:06 volumio volumio[988]: info:
Jan 11 14:26:06 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:26:06 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:26:06 volumio volumio[988]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-21.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D89357004d6b9520ddfdbe4824e177bf05cd157f19b5e31909fb3cfec3593fe72%2Clid%3D1536%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D678ff79e%2F42459%2F53660%2F143ec2d5.117972416.5.77684881%2F320.mp3&ext=.mp3" took 1 milliseconds
Jan 11 14:26:06 volumio volumio[988]: verbose: MPD COMMAND [object Object]
Jan 11 14:26:06 volumio volumio[988]: verbose: MPD COMMAND [object Object]
Jan 11 14:26:06 volumio volumio[988]: info:
Jan 11 14:26:06 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:26:06 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:26:06 volumio volumio[988]: info: ------------------------------ 2ms
Jan 11 14:26:06 volumio volumio[988]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 11 14:26:06 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand play
Jan 11 14:26:06 volumio volumio[988]: info: ------------------------------ 1ms
Jan 11 14:26:06 volumio volumio[988]: info: sendMpdCommand play took 2 milliseconds
Jan 11 14:26:06 volumio volumio[988]: info: camilladsp spawned new process with pid 1700, instance 1, run: true
Jan 11 14:26:14 volumio volumio[988]: info: CoreCommandRouter::volumioGetQueue
Jan 11 14:26:14 volumio volumio[988]: info: CoreStateMachine::getQueue
Jan 11 14:26:14 volumio volumio[988]: info: CorePlayQueue::getQueue
Jan 11 14:26:14 volumio nmbd[755]: [2025/01/11 14:26:14.497814, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jan 11 14:26:14 volumio nmbd[755]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.109 for name WORKGROUP<1d>.
Jan 11 14:26:14 volumio nmbd[755]: This response was from IP 192.168.1.82, reporting an IP address of 192.168.1.82.
Jan 11 14:26:14 volumio volumio[988]: info: CoreCommandRouter::volumioPlay
Jan 11 14:26:14 volumio volumio[988]: info: CoreStateMachine::play index undefined
Jan 11 14:26:14 volumio volumio[988]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 14:26:14 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:14 volumio volumio[988]: info: CoreStateMachine::startPlaybackTimer
Jan 11 14:26:14 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:14 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 14:26:14 volumio volumio[988]: info: sendMpdCommand stop took 1 milliseconds
Jan 11 14:26:14 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand clear
Jan 11 14:26:14 volumio volumio[988]: info:
Jan 11 14:26:14 volumio volumio[988]: ---------------------------- MPD announces state update: player
Jan 11 14:26:14 volumio volumio[988]: info:
Jan 11 14:26:14 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:26:14 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:26:14 volumio volumio[988]: info: ControllerMpd::getState
Jan 11 14:26:14 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 14:26:14 volumio volumio[988]: info: sendMpdCommand clear took 1 milliseconds
Jan 11 14:26:14 volumio volumio[988]: error: updateQueue error: null
Jan 11 14:26:14 volumio volumio[988]: info: sendMpdCommand status took 5 milliseconds
Jan 11 14:26:14 volumio volumio[988]: info: ------------------------------ 5ms
Jan 11 14:26:14 volumio volumio[988]: verbose: ControllerMpd::parseState
Jan 11 14:26:14 volumio volumio[988]: info: ControllerMpd::pushState
Jan 11 14:26:14 volumio volumio[988]: info: CoreCommandRouter::servicePushState
Jan 11 14:26:14 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:26:14 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:14 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 14:26:14 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:26:14 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:14 volumio volumio[988]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd
Jan 11 14:26:14 volumio volumio[988]: info: ------------------------------ 8ms
Jan 11 14:26:14 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-97.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dd71c3a6740ef9a77d205d926068bdeaeeb6dbb0ef4bd76640e43f7aca784368c%2Clid%3D1519%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D678ff79e%2F42459%2F53660%2F143ec2d5.117972416.5.77684881%2F320.mp3&ext=.mp3"
Jan 11 14:26:14 volumio volumio[988]: info:
Jan 11 14:26:14 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:26:14 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:26:14 volumio volumio[988]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-97.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dd71c3a6740ef9a77d205d926068bdeaeeb6dbb0ef4bd76640e43f7aca784368c%2Clid%3D1519%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D678ff79e%2F42459%2F53660%2F143ec2d5.117972416.5.77684881%2F320.mp3&ext=.mp3" took 2 milliseconds
Jan 11 14:26:14 volumio volumio[988]: verbose: MPD COMMAND [object Object]
Jan 11 14:26:14 volumio volumio[988]: verbose: MPD COMMAND [object Object]
Jan 11 14:26:14 volumio volumio[988]: info:
Jan 11 14:26:14 volumio volumio[988]: ---------------------------- MPD announces system playlist update
Jan 11 14:26:14 volumio volumio[988]: info: Ignoring MPD Status Update
Jan 11 14:26:14 volumio volumio[988]: info: ------------------------------ 2ms
Jan 11 14:26:14 volumio volumio[988]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 11 14:26:14 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand play
Jan 11 14:26:14 volumio volumio[988]: info: ------------------------------ 1ms
Jan 11 14:26:14 volumio volumio[988]: info: sendMpdCommand play took 1 milliseconds
Jan 11 14:26:16 volumio volumio[988]: info:
Jan 11 14:26:16 volumio volumio[988]: ---------------------------- MPD announces state update: player
Jan 11 14:26:16 volumio volumio[988]: info: ControllerMpd::getState
Jan 11 14:26:16 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 14:26:16 volumio volumio[988]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jan 11 14:26:16 volumio volumio[988]: info: FusionDsp - ---- read samplerate from file: 44100
Jan 11 14:26:16 volumio volumio[988]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jan 11 14:26:16 volumio volumio[988]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jan 11 14:26:16 volumio volumio[988]: info: FusionDsp - ---- read samplerate from file: 44100
Jan 11 14:26:16 volumio volumio[988]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jan 11 14:26:16 volumio volumio[988]: info:
Jan 11 14:26:16 volumio volumio[988]: ---------------------------- MPD announces state update: player
Jan 11 14:26:16 volumio volumio[988]: info: sendMpdCommand status took 16 milliseconds
Jan 11 14:26:16 volumio volumio[988]: info: ControllerMpd::getState
Jan 11 14:26:16 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 14:26:16 volumio volumio[988]: verbose: ControllerMpd::parseState
Jan 11 14:26:16 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 14:26:16 volumio volumio[988]: info: sendMpdCommand status took 3 milliseconds
Jan 11 14:26:16 volumio volumio[988]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 11 14:26:16 volumio volumio[988]: verbose: ControllerMpd::parseState
Jan 11 14:26:16 volumio volumio[988]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 14:26:16 volumio volumio[988]: verbose: ControllerMpd::parseTrackInfo
Jan 11 14:26:16 volumio volumio[988]: info: ControllerMpd::pushState
Jan 11 14:26:16 volumio volumio[988]: info: CoreCommandRouter::servicePushState
Jan 11 14:26:16 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:16 volumio volumio[988]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Девочка-деньги","artist":"Anacondaz","album":"Перезвони мне +79995771202","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-97.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dd71c3a6740ef9a77d205d926068bdeaeeb6dbb0ef4bd76640e43f7aca784368c%2Clid%3D1519%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D678ff79e%2F42459%2F53660%2F143ec2d5.117972416.5.77684881%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jan 11 14:26:16 volumio volumio[988]: verbose: CURRENT POSITION 137
Jan 11 14:26:16 volumio volumio[988]: info: CoreStateMachine::syncState stateService play
Jan 11 14:26:16 volumio volumio[988]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 14:26:16 volumio volumio[988]: info: ------------------------------ 22ms
Jan 11 14:26:16 volumio volumio[988]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 11 14:26:16 volumio volumio[988]: verbose: ControllerMpd::parseTrackInfo
Jan 11 14:26:16 volumio volumio[988]: info: ControllerMpd::pushState
Jan 11 14:26:16 volumio volumio[988]: info: CoreCommandRouter::servicePushState
Jan 11 14:26:16 volumio volumio[988]: info: CorePlayQueue::getTrack 137
Jan 11 14:26:16 volumio volumio[988]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1578,"duration":272,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Девочка-деньги","artist":"Anacondaz","album":"Перезвони мне +79995771202","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-97.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dd71c3a6740ef9a77d205d926068bdeaeeb6dbb0ef4bd76640e43f7aca784368c%2Clid%3D1519%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D678ff79e%2F42459%2F53660%2F143ec2d5.117972416.5.77684881%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jan 11 14:26:16 volumio volumio[988]: verbose: CURRENT POSITION 137
Jan 11 14:26:16 volumio volumio[988]: info: CoreStateMachine::syncState stateService play
Jan 11 14:26:16 volumio volumio[988]: info: CoreStateMachine::syncState currentStatus play
Jan 11 14:26:16 volumio volumio[988]: info: Received an update from plugin. extracting info from payload
Jan 11 14:26:16 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:26:16 volumio volumio[988]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 14:26:16 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:26:16 volumio volumio[988]: info: CoreStateMachine::pushState
Jan 11 14:26:16 volumio volumio[988]: info: CoreCommandRouter::volumioPushState
Jan 11 14:26:16 volumio volumio[988]: info: ------------------------------ 17ms
Jan 11 14:26:16 volumio volumio[988]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Jan 11 14:26:16 volumio volumio[988]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Jan 11 14:26:17 volumio volumio[988]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 11 14:26:17 volumio volumio[988]: Error: read ECONNRESET
Jan 11 14:26:17 volumio volumio[988]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) {
Jan 11 14:26:17 volumio volumio[988]: errno: -104,
Jan 11 14:26:17 volumio volumio[988]: code: 'ECONNRESET',
Jan 11 14:26:17 volumio volumio[988]: syscall: 'read'
Jan 11 14:26:17 volumio volumio[988]: }
Jan 11 14:26:17 volumio volumio[988]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 11 14:26:17 volumio sudo[1775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-11 14:25
Jan 11 14:26:17 volumio sudo[1775]: 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"