-- Logs begin at Thu 2024-04-25 14:02:08 CEST, end at Sun 2024-04-28 13:10:58 CEST. --
Apr 28 13:09:02 volumio volumio[856]: info: Preload queue cleared
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::ClearQueue
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::stop
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::getTrack 1
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:02 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:02 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::serviceStop
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::getTrack 1
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::serviceStop
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:09:02 volumio volumio[856]: info: ControllerMpd::stop
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::clearPlayQueue
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::saveQueue
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::addQueueItems
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::addQueueItems
Apr 28 13:09:02 volumio volumio[856]: info: Preload queue cleared
Apr 28 13:09:02 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream
Apr 28 13:09:02 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::saveQueue
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::play index 0
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::stop
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::play index undefined
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:02 volumio volumio[856]: info: [bandcamp-play] clearAddPlayTrack: bandcamp/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends@artistUrl=https%3A%2F%2Fdaevidallen.bandcamp.com@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 28 13:09:02 volumio volumio[856]: info:
Apr 28 13:09:02 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand stop took 16 milliseconds
Apr 28 13:09:02 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand stop took 6 milliseconds
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand clear
Apr 28 13:09:02 volumio volumio[856]: info:
Apr 28 13:09:02 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:02 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand status took 8 milliseconds
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand clear took 8 milliseconds
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand addid "https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3"
Apr 28 13:09:02 volumio volumio[856]: error: updateQueue error: null
Apr 28 13:09:02 volumio volumio[856]: info:
Apr 28 13:09:02 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:02 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:02 volumio volumio[856]: info: ------------------------------ 4ms
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand addid "https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3" took 3 milliseconds
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:02 volumio volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 28 13:09:02 volumio volumio[856]: verbose: MPD COMMAND [object Object]
Apr 28 13:09:02 volumio volumio[856]: verbose: MPD COMMAND [object Object]
Apr 28 13:09:02 volumio volumio[856]: verbose: MPD COMMAND [object Object]
Apr 28 13:09:02 volumio volumio[856]: info: ------------------------------ 15ms
Apr 28 13:09:02 volumio volumio[856]: info:
Apr 28 13:09:02 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:02 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:02 volumio volumio[856]: info: ------------------------------ 6ms
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 28 13:09:02 volumio volumio[856]: info: ------------------------------ 2ms
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand play took 2 milliseconds
Apr 28 13:09:02 volumio volumio[856]: info:
Apr 28 13:09:02 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:02 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:02 volumio volumio[856]: info: FusionDsp - ---- read samplerate, raw:
Apr 28 13:09:02 volumio volumio[856]: error: FusionDsp - invalid sample rate
Apr 28 13:09:02 volumio volumio[856]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 28 13:09:02 volumio volumio[856]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 28 13:09:02 volumio volumio[856]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 28 13:09:02 volumio volumio[856]: info:
Apr 28 13:09:02 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:02 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:02 volumio volumio[856]: info:
Apr 28 13:09:02 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand status took 26 milliseconds
Apr 28 13:09:02 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:02 volumio volumio[856]: info: ------------------------------ 13ms
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand status took 5 milliseconds
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:02 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:02 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:02 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 28 13:09:02 volumio volumio[856]: info: ------------------------------ 43ms
Apr 28 13:09:02 volumio volumio[856]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 28 13:09:02 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:02 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:02 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:02 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:02 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 28 13:09:02 volumio volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:02 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:02 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:02 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:02 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:02 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:02 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:02 volumio volumio[856]: info: ------------------------------ 39ms
Apr 28 13:09:02 volumio volumio[856]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Apr 28 13:09:30 volumio volumio[856]: info: Preload queue cleared
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::ClearQueue
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::stop
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::serviceStop
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::serviceStop
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:09:30 volumio volumio[856]: info: ControllerMpd::stop
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::clearPlayQueue
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::saveQueue
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::addQueueItems
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::addQueueItems
Apr 28 13:09:30 volumio volumio[856]: info: Preload queue cleared
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fhigh-points
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fhigh-points
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fbrothers
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fbrothers
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fbig-daddy
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fbig-daddy
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fwotsa-use
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fwotsa-use
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fgarden-song
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fgarden-song
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fcame-to-find-you
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fcame-to-find-you
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fthe-rapist
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fthe-rapist
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fsittin-in-a-teashop
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fsittin-in-a-teashop
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Ffire-becomes-her
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Ffire-becomes-her
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fno-ones-slave
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fno-ones-slave
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Ftor-song
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Ftor-song
Apr 28 13:09:30 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends-2
Apr 28 13:09:30 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends-2
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::saveQueue
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::play index 0
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::stop
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::play index undefined
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:30 volumio volumio[856]: info: [bandcamp-play] clearAddPlayTrack: bandcamp/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends@artistUrl=https%3A%2F%2Fdaevidallen.bandcamp.com@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream
Apr 28 13:09:30 volumio volumio[856]: info:
Apr 28 13:09:30 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand stop took 24 milliseconds
Apr 28 13:09:30 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand status took 4 milliseconds
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:30 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:30 volumio volumio[856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current bandcamp Received mpd
Apr 28 13:09:30 volumio volumio[856]: info: ------------------------------ 16ms
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand stop took 2 milliseconds
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand clear
Apr 28 13:09:30 volumio volumio[856]: info:
Apr 28 13:09:30 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:30 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand clear took 0 milliseconds
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand addid "https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3"
Apr 28 13:09:30 volumio volumio[856]: error: updateQueue error: null
Apr 28 13:09:30 volumio volumio[856]: info:
Apr 28 13:09:30 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:30 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:30 volumio volumio[856]: info: ------------------------------ 3ms
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand addid "https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3" took 2 milliseconds
Apr 28 13:09:30 volumio volumio[856]: verbose: MPD COMMAND [object Object]
Apr 28 13:09:30 volumio volumio[856]: verbose: MPD COMMAND [object Object]
Apr 28 13:09:30 volumio volumio[856]: verbose: MPD COMMAND [object Object]
Apr 28 13:09:30 volumio volumio[856]: info:
Apr 28 13:09:30 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:30 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:30 volumio volumio[856]: info: ------------------------------ 2ms
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 28 13:09:30 volumio volumio[856]: info: ------------------------------ 2ms
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand play took 1 milliseconds
Apr 28 13:09:30 volumio volumio[856]: info:
Apr 28 13:09:30 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:30 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:30 volumio volumio[856]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 28 13:09:30 volumio volumio[856]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 28 13:09:30 volumio volumio[856]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 28 13:09:30 volumio volumio[856]: info:
Apr 28 13:09:30 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand status took 24 milliseconds
Apr 28 13:09:30 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:30 volumio volumio[856]: info:
Apr 28 13:09:30 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:30 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:30 volumio volumio[856]: info:
Apr 28 13:09:30 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:30 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand status took 4 milliseconds
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:30 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:30 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:30 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 28 13:09:30 volumio volumio[856]: info: ------------------------------ 35ms
Apr 28 13:09:30 volumio volumio[856]: info: ------------------------------ 7ms
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand status took 6 milliseconds
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:30 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:30 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1051,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:30 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 28 13:09:30 volumio volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:30 volumio volumio[856]: info: ------------------------------ 31ms
Apr 28 13:09:30 volumio volumio[856]: info: sendMpdCommand playlistinfo took 20 milliseconds
Apr 28 13:09:30 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:30 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:30 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:30 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1188,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:30 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 28 13:09:30 volumio volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:30 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:30 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:30 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:30 volumio volumio[856]: info: ------------------------------ 44ms
Apr 28 13:09:30 volumio volumio[856]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Apr 28 13:09:35 volumio volumio[856]: info: Preload queue cleared
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::ClearQueue
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::stop
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:35 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:35 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::serviceStop
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::serviceStop
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:09:35 volumio volumio[856]: info: ControllerMpd::stop
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::clearPlayQueue
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::saveQueue
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::addQueueItems
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::addQueueItems
Apr 28 13:09:35 volumio volumio[856]: info: Preload queue cleared
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fhigh-points
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fhigh-points
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fbrothers
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fbrothers
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fbig-daddy
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fbig-daddy
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fwotsa-use
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fwotsa-use
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fgarden-song
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fgarden-song
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fcame-to-find-you
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fcame-to-find-you
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fthe-rapist
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fthe-rapist
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fsittin-in-a-teashop
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fsittin-in-a-teashop
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Ffire-becomes-her
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Ffire-becomes-her
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fno-ones-slave
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fno-ones-slave
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Ftor-song
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Ftor-song
Apr 28 13:09:35 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends-2
Apr 28 13:09:35 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends-2
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::saveQueue
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::play index 0
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::stop
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::play index undefined
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:35 volumio volumio[856]: info: [bandcamp-play] clearAddPlayTrack: bandcamp/track@trackUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Ftrack%2Fdear-friends@artistUrl=https%3A%2F%2Fdaevidallen.bandcamp.com@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 28 13:09:35 volumio volumio[856]: info:
Apr 28 13:09:35 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand stop took 19 milliseconds
Apr 28 13:09:35 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand stop took 6 milliseconds
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand clear
Apr 28 13:09:35 volumio volumio[856]: info:
Apr 28 13:09:35 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:35 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand status took 6 milliseconds
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand clear took 5 milliseconds
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand addid "https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3"
Apr 28 13:09:35 volumio volumio[856]: error: updateQueue error: null
Apr 28 13:09:35 volumio volumio[856]: info:
Apr 28 13:09:35 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:35 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:35 volumio volumio[856]: info: ------------------------------ 4ms
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand addid "https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3" took 6 milliseconds
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:35 volumio volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 28 13:09:35 volumio volumio[856]: verbose: MPD COMMAND [object Object]
Apr 28 13:09:35 volumio volumio[856]: verbose: MPD COMMAND [object Object]
Apr 28 13:09:35 volumio volumio[856]: info: ------------------------------ 15ms
Apr 28 13:09:35 volumio volumio[856]: info:
Apr 28 13:09:35 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:35 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:35 volumio volumio[856]: info: ------------------------------ 10ms
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 28 13:09:35 volumio volumio[856]: info: ------------------------------ 3ms
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand play took 2 milliseconds
Apr 28 13:09:35 volumio volumio[856]: info:
Apr 28 13:09:35 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:35 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:35 volumio volumio[856]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 28 13:09:35 volumio volumio[856]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 28 13:09:35 volumio volumio[856]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 28 13:09:35 volumio volumio[856]: info:
Apr 28 13:09:35 volumio volumio[856]: ---------------------------- MPD announces system playlist update
Apr 28 13:09:35 volumio volumio[856]: info: Ignoring MPD Status Update
Apr 28 13:09:35 volumio volumio[856]: info:
Apr 28 13:09:35 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand status took 22 milliseconds
Apr 28 13:09:35 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:35 volumio volumio[856]: info: ------------------------------ 8ms
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand status took 6 milliseconds
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:35 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:35 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:35 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 28 13:09:35 volumio volumio[856]: info: ------------------------------ 48ms
Apr 28 13:09:35 volumio volumio[856]: info: sendMpdCommand playlistinfo took 13 milliseconds
Apr 28 13:09:35 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:35 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:35 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:35 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1222,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:35 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 28 13:09:35 volumio volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:35 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:35 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:35 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:35 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:35 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:35 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:35 volumio volumio[856]: info: ------------------------------ 56ms
Apr 28 13:09:35 volumio volumio[856]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Apr 28 13:09:38 volumio volumio[856]: info: CoreCommandRouter::volumioPause
Apr 28 13:09:38 volumio volumio[856]: info: CoreStateMachine::pause
Apr 28 13:09:38 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 28 13:09:38 volumio volumio[856]: info: CoreStateMachine::servicePause
Apr 28 13:09:38 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:38 volumio volumio[856]: info: CoreCommandRouter::servicePause
Apr 28 13:09:38 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:09:38 volumio volumio[856]: info: ControllerMpd::pause
Apr 28 13:09:38 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand pause
Apr 28 13:09:38 volumio volumio[856]: info:
Apr 28 13:09:38 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:38 volumio volumio[856]: info: sendMpdCommand pause took 2 milliseconds
Apr 28 13:09:38 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:38 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:38 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds
Apr 28 13:09:38 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:38 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:38 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 28 13:09:38 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:38 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:38 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:38 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:38 volumio volumio[856]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4354,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:38 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:38 volumio volumio[856]: info: CoreStateMachine::syncState stateService pause
Apr 28 13:09:38 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus pause
Apr 28 13:09:38 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:38 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:38 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:38 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:38 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:38 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 28 13:09:38 volumio volumio[856]: info: ------------------------------ 11ms
Apr 28 13:09:39 volumio volumio[856]: info: camilladsp spawned new process with pid 3186, instance 1, run: true
Apr 28 13:09:39 volumio volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 28 13:09:39 volumio volumio[856]: info: CoreStateMachine::play index undefined
Apr 28 13:09:39 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:09:39 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:39 volumio volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 28 13:09:39 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:39 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:09:39 volumio volumio[856]: info: ControllerMpd::resume
Apr 28 13:09:39 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 28 13:09:39 volumio volumio[856]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 28 13:09:39 volumio volumio[856]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 28 13:09:39 volumio volumio[856]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 28 13:09:39 volumio volumio[856]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 28 13:09:39 volumio volumio[856]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 28 13:09:39 volumio volumio[856]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 28 13:09:39 volumio volumio[856]: info:
Apr 28 13:09:39 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:39 volumio volumio[856]: info: sendMpdCommand play took 22 milliseconds
Apr 28 13:09:39 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:39 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:39 volumio volumio[856]: info: sendMpdCommand status took 2 milliseconds
Apr 28 13:09:39 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:39 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:39 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 28 13:09:39 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:39 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:39 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:39 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:39 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5600,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:39 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:39 volumio volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 28 13:09:39 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus pause
Apr 28 13:09:39 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:39 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:39 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:39 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:39 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:39 volumio volumio[856]: info: ------------------------------ 12ms
Apr 28 13:09:39 volumio volumio[856]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Apr 28 13:09:39 volumio volumio[856]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Apr 28 13:09:42 volumio volumio[856]: info: CoreCommandRouter::volumioPause
Apr 28 13:09:42 volumio volumio[856]: info: CoreStateMachine::pause
Apr 28 13:09:42 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 28 13:09:42 volumio volumio[856]: info: CoreStateMachine::servicePause
Apr 28 13:09:42 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:42 volumio volumio[856]: info: CoreCommandRouter::servicePause
Apr 28 13:09:42 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:09:42 volumio volumio[856]: info: ControllerMpd::pause
Apr 28 13:09:42 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand pause
Apr 28 13:09:42 volumio volumio[856]: info:
Apr 28 13:09:42 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:09:42 volumio volumio[856]: info: sendMpdCommand pause took 1 milliseconds
Apr 28 13:09:42 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:09:42 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:09:42 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds
Apr 28 13:09:42 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:09:42 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:09:42 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 28 13:09:42 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:09:42 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:09:42 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:09:42 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:09:42 volumio volumio[856]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9851,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:09:42 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:09:42 volumio volumio[856]: info: CoreStateMachine::syncState stateService pause
Apr 28 13:09:42 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus pause
Apr 28 13:09:42 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:09:42 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:09:42 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:09:42 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:09:42 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:09:42 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 28 13:09:42 volumio volumio[856]: info: ------------------------------ 12ms
Apr 28 13:09:43 volumio volumio[856]: info: camilladsp spawned new process with pid 3207, instance 1, run: true
Apr 28 13:10:03 volumio volumio[856]: info: CoreCommandRouter::volumioAddQueueItems
Apr 28 13:10:03 volumio volumio[856]: info: CoreStateMachine::addQueueItems
Apr 28 13:10:03 volumio volumio[856]: info: CorePlayQueue::addQueueItems
Apr 28 13:10:03 volumio volumio[856]: info: Preload queue cleared
Apr 28 13:10:03 volumio volumio[856]: info: Adding Item to queue: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream
Apr 28 13:10:03 volumio volumio[856]: info: Using cached record of: bandcamp/search@query=Daevid%20allen@itemType=ArtistsAndLabels@combinedSearch=1/band@bandUrl=https%3A%2F%2Fdaevidallen.bandcamp.com/band@bandUrl=https%3A%2F%2Fflamedogrecords.bandcamp.com/album@albumUrl=https%3A%2F%2Fdaevidallen.bandcamp.com%2Falbum%2Fdreamin-a-dream
Apr 28 13:10:03 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 28 13:10:03 volumio volumio[856]: info: CorePlayQueue::saveQueue
Apr 28 13:10:03 volumio volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 28 13:10:03 volumio volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 28 13:10:17 volumio volumio[856]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 28 13:10:18 volumio volumio[856]: xcb_connection_has_error() returned true
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 28 13:10:18 volumio volumio[856]: xcb_connection_has_error() returned true
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 28 13:10:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 28 13:10:44 volumio volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 28 13:10:44 volumio volumio[856]: info: CoreStateMachine::play index undefined
Apr 28 13:10:44 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 28 13:10:44 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:10:44 volumio volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 28 13:10:44 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:10:44 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 28 13:10:44 volumio volumio[856]: info: ControllerMpd::resume
Apr 28 13:10:44 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 28 13:10:44 volumio volumio[856]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 28 13:10:44 volumio volumio[856]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 28 13:10:44 volumio volumio[856]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 28 13:10:44 volumio volumio[856]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 28 13:10:44 volumio volumio[856]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 28 13:10:44 volumio volumio[856]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 28 13:10:44 volumio volumio[856]: info:
Apr 28 13:10:44 volumio volumio[856]: ---------------------------- MPD announces state update: player
Apr 28 13:10:44 volumio volumio[856]: info: sendMpdCommand play took 17 milliseconds
Apr 28 13:10:44 volumio volumio[856]: info: ControllerMpd::getState
Apr 28 13:10:44 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 28 13:10:44 volumio volumio[856]: info: sendMpdCommand status took 2 milliseconds
Apr 28 13:10:44 volumio volumio[856]: verbose: ControllerMpd::parseState
Apr 28 13:10:44 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 28 13:10:44 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 28 13:10:44 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 28 13:10:44 volumio volumio[856]: info: ControllerMpd::pushState
Apr 28 13:10:44 volumio volumio[856]: info: CoreCommandRouter::servicePushState
Apr 28 13:10:44 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 28 13:10:44 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11097,"duration":122,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dear Friends","artist":"Daevid Allen","album":"Dreamin' a Dream","uri":"https://t4.bcbits.com/stream/d57b03154ec67e0b7536337a63aa4262/mp3-128/121912308?p=0&ts=1714388641&t=c6f2130a0a9772d8842145200b9dbbcd8abd0902&token=1714388641_07feff18101707dbb1106200d2f51b88b583c079&t.mp3","trackType":"mp3"}
Apr 28 13:10:44 volumio volumio[856]: verbose: CURRENT POSITION 0
Apr 28 13:10:44 volumio volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 28 13:10:44 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus pause
Apr 28 13:10:44 volumio volumio[856]: info: CoreStateMachine::pushState
Apr 28 13:10:44 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 13:10:44 volumio volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 28 13:10:44 volumio volumio[856]: info: MRS: Pushing multiroomSync output update for this device
Apr 28 13:10:44 volumio volumio[856]: info: MRS: Pushing multiroomSync output
Apr 28 13:10:44 volumio volumio[856]: info: ------------------------------ 17ms
Apr 28 13:10:44 volumio volumio[856]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Apr 28 13:10:44 volumio volumio[856]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Apr 28 13:10:58 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay
Apr 28 13:10:58 volumio volumio[856]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom
Apr 28 13:10:58 volumio volumio[856]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 28 13:10:58 volumio volumio[856]: TypeError: Cannot read property 'then' of undefined
Apr 28 13:10:58 volumio volumio[856]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9)
Apr 28 13:10:58 volumio volumio[856]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2249:30)
Apr 28 13:10:58 volumio volumio[856]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1411:26)
Apr 28 13:10:58 volumio volumio[856]: at Socket.emit (events.js:400:28)
Apr 28 13:10:58 volumio volumio[856]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 28 13:10:58 volumio volumio[856]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 28 13:10:58 volumio volumio[856]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 28 13:10:58 volumio sudo[3471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-28 13:09
Apr 28 13:10:58 volumio sudo[3471]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:15:21 AM CET"
VOLUMIO_VERSION="3.629"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_DEVICENAME="Asus Tinkerboard"
VOLUMIO_HASH="293a767fd1b71cabc5f5be4916f770a0"