-- Logs begin at Sun 2026-02-22 18:17:01 MSK, end at Sun 2026-02-22 18:19:17 MSK. -- Feb 22 18:18:01 volumio sudo[1833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //192.168.31.5/ubuntu-hdd/Музыка /mnt/NAS/Ubuntu Feb 22 18:18:01 volumio sudo[1833]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 18:18:07 volumio sudo[1833]: pam_unix(sudo:session): session closed for user root Feb 22 18:18:07 volumio kernel: CIFS VFS: Error connecting to socket. Aborting operation. Feb 22 18:18:07 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -113 Feb 22 18:18:07 volumio volumio[1096]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Feb 22 18:18:08 volumio volumio[1096]: verbose: New Socket.io Connection to 192.168.31.182 from 192.168.31.165 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 22 18:18:08 volumio volumio[1096]: verbose: New Socket.io Connection to 192.168.31.182 from 192.168.31.165 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 22 18:18:08 volumio volumio[1096]: verbose: New Socket.io Connection to 192.168.31.182 from 192.168.31.165 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 22 18:18:08 volumio volumio[1096]: verbose: New Socket.io Connection to 192.168.31.182 from 192.168.31.165 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 22 18:18:08 volumio volumio[1096]: verbose: New Socket.io Connection to 192.168.31.182 from 192.168.31.165 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 22 18:18:11 volumio volumio[1096]: verbose: New Socket.io Connection to 192.168.31.182 from 192.168.31.165 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Feb 22 18:18:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:12 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:12 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:12 volumio volumio[1096]: info: Listing playlists Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 18:18:12 volumio volumio[1096]: info: Received Get System Info Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 18:18:12 volumio volumio[1096]: info: Discovery: Getting this device information Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Feb 22 18:18:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Feb 22 18:18:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 22 18:18:13 volumio volumio[1096]: info: CoreCommandRouter::volumioPlay Feb 22 18:18:13 volumio volumio[1096]: info: CoreStateMachine::play index undefined Feb 22 18:18:13 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 18:18:13 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:13 volumio volumio[1096]: info: CoreStateMachine::startPlaybackTimer Feb 22 18:18:13 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:13 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 18:18:13 volumio volumio[1096]: info: sendMpdCommand stop took 1 milliseconds Feb 22 18:18:13 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 18:18:13 volumio volumio[1096]: info: sendMpdCommand clear took 1 milliseconds Feb 22 18:18:13 volumio volumio[1096]: info: Feb 22 18:18:13 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:13 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:13 volumio volumio[1096]: info: Feb 22 18:18:13 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:13 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:13 volumio volumio[1096]: info: Feb 22 18:18:13 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:13 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:13 volumio volumio[1096]: error: updateQueue error: null Feb 22 18:18:13 volumio volumio[1096]: error: updateQueue error: null Feb 22 18:18:13 volumio volumio[1096]: error: updateQueue error: null Feb 22 18:18:13 volumio volumio[1096]: info: ------------------------------ 8ms Feb 22 18:18:13 volumio volumio[1096]: info: ------------------------------ 7ms Feb 22 18:18:13 volumio volumio[1096]: info: ------------------------------ 3ms Feb 22 18:18:13 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-163.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D478b5d3cb1d7f9deaec663747d97330c55b712297f4555cdaafffd5d3a8ee0f0%2Clid%3D102%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a902aa%2F0%2F769989%2Fc6007a74.99555714.20.66087125%2Fflac-mp4&ext=.flac" Feb 22 18:18:13 volumio volumio[1096]: info: Feb 22 18:18:13 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:13 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:13 volumio volumio[1096]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-163.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D478b5d3cb1d7f9deaec663747d97330c55b712297f4555cdaafffd5d3a8ee0f0%2Clid%3D102%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a902aa%2F0%2F769989%2Fc6007a74.99555714.20.66087125%2Fflac-mp4&ext=.flac" took 2 milliseconds Feb 22 18:18:13 volumio volumio[1096]: verbose: MPD COMMAND [object Object] Feb 22 18:18:13 volumio volumio[1096]: verbose: MPD COMMAND [object Object] Feb 22 18:18:13 volumio volumio[1096]: verbose: MPD COMMAND [object Object] Feb 22 18:18:13 volumio volumio[1096]: info: Feb 22 18:18:13 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:13 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:13 volumio volumio[1096]: info: Feb 22 18:18:13 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:13 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:13 volumio volumio[1096]: info: Feb 22 18:18:13 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:13 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:13 volumio volumio[1096]: info: ------------------------------ 6ms Feb 22 18:18:13 volumio volumio[1096]: info: ------------------------------ 3ms Feb 22 18:18:13 volumio volumio[1096]: info: ------------------------------ 2ms Feb 22 18:18:13 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 22 18:18:13 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand play Feb 22 18:18:13 volumio volumio[1096]: info: Feb 22 18:18:13 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:13 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:13 volumio volumio[1096]: info: Feb 22 18:18:13 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:13 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:13 volumio volumio[1096]: info: ------------------------------ 6ms Feb 22 18:18:13 volumio volumio[1096]: info: sendMpdCommand play took 4 milliseconds Feb 22 18:18:13 volumio volumio[1096]: info: ------------------------------ 4ms Feb 22 18:18:13 volumio volumio[1096]: info: ------------------------------ 2ms Feb 22 18:18:14 volumio volumio[1096]: info: Feb 22 18:18:14 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:14 volumio volumio[1096]: info: Feb 22 18:18:14 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:14 volumio volumio[1096]: info: Feb 22 18:18:14 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand status took 7 milliseconds Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:14 volumio volumio[1096]: info: Feb 22 18:18:14 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand status took 10 milliseconds Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand status took 9 milliseconds Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:14 volumio volumio[1096]: info: Feb 22 18:18:14 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:14 volumio volumio[1096]: info: Feb 22 18:18:14 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand status took 5 milliseconds Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand status took 3 milliseconds Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand status took 2 milliseconds Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:14 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":322,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dancing Generation","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-163.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D478b5d3cb1d7f9deaec663747d97330c55b712297f4555cdaafffd5d3a8ee0f0%2Clid%3D102%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a902aa%2F0%2F769989%2Fc6007a74.99555714.20.66087125%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:14 volumio volumio[1096]: verbose: CURRENT POSITION 0 Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:14 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":322,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dancing Generation","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-163.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D478b5d3cb1d7f9deaec663747d97330c55b712297f4555cdaafffd5d3a8ee0f0%2Clid%3D102%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a902aa%2F0%2F769989%2Fc6007a74.99555714.20.66087125%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:14 volumio volumio[1096]: verbose: CURRENT POSITION 0 Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:14 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:14 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":322,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dancing Generation","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-163.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D478b5d3cb1d7f9deaec663747d97330c55b712297f4555cdaafffd5d3a8ee0f0%2Clid%3D102%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a902aa%2F0%2F769989%2Fc6007a74.99555714.20.66087125%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:14 volumio volumio[1096]: verbose: CURRENT POSITION 0 Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:14 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: ------------------------------ 39ms Feb 22 18:18:14 volumio volumio[1096]: info: ------------------------------ 49ms Feb 22 18:18:14 volumio volumio[1096]: info: ------------------------------ 48ms Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 32 milliseconds Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 31 milliseconds Feb 22 18:18:14 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 32 milliseconds Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:14 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:14 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":322,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dancing Generation","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-163.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D478b5d3cb1d7f9deaec663747d97330c55b712297f4555cdaafffd5d3a8ee0f0%2Clid%3D102%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a902aa%2F0%2F769989%2Fc6007a74.99555714.20.66087125%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:14 volumio volumio[1096]: verbose: CURRENT POSITION 0 Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:14 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:14 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":322,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dancing Generation","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-163.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D478b5d3cb1d7f9deaec663747d97330c55b712297f4555cdaafffd5d3a8ee0f0%2Clid%3D102%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a902aa%2F0%2F769989%2Fc6007a74.99555714.20.66087125%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:14 volumio volumio[1096]: verbose: CURRENT POSITION 0 Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:14 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:14 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":322,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dancing Generation","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-163.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D478b5d3cb1d7f9deaec663747d97330c55b712297f4555cdaafffd5d3a8ee0f0%2Clid%3D102%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a902aa%2F0%2F769989%2Fc6007a74.99555714.20.66087125%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:14 volumio volumio[1096]: verbose: CURRENT POSITION 0 Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:14 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:14 volumio volumio[1096]: info: ------------------------------ 72ms Feb 22 18:18:14 volumio volumio[1096]: info: ------------------------------ 69ms Feb 22 18:18:14 volumio volumio[1096]: info: ------------------------------ 69ms Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:14 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:14 volumio volumio[1096]: info: VolumeController::SetAlsaVolume- Feb 22 18:18:15 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:15 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:15 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:15 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:15 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:15 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:15 volumio volumio[1096]: info: VolumeController::SetAlsaVolume- Feb 22 18:18:15 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:15 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:15 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:15 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:15 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:15 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:17 volumio volumio[1096]: info: VolumeController::SetAlsaVolume- Feb 22 18:18:17 volumio volumio[1096]: info: VolumeController::SetAlsaVolume- Feb 22 18:18:17 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:17 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:17 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:17 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:17 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:17 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:17 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:17 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:22 volumio volumio[1096]: info: VolumeController::SetAlsaVolume+ Feb 22 18:18:22 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:22 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:22 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:22 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:22 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:22 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::volumioNext Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::next Feb 22 18:18:25 volumio volumio[1096]: info: ControllerMpd::next Feb 22 18:18:25 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand next Feb 22 18:18:25 volumio volumio[1096]: info: sendMpdCommand next took 7 milliseconds Feb 22 18:18:25 volumio volumio[1096]: info: Feb 22 18:18:25 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:25 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:25 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:25 volumio volumio[1096]: info: Feb 22 18:18:25 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:25 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:25 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:25 volumio volumio[1096]: info: Feb 22 18:18:25 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:25 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:25 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:25 volumio volumio[1096]: info: sendMpdCommand status took 3 milliseconds Feb 22 18:18:25 volumio volumio[1096]: info: sendMpdCommand status took 2 milliseconds Feb 22 18:18:25 volumio volumio[1096]: info: sendMpdCommand status took 1 milliseconds Feb 22 18:18:25 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:25 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:25 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:25 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Feb 22 18:18:25 volumio volumio[1096]: 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} Feb 22 18:18:25 volumio volumio[1096]: verbose: CURRENT POSITION 0 Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::syncState stateService stop Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::play index undefined Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:25 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:25 volumio volumio[1096]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Feb 22 18:18:25 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:25 volumio volumio[1096]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::startPlaybackTimer Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:25 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 18:18:25 volumio volumio[1096]: info: ------------------------------ 27ms Feb 22 18:18:25 volumio volumio[1096]: info: ------------------------------ 27ms Feb 22 18:18:25 volumio volumio[1096]: info: ------------------------------ 26ms Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:25 volumio volumio[1096]: info: sendMpdCommand stop took 13 milliseconds Feb 22 18:18:25 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 18:18:25 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:25 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:25 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:25 volumio volumio[1096]: info: Feb 22 18:18:25 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:25 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:25 volumio volumio[1096]: info: sendMpdCommand clear took 10 milliseconds Feb 22 18:18:25 volumio volumio[1096]: info: Feb 22 18:18:25 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:25 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:25 volumio volumio[1096]: info: Feb 22 18:18:25 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:25 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:25 volumio volumio[1096]: error: updateQueue error: null Feb 22 18:18:25 volumio volumio[1096]: error: updateQueue error: null Feb 22 18:18:25 volumio volumio[1096]: error: updateQueue error: null Feb 22 18:18:25 volumio volumio[1096]: info: ------------------------------ 11ms Feb 22 18:18:25 volumio volumio[1096]: info: ------------------------------ 3ms Feb 22 18:18:25 volumio volumio[1096]: info: ------------------------------ 2ms Feb 22 18:18:26 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-ruspb03skynt-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4bb23be94dbc9bd997088dd706dedadfcfc88429f364fa675763db5cf1d0a22a%2Clid%3D1712%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a8df37%2F0%2F1445411%2Fea77d307.99555719.20.66087128%2Fflac-mp4&ext=.flac" Feb 22 18:18:26 volumio volumio[1096]: info: Feb 22 18:18:26 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:26 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:26 volumio volumio[1096]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-ruspb03skynt-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4bb23be94dbc9bd997088dd706dedadfcfc88429f364fa675763db5cf1d0a22a%2Clid%3D1712%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a8df37%2F0%2F1445411%2Fea77d307.99555719.20.66087128%2Fflac-mp4&ext=.flac" took 2 milliseconds Feb 22 18:18:26 volumio volumio[1096]: verbose: MPD COMMAND [object Object] Feb 22 18:18:26 volumio volumio[1096]: verbose: MPD COMMAND [object Object] Feb 22 18:18:26 volumio volumio[1096]: verbose: MPD COMMAND [object Object] Feb 22 18:18:26 volumio volumio[1096]: info: Feb 22 18:18:26 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:26 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:26 volumio volumio[1096]: info: Feb 22 18:18:26 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:26 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:26 volumio volumio[1096]: info: Feb 22 18:18:26 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:26 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:26 volumio volumio[1096]: info: ------------------------------ 4ms Feb 22 18:18:26 volumio volumio[1096]: info: ------------------------------ 2ms Feb 22 18:18:26 volumio volumio[1096]: info: ------------------------------ 2ms Feb 22 18:18:26 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 22 18:18:26 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand play Feb 22 18:18:26 volumio volumio[1096]: info: Feb 22 18:18:26 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:26 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:26 volumio volumio[1096]: info: Feb 22 18:18:26 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:26 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:26 volumio volumio[1096]: info: ------------------------------ 3ms Feb 22 18:18:26 volumio volumio[1096]: info: sendMpdCommand play took 3 milliseconds Feb 22 18:18:26 volumio volumio[1096]: info: ------------------------------ 3ms Feb 22 18:18:26 volumio volumio[1096]: info: ------------------------------ 2ms Feb 22 18:18:27 volumio volumio[1096]: info: Feb 22 18:18:27 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:27 volumio volumio[1096]: info: Feb 22 18:18:27 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:27 volumio volumio[1096]: info: Feb 22 18:18:27 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:27 volumio volumio[1096]: info: Feb 22 18:18:27 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand status took 7 milliseconds Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand status took 8 milliseconds Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand status took 7 milliseconds Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand status took 1 milliseconds Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:27 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Но только не говори мне","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-ruspb03skynt-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4bb23be94dbc9bd997088dd706dedadfcfc88429f364fa675763db5cf1d0a22a%2Clid%3D1712%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a8df37%2F0%2F1445411%2Fea77d307.99555719.20.66087128%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:27 volumio volumio[1096]: verbose: CURRENT POSITION 1 Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Feb 22 18:18:27 volumio volumio[1096]: info: ------------------------------ 14ms Feb 22 18:18:27 volumio volumio[1096]: info: Feb 22 18:18:27 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:27 volumio volumio[1096]: info: Feb 22 18:18:27 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand status took 3 milliseconds Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand status took 2 milliseconds Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:27 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Но только не говори мне","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-ruspb03skynt-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4bb23be94dbc9bd997088dd706dedadfcfc88429f364fa675763db5cf1d0a22a%2Clid%3D1712%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a8df37%2F0%2F1445411%2Fea77d307.99555719.20.66087128%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:27 volumio volumio[1096]: verbose: CURRENT POSITION 1 Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:27 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:27 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Но только не говори мне","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-ruspb03skynt-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4bb23be94dbc9bd997088dd706dedadfcfc88429f364fa675763db5cf1d0a22a%2Clid%3D1712%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a8df37%2F0%2F1445411%2Fea77d307.99555719.20.66087128%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:27 volumio volumio[1096]: verbose: CURRENT POSITION 1 Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:27 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:27 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Но только не говори мне","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-ruspb03skynt-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4bb23be94dbc9bd997088dd706dedadfcfc88429f364fa675763db5cf1d0a22a%2Clid%3D1712%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a8df37%2F0%2F1445411%2Fea77d307.99555719.20.66087128%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:27 volumio volumio[1096]: verbose: CURRENT POSITION 1 Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:27 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: ------------------------------ 51ms Feb 22 18:18:27 volumio volumio[1096]: info: ------------------------------ 50ms Feb 22 18:18:27 volumio volumio[1096]: info: ------------------------------ 45ms Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 34 milliseconds Feb 22 18:18:27 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 34 milliseconds Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:27 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:27 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Но только не говори мне","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-ruspb03skynt-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4bb23be94dbc9bd997088dd706dedadfcfc88429f364fa675763db5cf1d0a22a%2Clid%3D1712%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a8df37%2F0%2F1445411%2Fea77d307.99555719.20.66087128%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:27 volumio volumio[1096]: verbose: CURRENT POSITION 1 Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:27 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:27 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Но только не говори мне","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-ruspb03skynt-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4bb23be94dbc9bd997088dd706dedadfcfc88429f364fa675763db5cf1d0a22a%2Clid%3D1712%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a8df37%2F0%2F1445411%2Fea77d307.99555719.20.66087128%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:27 volumio volumio[1096]: verbose: CURRENT POSITION 1 Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:27 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:27 volumio volumio[1096]: info: ------------------------------ 62ms Feb 22 18:18:27 volumio volumio[1096]: info: ------------------------------ 62ms Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:27 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:27 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:30 volumio volumio[1096]: info: CoreCommandRouter::volumioPlay Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::play index 4 Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::stop Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::stPlaybackTimer Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Feb 22 18:18:30 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:30 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:30 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:30 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::serviceStop Feb 22 18:18:30 volumio volumio[1096]: info: CorePlayQueue::getTrack 1 Feb 22 18:18:30 volumio volumio[1096]: info: CoreCommandRouter::serviceStop Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 22 18:18:30 volumio volumio[1096]: info: ControllerMpd::stop Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 18:18:30 volumio volumio[1096]: info: sendMpdCommand stop took 28 milliseconds Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::play index undefined Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 18:18:30 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::startPlaybackTimer Feb 22 18:18:30 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 18:18:30 volumio volumio[1096]: info: Feb 22 18:18:30 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:30 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:30 volumio volumio[1096]: info: sendMpdCommand stop took 2 milliseconds Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 18:18:30 volumio volumio[1096]: info: Feb 22 18:18:30 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:30 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:30 volumio volumio[1096]: info: Feb 22 18:18:30 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:30 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:30 volumio volumio[1096]: info: Feb 22 18:18:30 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:30 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:30 volumio volumio[1096]: info: sendMpdCommand status took 3 milliseconds Feb 22 18:18:30 volumio volumio[1096]: info: sendMpdCommand clear took 3 milliseconds Feb 22 18:18:30 volumio volumio[1096]: info: sendMpdCommand status took 3 milliseconds Feb 22 18:18:30 volumio volumio[1096]: info: sendMpdCommand status took 2 milliseconds Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:30 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:30 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:30 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:30 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:30 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:30 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:30 volumio volumio[1096]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Feb 22 18:18:30 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:30 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:30 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:30 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:30 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:30 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:30 volumio volumio[1096]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Feb 22 18:18:30 volumio volumio[1096]: info: ------------------------------ 15ms Feb 22 18:18:30 volumio volumio[1096]: info: ------------------------------ 15ms Feb 22 18:18:30 volumio volumio[1096]: info: Feb 22 18:18:30 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:30 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:30 volumio volumio[1096]: info: Feb 22 18:18:30 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:30 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:30 volumio volumio[1096]: error: updateQueue error: null Feb 22 18:18:30 volumio volumio[1096]: error: updateQueue error: null Feb 22 18:18:30 volumio volumio[1096]: error: updateQueue error: null Feb 22 18:18:30 volumio volumio[1096]: info: ------------------------------ 21ms Feb 22 18:18:30 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 20 milliseconds Feb 22 18:18:30 volumio volumio[1096]: info: ------------------------------ 3ms Feb 22 18:18:30 volumio volumio[1096]: info: ------------------------------ 2ms Feb 22 18:18:30 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:30 volumio volumio[1096]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 22 18:18:30 volumio volumio[1096]: info: ------------------------------ 26ms Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-spbmiran-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6861d3721fc905b411ad4f9e6a3f6f4feff20b9fa660812cb352ec18ef1bb6e8%2Clid%3D279%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a96f8d%2F0%2F14141%2Fac7fa835.99555723.20.66087134%2Fflac-mp4&ext=.flac" Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:31 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-spbmiran-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6861d3721fc905b411ad4f9e6a3f6f4feff20b9fa660812cb352ec18ef1bb6e8%2Clid%3D279%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a96f8d%2F0%2F14141%2Fac7fa835.99555723.20.66087134%2Fflac-mp4&ext=.flac" took 1 milliseconds Feb 22 18:18:31 volumio volumio[1096]: verbose: MPD COMMAND [object Object] Feb 22 18:18:31 volumio volumio[1096]: verbose: MPD COMMAND [object Object] Feb 22 18:18:31 volumio volumio[1096]: verbose: MPD COMMAND [object Object] Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:31 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:31 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:31 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 6ms Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 4ms Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 4ms Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand play Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:31 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Feb 22 18:18:31 volumio volumio[1096]: info: Ignoring MPD Status Update Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 4ms Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand play took 3 milliseconds Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 3ms Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 2ms Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand status took 8 milliseconds Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand status took 8 milliseconds Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand status took 8 milliseconds Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:31 volumio volumio[1096]: info: Feb 22 18:18:31 volumio volumio[1096]: ---------------------------- MPD announces state update: player Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::getState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand status took 5 milliseconds Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand status took 4 milliseconds Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand status took 3 milliseconds Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseState Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:31 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Аквалангисты любви","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-spbmiran-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6861d3721fc905b411ad4f9e6a3f6f4feff20b9fa660812cb352ec18ef1bb6e8%2Clid%3D279%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a96f8d%2F0%2F14141%2Fac7fa835.99555723.20.66087134%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:31 volumio volumio[1096]: verbose: CURRENT POSITION 4 Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:31 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Аквалангисты любви","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-spbmiran-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6861d3721fc905b411ad4f9e6a3f6f4feff20b9fa660812cb352ec18ef1bb6e8%2Clid%3D279%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a96f8d%2F0%2F14141%2Fac7fa835.99555723.20.66087134%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:31 volumio volumio[1096]: verbose: CURRENT POSITION 4 Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:31 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:31 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Аквалангисты любви","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-spbmiran-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6861d3721fc905b411ad4f9e6a3f6f4feff20b9fa660812cb352ec18ef1bb6e8%2Clid%3D279%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a96f8d%2F0%2F14141%2Fac7fa835.99555723.20.66087134%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:31 volumio volumio[1096]: verbose: CURRENT POSITION 4 Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:31 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 34ms Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 45ms Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 44ms Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 31 milliseconds Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 22 18:18:31 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 31 milliseconds Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:31 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:31 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Аквалангисты любви","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-spbmiran-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6861d3721fc905b411ad4f9e6a3f6f4feff20b9fa660812cb352ec18ef1bb6e8%2Clid%3D279%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a96f8d%2F0%2F14141%2Fac7fa835.99555723.20.66087134%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:31 volumio volumio[1096]: verbose: CURRENT POSITION 4 Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:31 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:31 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Аквалангисты любви","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-spbmiran-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6861d3721fc905b411ad4f9e6a3f6f4feff20b9fa660812cb352ec18ef1bb6e8%2Clid%3D279%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a96f8d%2F0%2F14141%2Fac7fa835.99555723.20.66087134%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:31 volumio volumio[1096]: verbose: CURRENT POSITION 4 Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:31 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: ControllerMpd::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getTrack 4 Feb 22 18:18:31 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Аквалангисты любви","artist":"Наталья Ветлицкая","album":"Плейбой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-spbmiran-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6861d3721fc905b411ad4f9e6a3f6f4feff20b9fa660812cb352ec18ef1bb6e8%2Clid%3D279%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69a96f8d%2F0%2F14141%2Fac7fa835.99555723.20.66087134%2Fflac-mp4&ext=.flac","trackType":"flac"} Feb 22 18:18:31 volumio volumio[1096]: verbose: CURRENT POSITION 4 Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Feb 22 18:18:31 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 69ms Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 67ms Feb 22 18:18:31 volumio volumio[1096]: info: ------------------------------ 67ms Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:31 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:31 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:36 volumio volumio[1096]: info: VolumeController::SetAlsaVolume+ Feb 22 18:18:36 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:36 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:36 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:36 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:36 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:36 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:18:39 volumio volumio[1096]: info: VolumeController::SetAlsaVolume+ Feb 22 18:18:39 volumio volumio[1096]: info: CoreStateMachine::pushState Feb 22 18:18:39 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:18:39 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Feb 22 18:18:39 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue Feb 22 18:18:39 volumio volumio[1096]: info: CoreStateMachine::getQueue Feb 22 18:18:39 volumio volumio[1096]: info: CorePlayQueue::getQueue Feb 22 18:19:16 volumio volumio[1096]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 18:19:16 volumio volumio[1096]: Error: read ECONNRESET Feb 22 18:19:16 volumio volumio[1096]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Feb 22 18:19:16 volumio volumio[1096]: errno: -104, Feb 22 18:19:16 volumio volumio[1096]: code: 'ECONNRESET', Feb 22 18:19:16 volumio volumio[1096]: syscall: 'read' Feb 22 18:19:16 volumio volumio[1096]: } Feb 22 18:19:16 volumio volumio[1096]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 18:19:17 volumio sudo[2196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-22 18:18 Feb 22 18:19:17 volumio sudo[2196]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:03:54 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="35e446ff98e90abcfcab1bb2733dfd3a"