-- Logs begin at Thu 2024-04-11 11:17:50 UTC, end at Thu 2024-04-11 11:49:00 UTC. --
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::volumioNext
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::next
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::stop
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::stPlaybackTimer
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::updateTrackBlock
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrackBlock
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:06 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:06 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::serviceStop
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::serviceStop
Apr 11 11:48:06 volumiow volumio[999]: info: ControllerMpd::stop
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 11:48:06 volumiow volumio[999]: info:
Apr 11 11:48:06 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:06 volumiow volumio[999]: info: sendMpdCommand stop took 11 milliseconds
Apr 11 11:48:06 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::play index undefined
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::startPlaybackTimer
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::clearAddPlayTracks NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/02 Myself at Last.wma
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::updateTrackBlock
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrackBlock
Apr 11 11:48:06 volumiow volumio[999]: info: sendMpdCommand status took 2 milliseconds
Apr 11 11:48:06 volumiow volumio[999]: info: sendMpdCommand stop took 2 milliseconds
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 11:48:06 volumiow volumio[999]: info:
Apr 11 11:48:06 volumiow volumio[999]: ---------------------------- MPD announces system playlist update
Apr 11 11:48:06 volumiow volumio[999]: info: Ignoring MPD Status Update
Apr 11 11:48:06 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 11 11:48:06 volumiow volumio[999]: info: sendMpdCommand clear took 2 milliseconds
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand add "NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/02 Myself at Last.wma"
Apr 11 11:48:06 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:06 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:06 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:06 volumiow volumio[999]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"This Path Tonight","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/01 This Path Tonight.wma","trackType":"wma"}
Apr 11 11:48:06 volumiow volumio[999]: verbose: CURRENT POSITION 1
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::syncState stateService stop
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:06 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:06 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:06 volumiow volumio[999]: info: No code
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:06 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:06 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:06 volumiow volumio[999]: info: ------------------------------ 21ms
Apr 11 11:48:06 volumiow volumio[999]: error: updateQueue error: null
Apr 11 11:48:06 volumiow volumio[999]: info:
Apr 11 11:48:06 volumiow volumio[999]: ---------------------------- MPD announces system playlist update
Apr 11 11:48:06 volumiow volumio[999]: info: Ignoring MPD Status Update
Apr 11 11:48:06 volumiow volumio[999]: info: ------------------------------ 21ms
Apr 11 11:48:06 volumiow volumio[999]: info: sendMpdCommand add "NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/02 Myself at Last.wma" took 20 milliseconds
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 11:48:06 volumiow volumio[999]: info: ------------------------------ 17ms
Apr 11 11:48:06 volumiow volumio[999]: info: sendMpdCommand play took 18 milliseconds
Apr 11 11:48:06 volumiow volumio[999]: info:
Apr 11 11:48:06 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:06 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:06 volumiow volumio[999]: info: sendMpdCommand status took 10 milliseconds
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:06 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 11 11:48:06 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:06 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:06 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:06 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:06 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Myself at Last","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/02 Myself at Last.wma","trackType":"wma"}
Apr 11 11:48:06 volumiow volumio[999]: verbose: CURRENT POSITION 1
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:06 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 11:48:06 volumiow volumio[999]: info: ------------------------------ 12ms
Apr 11 11:48:08 volumiow volumio[999]: info: CoreCommandRouter::volumioSeek
Apr 11 11:48:08 volumiow volumio[999]: info: CoreStateMachine::seek
Apr 11 11:48:08 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:08 volumiow volumio[999]: info: TRACKBLOCK {"uri":"music-library/NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/02 Myself at Last.wma","service":"mpd","name":"2 - Myself at Last","artist":"Graham Nash","album":"This Path Tonight","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=507&web=Graham%20Nash/This%20Path%20Tonight/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGraham%20Nash%2FThis%20Path%20Tonight&metadata=false","duration":319,"trackType":"wma"}
Apr 11 11:48:08 volumiow volumio[999]: info: CoreStateMachine::startPlaybackTimer
Apr 11 11:48:08 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:08 volumiow volumio[999]: info: ControllerMpd::seek
Apr 11 11:48:08 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:08 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:08 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:08 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:08 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:08 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:08 volumiow volumio[999]: error: null
Apr 11 11:48:08 volumiow volumio[999]: info:
Apr 11 11:48:08 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:08 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:08 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:08 volumiow volumio[999]: info: sendMpdCommand status took 11 milliseconds
Apr 11 11:48:08 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:08 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:08 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 11 11:48:08 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:08 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:08 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:08 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:08 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":119000,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1152 Kbps","isStreaming":false,"title":"Myself at Last","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/02 Myself at Last.wma","trackType":"wma"}
Apr 11 11:48:08 volumiow volumio[999]: verbose: CURRENT POSITION 1
Apr 11 11:48:08 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:08 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus play
Apr 11 11:48:08 volumiow volumio[999]: info: Received an update from plugin. extracting info from payload
Apr 11 11:48:08 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:08 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:08 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:08 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:08 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:08 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:08 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:08 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:08 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:08 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:08 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:08 volumiow volumio[999]: info: ------------------------------ 39ms
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::volumioNext
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::next
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::stop
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::stPlaybackTimer
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::updateTrackBlock
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrackBlock
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::serviceStop
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 1
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::serviceStop
Apr 11 11:48:10 volumiow volumio[999]: info: ControllerMpd::stop
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 11:48:10 volumiow volumio[999]: info:
Apr 11 11:48:10 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand stop took 14 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::play index undefined
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::startPlaybackTimer
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::clearAddPlayTracks NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/03 Cracks in the City.wma
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::updateTrackBlock
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrackBlock
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand status took 1 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand stop took 4 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:10 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Myself at Last","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/02 Myself at Last.wma","trackType":"wma"}
Apr 11 11:48:10 volumiow volumio[999]: verbose: CURRENT POSITION 2
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::syncState stateService stop
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:10 volumiow volumio[999]: info: No code
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:10 volumiow volumio[999]: info: ------------------------------ 24ms
Apr 11 11:48:10 volumiow volumio[999]: info:
Apr 11 11:48:10 volumiow volumio[999]: ---------------------------- MPD announces system playlist update
Apr 11 11:48:10 volumiow volumio[999]: info: Ignoring MPD Status Update
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand clear took 19 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand add "NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/03 Cracks in the City.wma"
Apr 11 11:48:10 volumiow volumio[999]: error: updateQueue error: null
Apr 11 11:48:10 volumiow volumio[999]: info:
Apr 11 11:48:10 volumiow volumio[999]: ---------------------------- MPD announces system playlist update
Apr 11 11:48:10 volumiow volumio[999]: info: Ignoring MPD Status Update
Apr 11 11:48:10 volumiow volumio[999]: info: ------------------------------ 2ms
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand add "NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/03 Cracks in the City.wma" took 1 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 11:48:10 volumiow volumio[999]: info: ------------------------------ 5ms
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand play took 4 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: info:
Apr 11 11:48:10 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:10 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:10 volumiow volumio[999]: info:
Apr 11 11:48:10 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:10 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand status took 12 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand status took 6 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:10 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:10 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cracks in the City","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/03 Cracks in the City.wma","trackType":"wma"}
Apr 11 11:48:10 volumiow volumio[999]: verbose: CURRENT POSITION 2
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 11:48:10 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cracks in the City","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/03 Cracks in the City.wma","trackType":"wma"}
Apr 11 11:48:10 volumiow volumio[999]: verbose: CURRENT POSITION 2
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus play
Apr 11 11:48:10 volumiow volumio[999]: info: Received an update from plugin. extracting info from payload
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:10 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:10 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:10 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:10 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:10 volumiow volumio[999]: info: ------------------------------ 35ms
Apr 11 11:48:10 volumiow volumio[999]: info: ------------------------------ 28ms
Apr 11 11:48:12 volumiow volumio[999]: info: CoreCommandRouter::volumioSeek
Apr 11 11:48:12 volumiow volumio[999]: info: CoreStateMachine::seek
Apr 11 11:48:12 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:12 volumiow volumio[999]: info: TRACKBLOCK {"uri":"music-library/NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/03 Cracks in the City.wma","service":"mpd","name":"3 - Cracks in the City","artist":"Graham Nash","album":"This Path Tonight","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=507&web=Graham%20Nash/This%20Path%20Tonight/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGraham%20Nash%2FThis%20Path%20Tonight&metadata=false","duration":222,"trackType":"wma","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2}
Apr 11 11:48:12 volumiow volumio[999]: info: CoreStateMachine::startPlaybackTimer
Apr 11 11:48:12 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:12 volumiow volumio[999]: info: ControllerMpd::seek
Apr 11 11:48:12 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:12 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:12 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:12 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:12 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:12 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:12 volumiow volumio[999]: error: null
Apr 11 11:48:12 volumiow volumio[999]: info:
Apr 11 11:48:12 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:12 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:12 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:12 volumiow volumio[999]: info: sendMpdCommand status took 2 milliseconds
Apr 11 11:48:12 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:12 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:12 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 11 11:48:12 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:12 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:12 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:12 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:12 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":90000,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1152 Kbps","isStreaming":false,"title":"Cracks in the City","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/03 Cracks in the City.wma","trackType":"wma"}
Apr 11 11:48:12 volumiow volumio[999]: verbose: CURRENT POSITION 2
Apr 11 11:48:12 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:12 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus play
Apr 11 11:48:12 volumiow volumio[999]: info: Received an update from plugin. extracting info from payload
Apr 11 11:48:12 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:12 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:12 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:12 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:12 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:12 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:12 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:12 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:12 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:12 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:12 volumiow volumio[999]: info: ------------------------------ 27ms
Apr 11 11:48:21 volumiow volumio[999]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates.
Apr 11 11:48:21 volumiow volumio[999]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:106:19)
Apr 11 11:48:21 volumiow volumio[999]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:113:37)
Apr 11 11:48:21 volumiow volumio[999]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13
Apr 11 11:48:21 volumiow volumio[999]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Apr 11 11:48:21 volumiow volumio[999]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:144:13)
Apr 11 11:48:21 volumiow volumio[999]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:114:3)
Apr 11 11:48:21 volumiow volumio[999]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Apr 11 11:48:21 volumiow volumio[999]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15
Apr 11 11:48:21 volumiow volumio[999]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14)
Apr 11 11:48:21 volumiow volumio[999]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14)
Apr 11 11:48:21 volumiow volumio[999]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3)
Apr 11 11:48:21 volumiow volumio[999]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10)
Apr 11 11:48:21 volumiow volumio[999]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3)
Apr 11 11:48:21 volumiow volumio[999]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12)
Apr 11 11:48:21 volumiow volumio[999]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Apr 11 11:48:32 volumiow nmbd[681]: [2024/04/11 11:48:32.837076, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 11:48:32 volumiow nmbd[681]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.105 for name WORKGROUP<1d>.
Apr 11 11:48:32 volumiow nmbd[681]: This response was from IP 192.168.5.107, reporting an IP address of 192.168.5.107.
Apr 11 11:48:32 volumiow kernel: perf: interrupt took too long (3932 > 3931), lowering kernel.perf_event_max_sample_rate to 50750
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::volumioNext
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::next
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::stop
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::stPlaybackTimer
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::updateTrackBlock
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrackBlock
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::serviceStop
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 2
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::serviceStop
Apr 11 11:48:36 volumiow volumio[999]: info: ControllerMpd::stop
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 11:48:36 volumiow volumio[999]: info:
Apr 11 11:48:36 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand stop took 12 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::play index undefined
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::startPlaybackTimer
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::clearAddPlayTracks NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/04 Beneath the Waves.wma
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::updateTrackBlock
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrackBlock
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand status took 4 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand stop took 3 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 11:48:36 volumiow volumio[999]: info:
Apr 11 11:48:36 volumiow volumio[999]: ---------------------------- MPD announces system playlist update
Apr 11 11:48:36 volumiow volumio[999]: info: Ignoring MPD Status Update
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand clear took 1 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand add "NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/04 Beneath the Waves.wma"
Apr 11 11:48:36 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cracks in the City","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/03 Cracks in the City.wma","trackType":"wma"}
Apr 11 11:48:36 volumiow volumio[999]: verbose: CURRENT POSITION 3
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::syncState stateService stop
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:36 volumiow volumio[999]: info: No code
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:36 volumiow volumio[999]: info: ------------------------------ 29ms
Apr 11 11:48:36 volumiow volumio[999]: error: updateQueue error: null
Apr 11 11:48:36 volumiow volumio[999]: info:
Apr 11 11:48:36 volumiow volumio[999]: ---------------------------- MPD announces system playlist update
Apr 11 11:48:36 volumiow volumio[999]: info: Ignoring MPD Status Update
Apr 11 11:48:36 volumiow volumio[999]: info: ------------------------------ 26ms
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand add "NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/04 Beneath the Waves.wma" took 26 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 11:48:36 volumiow volumio[999]: info: ------------------------------ 12ms
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand play took 12 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: info:
Apr 11 11:48:36 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:36 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:36 volumiow volumio[999]: info:
Apr 11 11:48:36 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand status took 1 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand status took 18 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 18 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:36 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beneath the Waves","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/04 Beneath the Waves.wma","trackType":"wma"}
Apr 11 11:48:36 volumiow volumio[999]: verbose: CURRENT POSITION 3
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 11:48:36 volumiow volumio[999]: info: ------------------------------ 25ms
Apr 11 11:48:36 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 11 11:48:36 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:36 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beneath the Waves","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/04 Beneath the Waves.wma","trackType":"wma"}
Apr 11 11:48:36 volumiow volumio[999]: verbose: CURRENT POSITION 3
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus play
Apr 11 11:48:36 volumiow volumio[999]: info: Received an update from plugin. extracting info from payload
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:36 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:36 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:36 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:36 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:36 volumiow volumio[999]: info: ------------------------------ 73ms
Apr 11 11:48:38 volumiow volumio[999]: info: CoreCommandRouter::volumioSeek
Apr 11 11:48:38 volumiow volumio[999]: info: CoreStateMachine::seek
Apr 11 11:48:38 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:38 volumiow volumio[999]: info: TRACKBLOCK {"uri":"music-library/NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/04 Beneath the Waves.wma","service":"mpd","name":"4 - Beneath the Waves","artist":"Graham Nash","album":"This Path Tonight","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=507&web=Graham%20Nash/This%20Path%20Tonight/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGraham%20Nash%2FThis%20Path%20Tonight&metadata=false","duration":243,"trackType":"wma","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2}
Apr 11 11:48:38 volumiow volumio[999]: info: CoreStateMachine::startPlaybackTimer
Apr 11 11:48:38 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:38 volumiow volumio[999]: info: ControllerMpd::seek
Apr 11 11:48:38 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:38 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:38 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:38 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:38 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:38 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:38 volumiow volumio[999]: error: null
Apr 11 11:48:38 volumiow volumio[999]: info:
Apr 11 11:48:38 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:38 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:38 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:38 volumiow volumio[999]: info: sendMpdCommand status took 1 milliseconds
Apr 11 11:48:38 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:38 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:38 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 11 11:48:38 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:38 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:38 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:38 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:38 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65000,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1152 Kbps","isStreaming":false,"title":"Beneath the Waves","artist":"Graham Nash","album":"This Path Tonight","uri":"NAS/Akselino2/Music from Bo/Graham Nash/This Path Tonight/04 Beneath the Waves.wma","trackType":"wma"}
Apr 11 11:48:38 volumiow volumio[999]: verbose: CURRENT POSITION 3
Apr 11 11:48:38 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:38 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus play
Apr 11 11:48:38 volumiow volumio[999]: info: Received an update from plugin. extracting info from payload
Apr 11 11:48:38 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:38 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:38 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:38 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:38 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:38 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:38 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:38 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:38 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:38 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:38 volumiow volumio[999]: info: ------------------------------ 16ms
Apr 11 11:48:42 volumiow volumio[999]: info: Executing endpoint metavolumio
Apr 11 11:48:42 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 11 11:48:42 volumiow volumio[999]: info: Executing endpoint metavolumio
Apr 11 11:48:42 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 11 11:48:49 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 11:48:49 volumiow volumio[999]: info: CURURI: genres://Folk/Gretchen%20Peters/Blackbirds
Apr 11 11:48:49 volumiow volumio[999]: info: Preload queue cleared
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/02 Pretty Things.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/03 When All You Got Is a Hammer.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/04 Everything Falls Away.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/05 The House on Auburn Street.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/06 When You Comin' Home.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/07 Jubilee.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/08 Black Ribbons.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/09 Nashville.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/10 The Cure for the Pain.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Preloading song: music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/11 Blackbirds (Reprise).wma
Apr 11 11:48:49 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma in service mpd
Apr 11 11:48:49 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F01%20Blackbirds.wma&metadata=false
Apr 11 11:48:49 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/02 Pretty Things.wma in service mpd
Apr 11 11:48:49 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F02%20Pretty%20Things.wma&metadata=false
Apr 11 11:48:49 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/02 Pretty Things.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:49 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:49 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:49 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:49 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:49 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:49 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:49 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:49 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/03 When All You Got Is a Hammer.wma in service mpd
Apr 11 11:48:49 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F03%20When%20All%20You%20Got%20Is%20a%20Hammer.wma&metadata=false
Apr 11 11:48:49 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/03 When All You Got Is a Hammer.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/04 Everything Falls Away.wma in service mpd
Apr 11 11:48:49 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F04%20Everything%20Falls%20Away.wma&metadata=false
Apr 11 11:48:49 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/04 Everything Falls Away.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/05 The House on Auburn Street.wma in service mpd
Apr 11 11:48:49 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F05%20The%20House%20on%20Auburn%20Street.wma&metadata=false
Apr 11 11:48:49 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/05 The House on Auburn Street.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/06 When You Comin' Home.wma in service mpd
Apr 11 11:48:49 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters%3B%20Jimmy%20LaFave/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F06%20When%20You%20Comin'%20Home.wma&metadata=false
Apr 11 11:48:49 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/06 When You Comin' Home.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/07 Jubilee.wma in service mpd
Apr 11 11:48:49 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F07%20Jubilee.wma&metadata=false
Apr 11 11:48:49 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/07 Jubilee.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/08 Black Ribbons.wma in service mpd
Apr 11 11:48:49 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F08%20Black%20Ribbons.wma&metadata=false
Apr 11 11:48:49 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/08 Black Ribbons.wma
Apr 11 11:48:49 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/09 Nashville.wma in service mpd
Apr 11 11:48:49 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F09%20Nashville.wma&metadata=false
Apr 11 11:48:49 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/09 Nashville.wma
Apr 11 11:48:50 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/10 The Cure for the Pain.wma in service mpd
Apr 11 11:48:50 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F10%20The%20Cure%20for%20the%20Pain.wma&metadata=false
Apr 11 11:48:50 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/10 The Cure for the Pain.wma
Apr 11 11:48:50 volumiow volumio[999]: info: Exploding uri music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/11 Blackbirds (Reprise).wma in service mpd
Apr 11 11:48:50 volumiow volumio[999]: info: ALBUMART /albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds%2F11%20Blackbirds%20(Reprise).wma&metadata=false
Apr 11 11:48:50 volumiow volumio[999]: info: URI /mnt/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/11 Blackbirds (Reprise).wma
Apr 11 11:48:51 volumiow volumio[999]: info: Preload queue cleared
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::ClearQueue
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::stop
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::stPlaybackTimer
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::updateTrackBlock
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrackBlock
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:51 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:51 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::serviceStop
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrack 3
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::serviceStop
Apr 11 11:48:51 volumiow volumio[999]: info: ControllerMpd::stop
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::clearPlayQueue
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::saveQueue
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::volumioPushQueue
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::addQueueItems
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::addQueueItems
Apr 11 11:48:51 volumiow volumio[999]: info: Preload queue cleared
Apr 11 11:48:51 volumiow volumio[999]: info: Adding Item to queue: genres://Folk/Gretchen%20Peters/Blackbirds
Apr 11 11:48:51 volumiow volumio[999]: info: Exploding uri genres://Folk/Gretchen%20Peters/Blackbirds in service mpd
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::volumioPushQueue
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::saveQueue
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::updateTrackBlock
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrackBlock
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::volumioPlay
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::play index 0
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::stop
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::play index undefined
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::startPlaybackTimer
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::clearAddPlayTracks NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 11:48:51 volumiow volumio[999]: info:
Apr 11 11:48:51 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand stop took 30 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand stop took 2 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 11:48:51 volumiow volumio[999]: info:
Apr 11 11:48:51 volumiow volumio[999]: ---------------------------- MPD announces system playlist update
Apr 11 11:48:51 volumiow volumio[999]: info: Ignoring MPD Status Update
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand status took 2 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand clear took 3 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand add "NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma"
Apr 11 11:48:51 volumiow volumio[999]: error: updateQueue error: null
Apr 11 11:48:51 volumiow volumio[999]: info:
Apr 11 11:48:51 volumiow volumio[999]: ---------------------------- MPD announces system playlist update
Apr 11 11:48:51 volumiow volumio[999]: info: Ignoring MPD Status Update
Apr 11 11:48:51 volumiow volumio[999]: info: ------------------------------ 6ms
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand add "NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma" took 4 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 11:48:51 volumiow volumio[999]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 11 11:48:51 volumiow volumio[999]: info: ------------------------------ 10ms
Apr 11 11:48:51 volumiow volumio[999]: info: ------------------------------ 5ms
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand play took 3 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: info:
Apr 11 11:48:51 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:51 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:51 volumiow volumio[999]: info:
Apr 11 11:48:51 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:51 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand status took 3 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand status took 3 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:51 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:51 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Blackbirds","artist":"Gretchen Peters","album":"Blackbirds","uri":"NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma","trackType":"wma"}
Apr 11 11:48:51 volumiow volumio[999]: verbose: CURRENT POSITION 0
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 11:48:51 volumiow volumio[999]: info: ------------------------------ 11ms
Apr 11 11:48:51 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 11 11:48:51 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:51 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:51 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Blackbirds","artist":"Gretchen Peters","album":"Blackbirds","uri":"NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma","trackType":"wma"}
Apr 11 11:48:51 volumiow volumio[999]: verbose: CURRENT POSITION 0
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus play
Apr 11 11:48:51 volumiow volumio[999]: info: Received an update from plugin. extracting info from payload
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:51 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:51 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:51 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:51 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:51 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:51 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:51 volumiow volumio[999]: info: ------------------------------ 20ms
Apr 11 11:48:51 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:51 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint metavolumio
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint metavolumio
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 11 11:48:52 volumiow volumio[999]: info: Executing endpoint metavolumio
Apr 11 11:48:52 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 11 11:48:53 volumiow volumio[999]: info: Executing endpoint metavolumio
Apr 11 11:48:53 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 11 11:48:53 volumiow volumio[999]: info: Executing endpoint metavolumio
Apr 11 11:48:53 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 11 11:48:55 volumiow volumio[999]: info: Executing endpoint metavolumio
Apr 11 11:48:55 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 11 11:48:55 volumiow volumio[999]: info: Executing endpoint metavolumio
Apr 11 11:48:55 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 11 11:48:56 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:56 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:56 volumiow volumio[999]: info: Executing endpoint getSimilarAlbums
Apr 11 11:48:56 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Apr 11 11:48:59 volumiow volumio[999]: info: CoreCommandRouter::volumioSeek
Apr 11 11:48:59 volumiow volumio[999]: info: CoreStateMachine::seek
Apr 11 11:48:59 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:59 volumiow volumio[999]: info: TRACKBLOCK {"uri":"music-library/NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma","service":"mpd","name":"1 - Blackbirds","artist":"Gretchen Peters","album":"Blackbirds","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=507&web=Gretchen%20Peters/Blackbirds/mega&path=%2Fmnt%2FNAS%2FAkselino2%2FMusic%20from%20Bo%2FGretchen%20Peters%2FBlackbirds&metadata=false","duration":273,"trackType":"wma","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2}
Apr 11 11:48:59 volumiow volumio[999]: info: CoreStateMachine::startPlaybackTimer
Apr 11 11:48:59 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:59 volumiow volumio[999]: info: ControllerMpd::seek
Apr 11 11:48:59 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:59 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:59 volumiow volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 11:48:59 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:59 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:59 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:59 volumiow volumio[999]: error: null
Apr 11 11:48:59 volumiow volumio[999]: info:
Apr 11 11:48:59 volumiow volumio[999]: ---------------------------- MPD announces state update: player
Apr 11 11:48:59 volumiow volumio[999]: info: ControllerMpd::getState
Apr 11 11:48:59 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 11:48:59 volumiow volumio[999]: info: sendMpdCommand status took 1 milliseconds
Apr 11 11:48:59 volumiow volumio[999]: verbose: ControllerMpd::parseState
Apr 11 11:48:59 volumiow volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 11:48:59 volumiow volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 11 11:48:59 volumiow volumio[999]: verbose: ControllerMpd::parseTrackInfo
Apr 11 11:48:59 volumiow volumio[999]: info: ControllerMpd::pushState
Apr 11 11:48:59 volumiow volumio[999]: info: CoreCommandRouter::servicePushState
Apr 11 11:48:59 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:59 volumiow volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80000,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1152 Kbps","isStreaming":false,"title":"Blackbirds","artist":"Gretchen Peters","album":"Blackbirds","uri":"NAS/Akselino2/Music from Bo/Gretchen Peters/Blackbirds/01 Blackbirds.wma","trackType":"wma"}
Apr 11 11:48:59 volumiow volumio[999]: verbose: CURRENT POSITION 0
Apr 11 11:48:59 volumiow volumio[999]: info: CoreStateMachine::syncState stateService play
Apr 11 11:48:59 volumiow volumio[999]: info: CoreStateMachine::syncState currentStatus play
Apr 11 11:48:59 volumiow volumio[999]: info: Received an update from plugin. extracting info from payload
Apr 11 11:48:59 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:59 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:59 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:59 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:59 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:59 volumiow volumio[999]: info: CoreStateMachine::pushState
Apr 11 11:48:59 volumiow volumio[999]: info: CorePlayQueue::getTrack 0
Apr 11 11:48:59 volumiow volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 11 11:48:59 volumiow volumio[999]: info: MRS: Pushing multiroomSync output update for this device
Apr 11 11:48:59 volumiow volumio[999]: info: MRS: Pushing multiroomSync output
Apr 11 11:48:59 volumiow volumio[999]: info: ------------------------------ 48ms
Apr 11 11:48:59 volumiow volumio[999]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 11:48:59 volumiow volumio[999]: Error: connect ETIMEDOUT 146.75.74.79:443
Apr 11 11:48:59 volumiow volumio[999]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Apr 11 11:48:59 volumiow volumio[999]: errno: -110,
Apr 11 11:48:59 volumiow volumio[999]: code: 'ETIMEDOUT',
Apr 11 11:48:59 volumiow volumio[999]: syscall: 'connect',
Apr 11 11:48:59 volumiow volumio[999]: address: '146.75.74.79',
Apr 11 11:48:59 volumiow volumio[999]: port: 443
Apr 11 11:48:59 volumiow volumio[999]: }
Apr 11 11:48:59 volumiow volumio[999]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 11:49:00 volumiow sudo[3650]: volumio : unable to resolve host volumiow
Apr 11 11:49:00 volumiow sudo[3650]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Apr 11 11:49:00 volumiow sudo[3650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-11 11:48
Apr 11 11:49:00 volumiow sudo[3650]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET"
VOLUMIO_VERSION="3.634"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"