-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Wed 2025-07-09 14:21:31 MSK. --
Jul 09 14:20:03 volumio volumio[1067]: verbose: New Socket.io Connection to 192.168.1.30:3000 from 192.168.1.239 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Jul 09 14:20:03 volumio volumio[1067]: verbose: New Socket.io Connection to 192.168.1.30:3000 from 192.168.1.239 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Jul 09 14:20:03 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::volumioNext
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::next
Jul 09 14:20:57 volumio volumio[1067]: info: ControllerMpd::next
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand next
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:20:57 volumio volumio[1067]: info: sendMpdCommand next took 4 milliseconds
Jul 09 14:20:57 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:20:57 volumio volumio[1067]: error: updateQueue error: null
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 1ms
Jul 09 14:20:57 volumio volumio[1067]: info: sendMpdCommand status took 0 milliseconds
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:20:57 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getTrack 5
Jul 09 14:20:57 volumio volumio[1067]: 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}
Jul 09 14:20:57 volumio volumio[1067]: verbose: CURRENT POSITION 5
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::syncState stateService stop
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::play index undefined
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::startPlaybackTimer
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand stop
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 7ms
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:20:57 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:20:57 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:20:57 volumio volumio[1067]: error: updateQueue error: null
Jul 09 14:20:57 volumio volumio[1067]: error: updateQueue error: null
Jul 09 14:20:57 volumio volumio[1067]: info: sendMpdCommand stop took 5 milliseconds
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:20:57 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:20:57 volumio volumio[1067]: info: sendMpdCommand status took 1 milliseconds
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand clear
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:20:57 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:57 volumio volumio[1067]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd
Jul 09 14:20:57 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:57 volumio volumio[1067]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 7ms
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 8ms
Jul 09 14:20:57 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:57 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info: sendMpdCommand clear took 10 milliseconds
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: error: updateQueue error: null
Jul 09 14:20:57 volumio volumio[1067]: error: updateQueue error: null
Jul 09 14:20:57 volumio volumio[1067]: error: updateQueue error: null
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 8ms
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 1ms
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bbe52a9798dd0a9699232d4d4610e27556ce144e95625113b226a32563ca944%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d68%2F0%2F1767362%2F313c4475.92534655.8.61986310%2F320.mp3&ext=.mp3"
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bbe52a9798dd0a9699232d4d4610e27556ce144e95625113b226a32563ca944%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d68%2F0%2F1767362%2F313c4475.92534655.8.61986310%2F320.mp3&ext=.mp3" took 1 milliseconds
Jul 09 14:20:57 volumio volumio[1067]: verbose: MPD COMMAND [object Object]
Jul 09 14:20:57 volumio volumio[1067]: verbose: MPD COMMAND [object Object]
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 1ms
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 1ms
Jul 09 14:20:57 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 09 14:20:57 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand play
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info:
Jul 09 14:20:57 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:20:57 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:20:57 volumio volumio[1067]: info: sendMpdCommand play took 2 milliseconds
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:20:57 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:20:59 volumio volumio[1067]: info:
Jul 09 14:20:59 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:20:59 volumio volumio[1067]: info:
Jul 09 14:20:59 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:20:59 volumio volumio[1067]: info:
Jul 09 14:20:59 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:20:59 volumio volumio[1067]: info:
Jul 09 14:20:59 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:20:59 volumio volumio[1067]: info:
Jul 09 14:20:59 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:20:59 volumio volumio[1067]: info:
Jul 09 14:20:59 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand status took 8 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand status took 6 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand status took 5 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:59 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A.Vivaldi - Presto","artist":"Jelonek","album":"Classical Massacre","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bbe52a9798dd0a9699232d4d4610e27556ce144e95625113b226a32563ca944%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d68%2F0%2F1767362%2F313c4475.92534655.8.61986310%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:20:59 volumio volumio[1067]: verbose: CURRENT POSITION 6
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus stop
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:59 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A.Vivaldi - Presto","artist":"Jelonek","album":"Classical Massacre","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bbe52a9798dd0a9699232d4d4610e27556ce144e95625113b226a32563ca944%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d68%2F0%2F1767362%2F313c4475.92534655.8.61986310%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:20:59 volumio volumio[1067]: verbose: CURRENT POSITION 6
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:20:59 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:59 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A.Vivaldi - Presto","artist":"Jelonek","album":"Classical Massacre","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bbe52a9798dd0a9699232d4d4610e27556ce144e95625113b226a32563ca944%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d68%2F0%2F1767362%2F313c4475.92534655.8.61986310%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:20:59 volumio volumio[1067]: verbose: CURRENT POSITION 6
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:20:59 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: ------------------------------ 20ms
Jul 09 14:20:59 volumio volumio[1067]: info: ------------------------------ 22ms
Jul 09 14:20:59 volumio volumio[1067]: info: ------------------------------ 22ms
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 22 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 22 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 22 milliseconds
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:20:59 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:59 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A.Vivaldi - Presto","artist":"Jelonek","album":"Classical Massacre","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bbe52a9798dd0a9699232d4d4610e27556ce144e95625113b226a32563ca944%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d68%2F0%2F1767362%2F313c4475.92534655.8.61986310%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:20:59 volumio volumio[1067]: verbose: CURRENT POSITION 6
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:20:59 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:59 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A.Vivaldi - Presto","artist":"Jelonek","album":"Classical Massacre","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bbe52a9798dd0a9699232d4d4610e27556ce144e95625113b226a32563ca944%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d68%2F0%2F1767362%2F313c4475.92534655.8.61986310%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:20:59 volumio volumio[1067]: verbose: CURRENT POSITION 6
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:20:59 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:20:59 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A.Vivaldi - Presto","artist":"Jelonek","album":"Classical Massacre","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bbe52a9798dd0a9699232d4d4610e27556ce144e95625113b226a32563ca944%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d68%2F0%2F1767362%2F313c4475.92534655.8.61986310%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:20:59 volumio volumio[1067]: verbose: CURRENT POSITION 6
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:20:59 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:20:59 volumio volumio[1067]: info: ------------------------------ 46ms
Jul 09 14:20:59 volumio volumio[1067]: info: ------------------------------ 44ms
Jul 09 14:20:59 volumio volumio[1067]: info: ------------------------------ 44ms
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:20:59 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:01 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri
Jul 09 14:21:01 volumio volumio[1067]: info: Preload queue cleared
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/33201905:22428491@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/2215069:5060850@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/872918:22190944@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/28397938:5307396@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/90947897:18031896@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/140406324:37151215@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/61986310:9725332@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/15736187:1713703@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/60363095:9317591@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/300141:1711121@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/1695521:168144@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/69373004:11599812@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/732415:81432@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/17309:2501088@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/37615:10624581@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/45245308:6073152@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/17198795:1892996@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/113182239:25590790@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/2139313:477753@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/131964131:33620485@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/39257484:5060852@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/38634627:10100@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/19326805:2176059@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/17197658:1892700@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/105582366:22885255@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/107058193:23425178@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/1710808:227551@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/36664892:4620360@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/17198341:3059438@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/50582508:6996534@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/28036267:4986719@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/26556243:4694349@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/18172490:14505755@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/34084451:4181557@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/60089337:9254656@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/3962382:446019@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/36664872:4620359@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/6006252:660238@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/139480147:36768372@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/2200853:217939@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/59735856:29027114@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/120966517:28964387@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/52745736:7450409@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/2278985:718991@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/9047114:948624@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/149961:14544@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/90145853:17770710@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/76154361:33999235@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/6024130:3113823@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/17887641:22515166@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/17342378:25857453@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/49211429:6738950@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/1721:2515612@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/595258:63576@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/107792424:23692072@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/28123186:10283@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/308966:40063@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/105553782:22874571@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/103040168:21971355@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Preloading song: yandex_music/track/301147:30853@503646255:24576982
Jul 09 14:21:01 volumio volumio[1067]: info: Exploding uri yandex_music/track/33201905:22428491@503646255:24576982 in service yandex_music
Jul 09 14:21:01 volumio volumio[1067]: info: Exploding uri yandex_music/track/2215069:5060850@503646255:24576982 in service yandex_music
Jul 09 14:21:01 volumio volumio[1067]: info: Exploding uri yandex_music/track/872918:22190944@503646255:24576982 in service yandex_music
Jul 09 14:21:01 volumio volumio[1067]: info: Exploding uri yandex_music/track/28397938:5307396@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/90947897:18031896@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/140406324:37151215@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/61986310:9725332@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/15736187:1713703@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/60363095:9317591@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/300141:1711121@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/1695521:168144@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/69373004:11599812@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/732415:81432@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/17309:2501088@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/37615:10624581@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/45245308:6073152@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/17198795:1892996@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/113182239:25590790@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/2139313:477753@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/131964131:33620485@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/39257484:5060852@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/38634627:10100@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/19326805:2176059@503646255:24576982 in service yandex_music
Jul 09 14:21:02 volumio volumio[1067]: info: Exploding uri yandex_music/track/17197658:1892700@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/105582366:22885255@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/107058193:23425178@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/1710808:227551@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/36664892:4620360@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/17198341:3059438@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Preload queue cleared
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::ClearQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::stop
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::stPlaybackTimer
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::updateTrackBlock
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrackBlock
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::serviceStop
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 6
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::serviceStop
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::stop
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand stop
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::clearPlayQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::saveQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::addQueueItems
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::addQueueItems
Jul 09 14:21:03 volumio volumio[1067]: info: Preload queue cleared
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/33201905:22428491@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/33201905:22428491@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::saveQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::updateTrackBlock
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrackBlock
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPlay
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::play index 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::addQueueItems
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::addQueueItems
Jul 09 14:21:03 volumio volumio[1067]: info: Preload queue cleared
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/2215069:5060850@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/2215069:5060850@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/872918:22190944@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/872918:22190944@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/28397938:5307396@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/28397938:5307396@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/90947897:18031896@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/90947897:18031896@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/140406324:37151215@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/140406324:37151215@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/61986310:9725332@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/61986310:9725332@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/15736187:1713703@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/15736187:1713703@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/60363095:9317591@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/60363095:9317591@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/300141:1711121@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/300141:1711121@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/1695521:168144@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/1695521:168144@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/69373004:11599812@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/69373004:11599812@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/732415:81432@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/732415:81432@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/17309:2501088@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/17309:2501088@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/37615:10624581@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/37615:10624581@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/45245308:6073152@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/45245308:6073152@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/17198795:1892996@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/17198795:1892996@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/113182239:25590790@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/113182239:25590790@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/2139313:477753@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/2139313:477753@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/131964131:33620485@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/131964131:33620485@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/39257484:5060852@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/39257484:5060852@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/38634627:10100@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/38634627:10100@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/19326805:2176059@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/19326805:2176059@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/17197658:1892700@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/17197658:1892700@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/105582366:22885255@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/105582366:22885255@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/107058193:23425178@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/107058193:23425178@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/1710808:227551@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/1710808:227551@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/36664892:4620360@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/36664892:4620360@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/17198341:3059438@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Using cached record of: yandex_music/track/17198341:3059438@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/50582508:6996534@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/50582508:6996534@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/28036267:4986719@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/28036267:4986719@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/26556243:4694349@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/26556243:4694349@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/18172490:14505755@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/18172490:14505755@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/34084451:4181557@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/34084451:4181557@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/60089337:9254656@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/60089337:9254656@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/3962382:446019@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/3962382:446019@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/36664872:4620359@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/36664872:4620359@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/6006252:660238@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/6006252:660238@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/139480147:36768372@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/139480147:36768372@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/2200853:217939@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/2200853:217939@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/59735856:29027114@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/59735856:29027114@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/120966517:28964387@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/120966517:28964387@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/52745736:7450409@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/52745736:7450409@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/2278985:718991@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/2278985:718991@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/9047114:948624@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/9047114:948624@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/149961:14544@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/149961:14544@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/90145853:17770710@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/90145853:17770710@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/76154361:33999235@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/76154361:33999235@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/6024130:3113823@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/6024130:3113823@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/17887641:22515166@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/17887641:22515166@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/17342378:25857453@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/17342378:25857453@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/49211429:6738950@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/49211429:6738950@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/1721:2515612@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/1721:2515612@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/595258:63576@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/595258:63576@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/107792424:23692072@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/107792424:23692072@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/28123186:10283@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/28123186:10283@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/308966:40063@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/308966:40063@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/105553782:22874571@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/105553782:22874571@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/103040168:21971355@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/103040168:21971355@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: Adding Item to queue: yandex_music/track/301147:30853@503646255:24576982
Jul 09 14:21:03 volumio volumio[1067]: info: Exploding uri yandex_music/track/301147:30853@503646255:24576982 in service yandex_music
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::stop
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::play index undefined
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::startPlaybackTimer
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand stop
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::saveQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::updateTrackBlock
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrackBlock
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand stop took 45 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand stop took 16 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand clear
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:21:03 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand clear took 3 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand status took 1 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 19ms
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 18ms
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:21:03 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:21:03 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:21:03 volumio volumio[1067]: error: updateQueue error: null
Jul 09 14:21:03 volumio volumio[1067]: error: updateQueue error: null
Jul 09 14:21:03 volumio volumio[1067]: error: updateQueue error: null
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 26ms
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 25 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 5ms
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 4ms
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:03 volumio volumio[1067]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 30ms
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3"
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:21:03 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3" took 2 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: verbose: MPD COMMAND [object Object]
Jul 09 14:21:03 volumio volumio[1067]: verbose: MPD COMMAND [object Object]
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:21:03 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:21:03 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:21:03 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 3ms
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 1ms
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 1ms
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand play
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:21:03 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces system playlist update
Jul 09 14:21:03 volumio volumio[1067]: info: Ignoring MPD Status Update
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand play took 3 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 2ms
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand status took 1 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:03 volumio volumio[1067]: info:
Jul 09 14:21:03 volumio volumio[1067]: ---------------------------- MPD announces state update: player
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand status took 4 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:03 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus stop
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:03 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:03 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:03 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:03 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 15ms
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 17ms
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 16ms
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:03 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:03 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:03 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:03 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:03 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:03 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:03 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:03 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 29ms
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 27ms
Jul 09 14:21:03 volumio volumio[1067]: info: ------------------------------ 27ms
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:03 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:09 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 09 14:21:10 volumio volumio[1067]: info: Retrieving Cloud Streaming UI
Jul 09 14:21:10 volumio volumio[1067]: info: Getting Tidal Cloud Configuration
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 09 14:21:10 volumio volumio[1067]: info: Getting Qobuz Cloud Configuration
Jul 09 14:21:10 volumio volumio[1067]: info: Asking plugin for UI Config
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 09 14:21:10 volumio volumio[1067]: info: Getting Spotify Cloud Configuration
Jul 09 14:21:10 volumio volumio[1067]: info: Asking plugin for UI Config
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 09 14:21:10 volumio volumio[1067]: info: Saving Spotify Acccount
Jul 09 14:21:10 volumio volumio[1067]: info: Got Tidal Cloud Configuration
Jul 09 14:21:10 volumio volumio[1067]: info: Got it
Jul 09 14:21:10 volumio volumio[1067]: info: Got it
Jul 09 14:21:10 volumio volumio[1067]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 09 14:21:10 volumio volumio[1067]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 09 14:21:10 volumio volumio[1067]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 09 14:21:12 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:21:12 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand update
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: info:
Jul 09 14:21:14 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand update took 2 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: info:
Jul 09 14:21:14 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: info:
Jul 09 14:21:14 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: info:
Jul 09 14:21:14 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: info:
Jul 09 14:21:14 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: info:
Jul 09 14:21:14 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 208 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 207 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 43 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 25 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:14 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11512,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:14 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:14 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:14 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11512,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:14 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:14 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:14 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11512,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:14 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:14 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: ------------------------------ 284ms
Jul 09 14:21:14 volumio volumio[1067]: info: ------------------------------ 283ms
Jul 09 14:21:14 volumio volumio[1067]: info: ------------------------------ 283ms
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 77 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 59 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 40 milliseconds
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:14 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:14 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11512,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:14 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:14 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:14 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11706,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:14 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:14 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:14 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11706,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:14 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:14 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:14 volumio volumio[1067]: info: ------------------------------ 319ms
Jul 09 14:21:14 volumio volumio[1067]: info: ------------------------------ 114ms
Jul 09 14:21:14 volumio volumio[1067]: info: ------------------------------ 113ms
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:14 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand rescan
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info:
Jul 09 14:21:16 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand rescan took 2 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info:
Jul 09 14:21:16 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 1 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info:
Jul 09 14:21:16 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info:
Jul 09 14:21:16 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 38 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 38 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 1 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:16 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13912,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:16 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:16 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: ------------------------------ 104ms
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info:
Jul 09 14:21:16 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 58 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 39 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 21 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 14 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 13 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:16 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13912,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:16 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:16 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:16 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13912,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:16 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:16 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:16 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13912,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:16 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:16 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: ------------------------------ 166ms
Jul 09 14:21:16 volumio volumio[1067]: info: ------------------------------ 130ms
Jul 09 14:21:16 volumio volumio[1067]: info: ------------------------------ 130ms
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info:
Jul 09 14:21:16 volumio volumio[1067]: ---------------------------- MPD announces state update: update
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::getState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand status took 1 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseState
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:16 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14003,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:16 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:16 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: ------------------------------ 90ms
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:16 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 32 milliseconds
Jul 09 14:21:16 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:21:16 volumio volumio[1067]: info: ControllerMpd::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::servicePushState
Jul 09 14:21:16 volumio volumio[1067]: info: CorePlayQueue::getTrack 0
Jul 09 14:21:16 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14106,"duration":224,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Родина","artist":"Сергей Трофимов","album":"Русские хиты","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8d5e104dbb6e2fd4cdc6e63e5c6e304e41f79634c3e386bc90f3cf1f98a13d8d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D687c0d3c%2F35075%2F4814188%2F559774db.157396966.7.33201905%2F320.mp3&ext=.mp3","trackType":"mp3"}
Jul 09 14:21:16 volumio volumio[1067]: verbose: CURRENT POSITION 0
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play
Jul 09 14:21:16 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreStateMachine::pushState
Jul 09 14:21:16 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState
Jul 09 14:21:16 volumio volumio[1067]: info: ------------------------------ 59ms
Jul 09 14:21:17 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:17 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:17 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:17 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:21:17 volumio volumio[1067]: info: CoreStateMachine::getQueue
Jul 09 14:21:17 volumio volumio[1067]: info: CorePlayQueue::getQueue
Jul 09 14:21:20 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:21:24 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:21:28 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:21:30 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Jul 09 14:21:30 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Jul 09 14:21:30 volumio volumio[1067]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 14:21:30 volumio volumio[1067]: Error: getaddrinfo -3007
Jul 09 14:21:30 volumio volumio[1067]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Jul 09 14:21:30 volumio volumio[1067]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Jul 09 14:21:30 volumio volumio[1067]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Jul 09 14:21:30 volumio volumio[1067]: code: -3007,
Jul 09 14:21:30 volumio volumio[1067]: errno: -3007,
Jul 09 14:21:30 volumio volumio[1067]: syscall: 'getaddrinfo'
Jul 09 14:21:30 volumio volumio[1067]: }
Jul 09 14:21:30 volumio volumio[1067]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 14:21:31 volumio sudo[6148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 14:20
Jul 09 14:21:31 volumio sudo[6148]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST"
VOLUMIO_VERSION="3.819"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"