-- Logs begin at Wed 2022-01-05 21:09:03 MST. --
Jan 06 10:42:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:42 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:42 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:42 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:42] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:42:44 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:44 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:44 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:44 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:44 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:44] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:42:46 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:46 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:46 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:46 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:46 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:46] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:47 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:47] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:42:47 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:47] "GET /play/pandora/stationToken=4058670268554901831 HTTP/1.1" 308 -
Jan 06 10:42:47 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:47] "GET /save/INXS%20Radio HTTP/1.1" 200 -
Jan 06 10:42:47 volumio3 volumio[999]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.26.0 Total Clients: 7
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioClearQueue
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::ClearQueue
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::stop
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 06 10:42:47 volumio3 volumio[999]: verbose: UNSET VOLATILE
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::stPlaybackTimer
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::updateTrackBlock
Jan 06 10:42:47 volumio3 volumio[999]: info: CorePlayQueue::getTrackBlock
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:42:47 volumio3 volumio[999]: info: CorePlayQueue::getTrack 10
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::serviceStop
Jan 06 10:42:47 volumio3 volumio[999]: info: CorePlayQueue::getTrack 10
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::serviceStop
Jan 06 10:42:47 volumio3 volumio[999]: info: [1641490967953] ControllerPandora::stop
Jan 06 10:42:47 volumio3 volumio[999]: info: ControllerMpd::stop
Jan 06 10:42:47 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Jan 06 10:42:47 volumio3 volumio[999]: info: CorePlayQueue::clearPlayQueue
Jan 06 10:42:47 volumio3 volumio[999]: info: CorePlayQueue::saveQueue
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushQueue
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: pandora , handleBrowseUri
Jan 06 10:42:47 volumio3 volumio[999]: info: [1641490967969] ControllerPandora::handleBrowseUri
Jan 06 10:42:47 volumio3 volumio[999]: info: [1641490967969] ControllerPandora::checkForExpiredStations
Jan 06 10:42:47 volumio3 volumio[999]: info: [1641490967969] [Pandora] checkForExpiredStations: Stations expired
Jan 06 10:42:47 volumio3 volumio[999]: info: [1641490967969] ControllerPandora::PandoraHandler::fillStationData
Jan 06 10:42:47 volumio3 volumio[999]: info:
Jan 06 10:42:47 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:42:47 volumio3 volumio[999]: info: sendMpdCommand stop took 39 milliseconds
Jan 06 10:42:47 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:42:47 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:42:47 volumio3 volumio[999]: info: [1641490967994] ControllerPandora::pushState
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:42:47 volumio3 volumio[999]: info: CorePlayQueue::getTrack 10
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:47 volumio3 volumio[999]: info: CorePlayQueue::getTrack 10
Jan 06 10:42:47 volumio3 volumio[999]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Bring Her Back","name":"Bring Her Back","artist":"Kadie Elder","album":"B O Y","albumart":"http://mediaserver-cont-dc6-1-v4v6.pandora.com/images/public/int/3/0/0/9/190374319003_500W_500H.jpg","realUri":"http://t3-1.p-cdn.us/access/4981172033631916656.mp3?version=5&lid=27752775&token=0uLYGd%2Bg9qMEh5F9ojveOMELdJvwrvZPFj8rTfuDke2Ol66D%2FzdKpDHFLlz1BFSuvRvqD4HSe%2FeaP0yryNOI8W3RcA211FuUA0w2DRPJ2oqmKlFCmDFMwteeF2hZB%2Ftnpm5%2FdNbK34sAPDnWXOUzzCPXrx1vHRqwxRHCQSUbfQCU0YNN1DYq9fvYMF6KjCe7TI4GinccfvheJvDvmW52Bm9rDx%2FcR1Rj62xvjdeyxbNj7cZ8zHc36k9yhrepspM85S%2BcbYIiK5AbeRaXvENL6ZQjp05tle7JKMi7XVkvsePs05aJ3c%2FYz6cxBZSKeFQqqdf8BypyQnqjTRCV1QobYg%3D%3D","isStreaming":true,"duration":221,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t3-1.p-cdn.us/access/4981172033631916656.mp3?version=5&lid=27752775&token=0uLYGd%2Bg9qMEh5F9ojveOMELdJvwrvZPFj8rTfuDke2Ol66D%2FzdKpDHFLlz1BFSuvRvqD4HSe%2FeaP0yryNOI8W3RcA211FuUA0w2DRPJ2oqmKlFCmDFMwteeF2hZB%2Ftnpm5%2FdNbK34sAPDnWXOUzzCPXrx1vHRqwxRHCQSUbfQCU0YNN1DYq9fvYMF6KjCe7TI4GinccfvheJvDvmW52Bm9rDx%2FcR1Rj62xvjdeyxbNj7cZ8zHc36k9yhrepspM85S%2BcbYIiK5AbeRaXvENL6ZQjp05tle7JKMi7XVkvsePs05aJ3c%2FYz6cxBZSKeFQqqdf8BypyQnqjTRCV1QobYg%3D%3D","seek":0,"status":"stop"}
Jan 06 10:42:47 volumio3 volumio[999]: verbose: CURRENT POSITION 10
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::syncState   stateService stop
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::syncState   currentStatus stop
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:42:47 volumio3 volumio[999]: info: CorePlayQueue::getTrack 10
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:42:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:48 volumio3 volumio[999]: info: No code
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CorePlayQueue::getTrack 10
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService pandora
Jan 06 10:42:48 volumio3 volumio[999]: info: sendMpdCommand status took 12 milliseconds
Jan 06 10:42:48 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:42:48 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:42:48 volumio3 volumio[999]: info:
Jan 06 10:42:48 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:42:48 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:42:48 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:42:48 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 06 10:42:48 volumio3 volumio[999]: info: sendMpdCommand status took 3 milliseconds
Jan 06 10:42:48 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:42:48 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:42:48 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:42:48 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CorePlayQueue::getTrack 10
Jan 06 10:42:48 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:42:48 volumio3 volumio[999]: info: ------------------------------ 27ms
Jan 06 10:42:48 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 06 10:42:48 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:42:48 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:48 volumio3 volumio[999]: info: CorePlayQueue::getTrack 10
Jan 06 10:42:48 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:42:48 volumio3 volumio[999]: info: ------------------------------ 22ms
Jan 06 10:42:48 volumio3 volumio[999]: info: [1641490968176] ControllerPandora::PandoraHandler::fillStationData
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:48 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:48 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:48 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:48] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:42:48 volumio3 volumio[999]: info: [1641490968334] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969037] [Pandora] PandoraHandler::fetchTracks::fetchStationPlaylist: Retrieved INXS Radio playlist
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969037] ControllerPandora::PandoraHandler::fetchTracks::fillNewTracks
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969038] [Pandora] PandoraHandler::fetchTracks::fillNewTracks: Fetched 4 track(s)
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::addQueueItems
Jan 06 10:42:49 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=4629897794771348646
Jan 06 10:42:49 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=4629897794771348646 in service pandora
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969039] ControllerPandora::explodeUri
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=2800899542269696558
Jan 06 10:42:49 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=2800899542269696558 in service pandora
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969040] ControllerPandora::explodeUri
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=6885640622819016858
Jan 06 10:42:49 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=6885640622819016858 in service pandora
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969040] ControllerPandora::explodeUri
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=3616609269250377549
Jan 06 10:42:49 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=3616609269250377549 in service pandora
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969040] ControllerPandora::explodeUri
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::saveQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::updateTrackBlock
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrackBlock
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::play index 0
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::stop
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 06 10:42:49 volumio3 volumio[999]: verbose: UNSET VOLATILE
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::play index undefined
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::startPlaybackTimer
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969052] ControllerPandora::clearAddPlayTrack
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::clear
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand clear
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:42:49 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand clear took 5 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969058] ControllerPandora::checkForExpiredStations
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969058] ControllerPandora::removeTrack
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969058] [Pandora] removeTrack: Not removing track with uri: null at queue index: -1
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969059] ControllerPandora::appendTracksToMpd
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969059] [Pandora] appendTracksToMpd: Added 1 track(s) to mpd
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand addid
Jan 06 10:42:49 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:49] "GET /play/pandora/stationToken%3D4058670268554901831/ HTTP/1.1" 200 -
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand play
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:42:49 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:42:49 volumio3 volumio[999]: error: updateQueue error: null
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:42:49 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 11ms
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand addid took 7 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand play took 7 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 6ms
Jan 06 10:42:49 volumio3 volumio[999]: verbose: MPD COMMAND [object Object]
Jan 06 10:42:49 volumio3 volumio[999]: verbose: MPD COMMAND [object Object]
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969069] ControllerPandora::pushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"(Keep Feeling) Fascination (Remastered)","name":"(Keep Feeling) Fascination (Remastered)","artist":"The Human League","album":"The Very Best Of The Human League","albumart":"http://cont-3.p-cdn.us/images/05/fe/c1/fc/c28347b2a64a259a05d25e21/1080W_1080H.jpg","realUri":"http://t1-3.p-cdn.us/access/4629897794771348646.mp3?version=5&lid=27752775&token=yXrpMGw3SGbYrr7DbIw0jHxLxOmB3pIXYrEYs%2FtwrII9nTmUScJdQg%2F3Yi3pSNC0PK5YluKYE2vH5wrC7sTvDz9R7t7n%2F3cVDorLhIxWRWa565JFtpe3nyswhtZwUEOdMfyk%2BrF8FRi%2BhZq%2BJQQFpGCnQwGXDFsZ4ekWPAqEZmx55Bg7Aclced9zG9877nLuxdgXfw8ap3VzWcHjr23oSCla6C2C4ANJYVAv1OjW2Zq9R3RS7mvJcghhZiXOGv2KY3dNPVt%2FsZIo5ZgTPia2NJvRKsnLv0c7I0Aninbspjlnzbf0ghMkQ1HcQLt7mBBLrPfvbRZUk9u0mxsHg8JVkg%3D%3D","isStreaming":true,"duration":223,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-3.p-cdn.us/access/4629897794771348646.mp3?version=5&lid=27752775&token=yXrpMGw3SGbYrr7DbIw0jHxLxOmB3pIXYrEYs%2FtwrII9nTmUScJdQg%2F3Yi3pSNC0PK5YluKYE2vH5wrC7sTvDz9R7t7n%2F3cVDorLhIxWRWa565JFtpe3nyswhtZwUEOdMfyk%2BrF8FRi%2BhZq%2BJQQFpGCnQwGXDFsZ4ekWPAqEZmx55Bg7Aclced9zG9877nLuxdgXfw8ap3VzWcHjr23oSCla6C2C4ANJYVAv1OjW2Zq9R3RS7mvJcghhZiXOGv2KY3dNPVt%2FsZIo5ZgTPia2NJvRKsnLv0c7I0Aninbspjlnzbf0ghMkQ1HcQLt7mBBLrPfvbRZUk9u0mxsHg8JVkg%3D%3D","seek":0,"status":"play"}
Jan 06 10:42:49 volumio3 volumio[999]: verbose: CURRENT POSITION 0
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::syncState   stateService play
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::syncState   currentStatus stop
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService pandora
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969078] ControllerPandora::fetchAndAddTracks
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969078] ControllerPandora::getStationTracks
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969079] [Pandora] PandoraHandler::getSongMaxDiff: -12
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969079] ControllerPandora::fetchAndAddTracks::getSqInfo
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969079] ControllerPandora::getStationTracks
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969079] [Pandora] fetchAndAddTracks: diff1: -12 sQPos1: 0
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969079] [Pandora] fetchAndAddTracks: Fetching tracks
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969079] ControllerPandora::PandoraHandler::fillStationData
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:42:49 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:42:49 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 21ms
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 6ms
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:42:49 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 7ms
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 5ms
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969139] ControllerPandora::pandoraListener
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand status took 6 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand status took 8 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand status took 7 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969151] ControllerPandora::pushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"(Keep Feeling) Fascination (Remastered)","artist":"The Human League","album":"The Very Best Of The Human League","uri":"http://t1-3.p-cdn.us/access/4629897794771348646.mp3?version=5&lid=27752775&token=yXrpMGw3SGbYrr7DbIw0jHxLxOmB3pIXYrEYs%2FtwrII9nTmUScJdQg%2F3Yi3pSNC0PK5YluKYE2vH5wrC7sTvDz9R7t7n%2F3cVDorLhIxWRWa565JFtpe3nyswhtZwUEOdMfyk%2BrF8FRi%2BhZq%2BJQQFpGCnQwGXDFsZ4ekWPAqEZmx55Bg7Aclced9zG9877nLuxdgXfw8ap3VzWcHjr23oSCla6C2C4ANJYVAv1OjW2Zq9R3RS7mvJcghhZiXOGv2KY3dNPVt%2FsZIo5ZgTPia2NJvRKsnLv0c7I0Aninbspjlnzbf0ghMkQ1HcQLt7mBBLrPfvbRZUk9u0mxsHg8JVkg%3D%3D","trackType":"mp3"}
Jan 06 10:42:49 volumio3 volumio[999]: verbose: CURRENT POSITION 0
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::syncState   stateService play
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::syncState   currentStatus play
Jan 06 10:42:49 volumio3 volumio[999]: info: Received an update from plugin. extracting info from payload
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService pandora
Jan 06 10:42:49 volumio3 volumio[999]: info:
Jan 06 10:42:49 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand status took 15 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand status took 2 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 27ms
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 25ms
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:42:49 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:42:49 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:42:49 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 23ms
Jan 06 10:42:49 volumio3 volumio[999]: info: ------------------------------ 10ms
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969265] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969980] [Pandora] PandoraHandler::fetchTracks::fetchStationPlaylist: Retrieved INXS Radio playlist
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969981] ControllerPandora::PandoraHandler::fetchTracks::fillNewTracks
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969981] [Pandora] PandoraHandler::fetchTracks::fillNewTracks: Fetched 4 track(s)
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::addQueueItems
Jan 06 10:42:49 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=4434805491176379474
Jan 06 10:42:49 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=4434805491176379474 in service pandora
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969982] ControllerPandora::explodeUri
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=6879480546196389223
Jan 06 10:42:49 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=6879480546196389223 in service pandora
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969982] ControllerPandora::explodeUri
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=6524487335768910363
Jan 06 10:42:49 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=6524487335768910363 in service pandora
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969983] ControllerPandora::explodeUri
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=3231827626620193188
Jan 06 10:42:49 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=3231827626620193188 in service pandora
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969983] ControllerPandora::explodeUri
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::saveQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: CoreStateMachine::updateTrackBlock
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getTrackBlock
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969993] ControllerPandora::getStationTracks
Jan 06 10:42:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:49 volumio3 volumio[999]: info: [1641490969993] [Pandora] PandoraHandler::getSongMaxDiff: -8
Jan 06 10:42:50 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:50 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:50 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:50 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:50 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:50] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:42:53 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:53 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:53 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:53 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:53 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:53 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:53 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:53] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:42:53 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:53] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:42:54 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:54 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:54 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:54 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:54 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:54] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:42:56 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:56 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:56 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:56 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:56 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:56] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:42:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:57 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:57] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:42:58 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:42:58 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:42:58 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:42:58 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:42:58 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:42:58] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:00 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:00 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:00 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:00 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:00 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:00] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:02] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:02 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:02 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:02] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:04 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:04 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:04 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:04 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:04 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:04] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:06 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:06 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:06 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:06 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:06 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:06] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:07 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:07] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:08 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:08 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:08 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:08 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:08 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:08] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:10 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:10 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:10 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:10 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:10] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:12 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:12] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:12 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:12 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:12 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:12] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:14 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:14 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:14 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:14 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:14 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:14] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:16 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:16 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:16 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:16 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:16 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:16] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:17 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:17] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:18 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:18 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:18 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:18] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:20 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:20 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:20 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:20 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:20 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:20] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:22 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:22] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:22 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:22 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:22 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:22] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:24 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:24 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:24 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:24 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:24 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:24] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:26 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:26 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:26 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:26 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:26 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:26] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:27 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:27] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:28 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:28 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:28 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:28 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:28 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:28] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:30 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:30 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:30 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:30 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:30 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:30] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:32 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:32] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:32 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:32 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:32 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:32] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:34 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:34 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:34 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:34 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:34 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:34] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:36 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:36 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:36 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:36 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:36 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:36] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:37 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:37] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:38 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:38 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:38 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:38 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:38 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:38] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:40 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:40 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:40 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:40 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:40 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:40] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:42 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:42] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:42 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:42 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:42 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:42] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:44 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:44 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:44 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:44 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:44 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:44] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:46 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:46 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:46 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:46 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:46 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:46] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:47 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:47] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:48 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:48 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:48 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:48] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:50 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:50 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:50 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:50 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:50 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:50] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:52 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:52] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:52 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:52 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:52 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:52] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:55 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:55 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:55 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:55 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:55 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:55] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:56 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:56 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:56 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:56 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:56 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:56] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:43:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:57 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:57] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:43:58 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:43:58 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:43:58 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:43:58 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:43:58 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:43:58] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:00 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:00 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:00 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:00 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:00 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:00] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:02] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:02 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:02 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:02] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:04 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:04 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:04 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:04 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:04 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:04] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:06 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:06 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:06 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:06 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:06 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:06] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:06 volumio3 volumio[999]: error: error
Jan 06 10:44:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:07 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:07] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:08 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:08 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:08 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:08 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:08 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:08] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:10 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:10 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:10 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:10 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:10] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:12 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:12] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:12 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:12 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:12 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:12] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:14 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:14 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:14 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:14 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:14 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:14] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:16 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:16 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:16 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:16 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:16 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:16] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:17 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:17] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:18 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:18 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:18 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:18] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:20 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:20 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:20 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:20 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:20 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:20] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:22 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:22] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:22 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:22 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:22 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:22] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:24 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:24 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:24 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:24 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:24 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:24] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:26 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:26 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:26 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:26 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:26 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:26] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:27 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:27] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:28 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:28 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:28 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:28 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:28 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:28] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:30 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:30 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:30 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:30 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:30 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:30] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:32 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:32] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:32 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:32 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:32 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:32] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:34 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:34 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:34 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:34 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:34 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:34] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:36 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:36 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:36 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:36 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:36 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:36] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:37 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:37] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:38 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:38 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:38 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:38 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:38 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:38] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:40 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:40 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:40 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:40 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:40 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:40] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:42 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:42] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:42 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:42 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:42 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:42] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:44 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:44 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:44 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:44 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:44 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:44] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:46 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:46 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:46 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:46 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:46 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:46] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:47 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:47] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:48 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:48 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:48 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:48] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:50 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:50 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:50 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:50 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:50 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:50] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:52 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:52] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:52 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:52 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:52 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:52] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:54 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:54 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:54 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:54 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:54 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:54] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:56 volumio3 volumio[999]: error: error
Jan 06 10:44:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:57 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:57 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:57 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:57] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:44:57 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:57] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:44:58 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:44:58 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:44:58 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:44:58 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:44:58 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:44:58] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:00 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:00 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:00 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:00 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:00 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:00] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:02] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:02 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:02 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:02] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:04 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:04 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:04 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:04 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:04 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:04] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:06 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:06 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:06 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:06 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:06 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:06] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:07 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:07] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:08 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:08 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:08 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:08 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:08 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:08] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:10 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:10 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:10 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:10 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:10] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:12 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:12] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:12 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:12 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:12 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:12] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:14 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:14 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:14 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:14 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:14 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:14] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:16 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:16 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:16 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:16 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:16 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:16] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:17 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:17] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:18 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:18 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:18 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:18] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:20 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:20 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:20 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:20 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:20 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:20] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:22 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:22] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:22 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:22 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:22 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:22] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:24 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:24 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:24 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:24 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:24 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:24] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:26 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:26 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:26 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:26 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:26 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:26] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:27 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:27] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:28 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:28 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:28 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:28 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:28 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:28] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:30 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:30 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:30 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:30 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:30 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:30] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:32 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:32] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:32 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:32 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:32 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:32] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:34 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:34 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:34 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:34 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:34 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:34] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:36 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:36 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:36 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:36 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:36 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:36] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:37 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:37] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:38 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:38 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:38 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:38 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:38 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:38] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:40 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:40 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:40 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:40 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:40 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:40] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:42 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:42] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:42 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:42 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:42 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:42] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:44 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:44 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:44 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:44 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:44 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:44] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:46 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:46 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:46 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:46 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:46 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:46] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:47 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:47] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:48 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:48 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:48 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:48 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:48] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:50 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:50 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:50 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:50 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:50 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:50] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:52 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:52] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:52 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:52 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:52 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:52] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:54 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:54 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:54 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:54 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:54 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:54] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:56 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:56 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:56 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:56 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:56 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:56] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:45:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:57 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:57] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:45:59 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:45:59 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:45:59 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:45:59 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:45:59 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:45:59] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:00 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:00 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:00 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:00 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:00 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:00] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:02] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:02 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:02 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:02] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:04 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:04 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:04 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:04 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:04 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:04] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:06 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:06 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:06 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:06 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:07 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:07] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:07 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:07] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:08 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:09 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:09 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:09 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:09] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:11 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:11 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:11 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:11 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:11 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:11] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:12 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:12] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:13 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:13 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:13 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:13 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:13 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:13] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:15 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:15 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:15 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:15 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:15 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:15] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:17 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:17 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:17 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:17] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:17 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:17] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:19 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:19 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:19] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:21 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:21 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:21 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:21 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:21 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:21] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:22 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:22 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:22] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:23 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:23 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:23 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:23 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:23 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:23] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:25 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:25 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:25 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:25 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:25 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:25] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:27 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:27 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:27 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:27] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:27 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:46:27 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:46:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:27 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:27 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:27] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:29 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:29 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:29 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:29 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:29 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:29] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:30 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:30 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:46:30 volumio3 volumio[999]: info: [1641491190304] ControllerPandora::ExpireOldTracks::reaper
Jan 06 10:46:30 volumio3 volumio[999]: info: [1641491190304] [Pandora] ExpireOldTracks::reaper: No victims found: Expiring zero tracks.  Don't worry -- Jason will return.
Jan 06 10:46:31 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:31 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:31 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:31 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:31 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:31] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:32 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:32] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:32 volumio3 volumio[999]: info:
Jan 06 10:46:32 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:46:32 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:46:32 volumio3 volumio[999]: info: [1641491192568] ControllerPandora::pandoraListener
Jan 06 10:46:32 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:46:32 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:46:32 volumio3 volumio[999]: info:
Jan 06 10:46:32 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:46:32 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:46:32 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:46:32 volumio3 volumio[999]: info:
Jan 06 10:46:32 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:46:32 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:46:32 volumio3 volumio[999]: info:
Jan 06 10:46:32 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:46:32 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:46:32 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:46:32 volumio3 volumio[999]: error: updateQueue error: null
Jan 06 10:46:32 volumio3 volumio[999]: error: updateQueue error: null
Jan 06 10:46:32 volumio3 volumio[999]: info: sendMpdCommand status took 7 milliseconds
Jan 06 10:46:32 volumio3 volumio[999]: info: ------------------------------ 8ms
Jan 06 10:46:32 volumio3 volumio[999]: info: sendMpdCommand status took 6 milliseconds
Jan 06 10:46:32 volumio3 volumio[999]: info: ------------------------------ 5ms
Jan 06 10:46:32 volumio3 volumio[999]: info: sendMpdCommand status took 4 milliseconds
Jan 06 10:46:32 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:46:32 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:46:32 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:46:32 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:46:32 volumio3 volumio[999]: info: [1641491192578] ControllerPandora::pushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:46:32 volumio3 volumio[999]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null,"trackType":"mp3"}
Jan 06 10:46:32 volumio3 volumio[999]: verbose: CURRENT POSITION 0
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreStateMachine::syncState   stateService stop
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreStateMachine::syncState   currentStatus play
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreStateMachine::stPlaybackTimer
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService pandora
Jan 06 10:46:32 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:46:32 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:46:32 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:46:32 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:46:32 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:46:32 volumio3 volumio[999]: info: ------------------------------ 22ms
Jan 06 10:46:32 volumio3 volumio[999]: info: ------------------------------ 20ms
Jan 06 10:46:33 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:33 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:33 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:33 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:33 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:33] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:35 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:35 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:35 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:35 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:35 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:35] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:37 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:37 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:37 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:37] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:37 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:37 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:37] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:39 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:39 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:39 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:39 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:39 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:39] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:41 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:41 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:41 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:41 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:41 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:41] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:42 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:42 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:42] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:43 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:43 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:43 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:43 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:43 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:43] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:45 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:45 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:45 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:45 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:45 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:45] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:47 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:47 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:47 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:47] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:47 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:47 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:47] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:49 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:49 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:49 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:49 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:49 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:49] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:51 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:51 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:51 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:51 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:51 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:51] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:52 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:52 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:52] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:53 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:53 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:53 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:53 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:53 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:53] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:55 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:55 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:55 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:55 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:55 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:55] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:57 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:57 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:57 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:57] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:46:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:57 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:57 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:57] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:46:59 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:46:59 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:46:59 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:46:59 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:46:59 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:46:59] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:02 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:02 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:02] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:02 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:02 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:02] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:47:03 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:03 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:03 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:03 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:03 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:03] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:05 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:05 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:05 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:05 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:05 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:05] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:07 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:07 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:07 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:07] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:07 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:07 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:07] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:09 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:09] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:09 volumio3 volumio[999]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.26.0 Total Clients: 7
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- Client requests Volumio play
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioPlay
Jan 06 10:47:09 volumio3 volumio[999]: verbose: UNSET VOLATILE
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::play index undefined
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::startPlaybackTimer
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229750] ControllerPandora::clearAddPlayTrack
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::clear
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand clear
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:09 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand clear took 7 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229758] ControllerPandora::checkForExpiredStations
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229758] ControllerPandora::appendTracksToMpd
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229759] [Pandora] appendTracksToMpd: Added 1 track(s) to mpd
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand addid
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand play
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:09 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:09 volumio3 volumio[999]: error: updateQueue error: null
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:09 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 9ms
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand addid took 7 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand play took 6 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 5ms
Jan 06 10:47:09 volumio3 volumio[999]: verbose: MPD COMMAND [object Object]
Jan 06 10:47:09 volumio3 volumio[999]: verbose: MPD COMMAND [object Object]
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229768] ControllerPandora::pushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"(Keep Feeling) Fascination (Remastered)","name":"(Keep Feeling) Fascination (Remastered)","artist":"The Human League","album":"The Very Best Of The Human League","albumart":"http://cont-3.p-cdn.us/images/05/fe/c1/fc/c28347b2a64a259a05d25e21/1080W_1080H.jpg","realUri":"http://t1-3.p-cdn.us/access/4629897794771348646.mp3?version=5&lid=27752775&token=yXrpMGw3SGbYrr7DbIw0jHxLxOmB3pIXYrEYs%2FtwrII9nTmUScJdQg%2F3Yi3pSNC0PK5YluKYE2vH5wrC7sTvDz9R7t7n%2F3cVDorLhIxWRWa565JFtpe3nyswhtZwUEOdMfyk%2BrF8FRi%2BhZq%2BJQQFpGCnQwGXDFsZ4ekWPAqEZmx55Bg7Aclced9zG9877nLuxdgXfw8ap3VzWcHjr23oSCla6C2C4ANJYVAv1OjW2Zq9R3RS7mvJcghhZiXOGv2KY3dNPVt%2FsZIo5ZgTPia2NJvRKsnLv0c7I0Aninbspjlnzbf0ghMkQ1HcQLt7mBBLrPfvbRZUk9u0mxsHg8JVkg%3D%3D","isStreaming":true,"duration":223,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-3.p-cdn.us/access/4629897794771348646.mp3?version=5&lid=27752775&token=yXrpMGw3SGbYrr7DbIw0jHxLxOmB3pIXYrEYs%2FtwrII9nTmUScJdQg%2F3Yi3pSNC0PK5YluKYE2vH5wrC7sTvDz9R7t7n%2F3cVDorLhIxWRWa565JFtpe3nyswhtZwUEOdMfyk%2BrF8FRi%2BhZq%2BJQQFpGCnQwGXDFsZ4ekWPAqEZmx55Bg7Aclced9zG9877nLuxdgXfw8ap3VzWcHjr23oSCla6C2C4ANJYVAv1OjW2Zq9R3RS7mvJcghhZiXOGv2KY3dNPVt%2FsZIo5ZgTPia2NJvRKsnLv0c7I0Aninbspjlnzbf0ghMkQ1HcQLt7mBBLrPfvbRZUk9u0mxsHg8JVkg%3D%3D","seek":0,"status":"play"}
Jan 06 10:47:09 volumio3 volumio[999]: verbose: CURRENT POSITION 0
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::syncState   stateService play
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::syncState   currentStatus stop
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService pandora
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229775] ControllerPandora::fetchAndAddTracks
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229776] ControllerPandora::getStationTracks
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229776] [Pandora] PandoraHandler::getSongMaxDiff: -8
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229777] ControllerPandora::fetchAndAddTracks::getSqInfo
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229777] ControllerPandora::getStationTracks
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229778] [Pandora] fetchAndAddTracks: diff1: -8 sQPos1: 0
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229778] [Pandora] fetchAndAddTracks: Fetching tracks
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229778] ControllerPandora::PandoraHandler::fillStationData
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:09 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:09 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 25ms
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 7ms
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:09 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 9ms
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 7ms
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:09 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:09] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:09 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:09] "GET /command/play HTTP/1.1" 200 -
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229910] ControllerPandora::pandoraListener
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand status took 9 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand status took 9 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand status took 9 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: info: [1641491229925] ControllerPandora::pushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"(Keep Feeling) Fascination (Remastered)","artist":"The Human League","album":"The Very Best Of The Human League","uri":"http://t1-3.p-cdn.us/access/4629897794771348646.mp3?version=5&lid=27752775&token=yXrpMGw3SGbYrr7DbIw0jHxLxOmB3pIXYrEYs%2FtwrII9nTmUScJdQg%2F3Yi3pSNC0PK5YluKYE2vH5wrC7sTvDz9R7t7n%2F3cVDorLhIxWRWa565JFtpe3nyswhtZwUEOdMfyk%2BrF8FRi%2BhZq%2BJQQFpGCnQwGXDFsZ4ekWPAqEZmx55Bg7Aclced9zG9877nLuxdgXfw8ap3VzWcHjr23oSCla6C2C4ANJYVAv1OjW2Zq9R3RS7mvJcghhZiXOGv2KY3dNPVt%2FsZIo5ZgTPia2NJvRKsnLv0c7I0Aninbspjlnzbf0ghMkQ1HcQLt7mBBLrPfvbRZUk9u0mxsHg8JVkg%3D%3D","trackType":"mp3"}
Jan 06 10:47:09 volumio3 volumio[999]: verbose: CURRENT POSITION 0
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::syncState   stateService play
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::syncState   currentStatus play
Jan 06 10:47:09 volumio3 volumio[999]: info: Received an update from plugin. extracting info from payload
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService pandora
Jan 06 10:47:09 volumio3 volumio[999]: info:
Jan 06 10:47:09 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand status took 17 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand status took 2 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 33ms
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 31ms
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:09 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:09 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:09 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 26ms
Jan 06 10:47:09 volumio3 volumio[999]: info: ------------------------------ 8ms
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:09 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230082] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230764] [Pandora] PandoraHandler::fetchTracks::fetchStationPlaylist: Retrieved INXS Radio playlist
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230764] ControllerPandora::PandoraHandler::fetchTracks::fillNewTracks
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230764] [Pandora] PandoraHandler::fetchTracks::fillNewTracks: Fetched 4 track(s)
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::addQueueItems
Jan 06 10:47:10 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=5993129184120569696
Jan 06 10:47:10 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=5993129184120569696 in service pandora
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230765] ControllerPandora::explodeUri
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=2396453293378743000
Jan 06 10:47:10 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=2396453293378743000 in service pandora
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230766] ControllerPandora::explodeUri
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=4447475217034890422
Jan 06 10:47:10 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=4447475217034890422 in service pandora
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230766] ControllerPandora::explodeUri
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=7331326825264721710
Jan 06 10:47:10 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=7331326825264721710 in service pandora
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230766] ControllerPandora::explodeUri
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::saveQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: CoreStateMachine::updateTrackBlock
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::getTrackBlock
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230780] ControllerPandora::getStationTracks
Jan 06 10:47:10 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:10 volumio3 volumio[999]: info: [1641491230781] [Pandora] PandoraHandler::getSongMaxDiff: -4
Jan 06 10:47:11 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:11 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:11 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:11 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:11 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:11] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:12 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:12 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:12] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:47:13 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:13 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:13 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:13 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:13 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:13] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:15 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:15 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:15 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:15 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:15 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:15] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:17 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:17 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:17 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:17] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:17 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:17 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:17] "GET /status/ HTTP/1.1" 200 -
Jan 06 10:47:18 volumio3 volumio[999]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.26.0 Total Clients: 8
Jan 06 10:47:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:18 volumio3 volumio[999]: info:
Jan 06 10:47:18 volumio3 volumio[999]: ---------------------------- Client requests Volumio next
Jan 06 10:47:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioNext
Jan 06 10:47:18 volumio3 volumio[999]: info: CoreStateMachine::next
Jan 06 10:47:18 volumio3 volumio[999]: info: [1641491238921] ControllerPandora::next
Jan 06 10:47:18 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:18 volumio3 volumio[999]: info: [1641491238924] [Pandora] handleMediaButton: User chose "next" function
Jan 06 10:47:18 volumio3 volumio[999]: info: [1641491238925] ControllerPandora::stop
Jan 06 10:47:18 volumio3 volumio[999]: info: ControllerMpd::stop
Jan 06 10:47:18 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand stop
Jan 06 10:47:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:18 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:18 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:18 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:18 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:18] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:19] "GET /command/next HTTP/1.1" 200 -
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand stop took 127 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239055] ControllerPandora::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 0
Jan 06 10:47:19 volumio3 volumio[999]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"(Keep Feeling) Fascination (Remastered)","name":"(Keep Feeling) Fascination (Remastered)","artist":"The Human League","album":"The Very Best Of The Human League","albumart":"http://cont-3.p-cdn.us/images/05/fe/c1/fc/c28347b2a64a259a05d25e21/1080W_1080H.jpg","realUri":"http://t1-3.p-cdn.us/access/4629897794771348646.mp3?version=5&lid=27752775&token=yXrpMGw3SGbYrr7DbIw0jHxLxOmB3pIXYrEYs%2FtwrII9nTmUScJdQg%2F3Yi3pSNC0PK5YluKYE2vH5wrC7sTvDz9R7t7n%2F3cVDorLhIxWRWa565JFtpe3nyswhtZwUEOdMfyk%2BrF8FRi%2BhZq%2BJQQFpGCnQwGXDFsZ4ekWPAqEZmx55Bg7Aclced9zG9877nLuxdgXfw8ap3VzWcHjr23oSCla6C2C4ANJYVAv1OjW2Zq9R3RS7mvJcghhZiXOGv2KY3dNPVt%2FsZIo5ZgTPia2NJvRKsnLv0c7I0Aninbspjlnzbf0ghMkQ1HcQLt7mBBLrPfvbRZUk9u0mxsHg8JVkg%3D%3D","isStreaming":true,"duration":223,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-3.p-cdn.us/access/4629897794771348646.mp3?version=5&lid=27752775&token=yXrpMGw3SGbYrr7DbIw0jHxLxOmB3pIXYrEYs%2FtwrII9nTmUScJdQg%2F3Yi3pSNC0PK5YluKYE2vH5wrC7sTvDz9R7t7n%2F3cVDorLhIxWRWa565JFtpe3nyswhtZwUEOdMfyk%2BrF8FRi%2BhZq%2BJQQFpGCnQwGXDFsZ4ekWPAqEZmx55Bg7Aclced9zG9877nLuxdgXfw8ap3VzWcHjr23oSCla6C2C4ANJYVAv1OjW2Zq9R3RS7mvJcghhZiXOGv2KY3dNPVt%2FsZIo5ZgTPia2NJvRKsnLv0c7I0Aninbspjlnzbf0ghMkQ1HcQLt7mBBLrPfvbRZUk9u0mxsHg8JVkg%3D%3D","seek":0,"status":"stop"}
Jan 06 10:47:19 volumio3 volumio[999]: verbose: CURRENT POSITION 0
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::syncState   stateService stop
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::syncState   currentStatus play
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::play index undefined
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService pandora
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::startPlaybackTimer
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239089] ControllerPandora::clearAddPlayTrack
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::clear
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand clear
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:19 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand clear took 13 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239103] ControllerPandora::checkForExpiredStations
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239103] ControllerPandora::removeTrack
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239103] [Pandora] removeTrack: Not removing track with uri: null at queue index: -1
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239104] ControllerPandora::appendTracksToMpd
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239104] [Pandora] appendTracksToMpd: Added 1 track(s) to mpd
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand addid
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand play
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:19 volumio3 volumio[999]: error: updateQueue error: null
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:19 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand status took 9 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 10ms
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand addid took 8 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand play took 8 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand status took 6 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:19 volumio3 volumio[999]: verbose: MPD COMMAND [object Object]
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239118] ControllerPandora::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Enjoy The Silence","name":"Enjoy The Silence","artist":"Depeche Mode","album":"The Best Of Depeche Mode Volume 1","albumart":"http://cont-2.p-cdn.us/images/2e/e8/5a/bb/b7474ed09d7f0747412774fe/1080W_1080H.jpg","realUri":"http://audio-dc6-t1-2-v4v6.pandora.com/access/5993129184120569696.mp3?version=5&lid=27752775&token=ADveiMYp%2FCqpuHJZWFUTWriwNGDfT67yVjFbRpDGeYyWX0G79FkXw399UWVR5mr1gHKPMkXoqoj%2Fa3UUbhIoQraxhVKDUJG4SJCvCOUqpw7vOMIGOgG5%2FS0IlrK3fKjosbo%2F2%2Fe5b%2F4LZ0ncgV84vDkOfIJ2pd6sOKwcNS5B5CBNedR5CnTNnUGrP9syM3yMs7htI6PikoLMT4FkLbAXcngiabj18oU%2BHreED2VbyYifPIWxBYoZIFPpk9QcmPLa%2BYM6Xe%2BAiRXqCa2z1cULLmohon6Lfg7fpTkxvwjcqSvCs1wxCFYwUaGjSxBggejs0tBLOQ0LJiAKNHePQHuiSA%3D%3D","isStreaming":true,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://audio-dc6-t1-2-v4v6.pandora.com/access/5993129184120569696.mp3?version=5&lid=27752775&token=ADveiMYp%2FCqpuHJZWFUTWriwNGDfT67yVjFbRpDGeYyWX0G79FkXw399UWVR5mr1gHKPMkXoqoj%2Fa3UUbhIoQraxhVKDUJG4SJCvCOUqpw7vOMIGOgG5%2FS0IlrK3fKjosbo%2F2%2Fe5b%2F4LZ0ncgV84vDkOfIJ2pd6sOKwcNS5B5CBNedR5CnTNnUGrP9syM3yMs7htI6PikoLMT4FkLbAXcngiabj18oU%2BHreED2VbyYifPIWxBYoZIFPpk9QcmPLa%2BYM6Xe%2BAiRXqCa2z1cULLmohon6Lfg7fpTkxvwjcqSvCs1wxCFYwUaGjSxBggejs0tBLOQ0LJiAKNHePQHuiSA%3D%3D","seek":0,"status":"play"}
Jan 06 10:47:19 volumio3 volumio[999]: verbose: CURRENT POSITION 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::syncState   stateService play
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::syncState   currentStatus stop
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService pandora
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 27ms
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239128] ControllerPandora::fetchAndAddTracks
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239128] ControllerPandora::getStationTracks
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239129] [Pandora] PandoraHandler::getSongMaxDiff: -4
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239129] ControllerPandora::fetchAndAddTracks::getSqInfo
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239129] ControllerPandora::getStationTracks
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239130] [Pandora] fetchAndAddTracks: diff1: -4 sQPos1: 8
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239130] [Pandora] fetchAndAddTracks: Fetching tracks
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239130] ControllerPandora::PandoraHandler::fillStationData
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:19 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:19 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 31ms
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 29 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 11ms
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 39ms
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces system playlist update
Jan 06 10:47:19 volumio3 volumio[999]: info: Ignoring MPD Status Update
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 7ms
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 4ms
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:19] "GET /current/ HTTP/1.1" 200 -
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239310] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239409] ControllerPandora::pandoraListener
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand status took 10 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand status took 7 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:19 volumio3 volumio[999]: info:
Jan 06 10:47:19 volumio3 volumio[999]: ---------------------------- MPD announces state update: player
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::getState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand status
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand status took 5 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand status took 3 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseState
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239430] ControllerPandora::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Enjoy The Silence","artist":"Depeche Mode","album":"The Best Of Depeche Mode Volume 1","uri":"http://audio-dc6-t1-2-v4v6.pandora.com/access/5993129184120569696.mp3?version=5&lid=27752775&token=ADveiMYp%2FCqpuHJZWFUTWriwNGDfT67yVjFbRpDGeYyWX0G79FkXw399UWVR5mr1gHKPMkXoqoj%2Fa3UUbhIoQraxhVKDUJG4SJCvCOUqpw7vOMIGOgG5%2FS0IlrK3fKjosbo%2F2%2Fe5b%2F4LZ0ncgV84vDkOfIJ2pd6sOKwcNS5B5CBNedR5CnTNnUGrP9syM3yMs7htI6PikoLMT4FkLbAXcngiabj18oU%2BHreED2VbyYifPIWxBYoZIFPpk9QcmPLa%2BYM6Xe%2BAiRXqCa2z1cULLmohon6Lfg7fpTkxvwjcqSvCs1wxCFYwUaGjSxBggejs0tBLOQ0LJiAKNHePQHuiSA%3D%3D","trackType":"mp3"}
Jan 06 10:47:19 volumio3 volumio[999]: verbose: CURRENT POSITION 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::syncState   stateService play
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::syncState   currentStatus play
Jan 06 10:47:19 volumio3 volumio[999]: info: Received an update from plugin. extracting info from payload
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::setConsumeUpdateService pandora
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 32ms
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 31ms
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:19 volumio3 volumio[999]: verbose: ControllerMpd::parseTrackInfo
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:19 volumio3 volumio[999]: info: ControllerMpd::pushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::servicePushState
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrack 8
Jan 06 10:47:19 volumio3 volumio[999]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 27ms
Jan 06 10:47:19 volumio3 volumio[999]: info: ------------------------------ 23ms
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239980] [Pandora] PandoraHandler::fetchTracks::fetchStationPlaylist: Retrieved INXS Radio playlist
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239981] ControllerPandora::PandoraHandler::fetchTracks::fillNewTracks
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239981] [Pandora] PandoraHandler::fetchTracks::fillNewTracks: Fetched 4 track(s)
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::addQueueItems
Jan 06 10:47:19 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=6855632474598073177
Jan 06 10:47:19 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=6855632474598073177 in service pandora
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239982] ControllerPandora::explodeUri
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=5145303821052400702
Jan 06 10:47:19 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=5145303821052400702 in service pandora
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239982] ControllerPandora::explodeUri
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=2200336587340898662
Jan 06 10:47:19 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=2200336587340898662 in service pandora
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239983] ControllerPandora::explodeUri
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: Adding Item to queue: /pandora/stationToken=4058670268554901831trackId=8241293700718592918
Jan 06 10:47:19 volumio3 volumio[999]: info: Exploding uri /pandora/stationToken=4058670268554901831trackId=8241293700718592918 in service pandora
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239983] ControllerPandora::explodeUri
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::saveQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreCommandRouter::volumioPushQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: CoreStateMachine::updateTrackBlock
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getTrackBlock
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239998] ControllerPandora::getStationTracks
Jan 06 10:47:19 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:19 volumio3 volumio[999]: info: [1641491239999] [Pandora] PandoraHandler::getSongMaxDiff: 0
Jan 06 10:47:21 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetState
Jan 06 10:47:21 volumio3 volumio[999]: info: CoreCommandRouter::volumioGetQueue
Jan 06 10:47:21 volumio3 volumio[999]: info: CoreStateMachine::getQueue
Jan 06 10:47:21 volumio3 volumio[999]: info: CorePlayQueue::getQueue
Jan 06 10:47:21 volumio3 python3[5658]: 192.168.4.27 - - [06/Jan/2022 10:47:21] "GET /current/ HTTP/1.1" 200 -