-- Logs begin at Thu 2019-02-14 04:11:59 CST, end at Thu 2025-07-03 15:27:52 CDT. -- Jul 03 15:26:01 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 03 15:26:01 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 03 15:26:01 volumio volumio[832]: info: Discovery: Getting this device information Jul 03 15:26:01 volumio volumio[832]: info: CoreCommandRouter::volumioGetState Jul 03 15:26:01 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 03 15:26:01 volumio volumio[832]: verbose: New Socket.io Connection to 192.168.10.27:3000 from 192.168.10.17 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jul 03 15:26:06 volumio volumio[832]: verbose: New Socket.io Connection to 192.168.10.27:3000 from 192.168.10.17 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jul 03 15:26:33 volumio volumio[832]: verbose: New Socket.io Connection to 192.168.10.27:3000 from 192.168.10.17 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jul 03 15:26:37 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 03 15:26:37 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 03 15:26:37 volumio volumio[832]: info: Discovery: Getting this device information Jul 03 15:26:37 volumio volumio[832]: info: CoreCommandRouter::volumioGetState Jul 03 15:26:37 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 03 15:26:43 volumio volumio[832]: verbose: New Socket.io Connection to 192.168.10.27:3000 from 192.168.10.17 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jul 03 15:27:05 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 03 15:27:05 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 03 15:27:05 volumio volumio[832]: info: Discovery: Getting this device information Jul 03 15:27:05 volumio volumio[832]: info: CoreCommandRouter::volumioGetState Jul 03 15:27:05 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 03 15:27:06 volumio volumio[832]: verbose: New Socket.io Connection to 192.168.10.27:3000 from 192.168.10.17 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jul 03 15:27:11 volumio volumio[832]: verbose: New Socket.io Connection to 192.168.10.27 from 192.168.10.17 UA: Mozilla/5.0 (Linux; Android 15; SM-A546U Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.116 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::volumioGetVisibleSources Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::volumioGetState Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 03 15:27:11 volumio volumio[832]: info: Received Get System Info Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 03 15:27:11 volumio volumio[832]: info: Discovery: Getting this device information Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::volumioGetState Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::volumioGetState Jul 03 15:27:11 volumio volumio[832]: info: Listing playlists Jul 03 15:27:11 volumio volumio[832]: info: CoreCommandRouter::volumioGetQueue Jul 03 15:27:11 volumio volumio[832]: info: CoreStateMachine::getQueue Jul 03 15:27:11 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:12 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 03 15:27:12 volumio volumio[832]: info: Received Get System Info Jul 03 15:27:12 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 03 15:27:12 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 03 15:27:12 volumio volumio[832]: info: Discovery: Getting this device information Jul 03 15:27:12 volumio volumio[832]: info: CoreCommandRouter::volumioGetState Jul 03 15:27:12 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 03 15:27:13 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 03 15:27:13 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 03 15:27:13 volumio volumio[832]: info: Discovery: Getting this device information Jul 03 15:27:13 volumio volumio[832]: info: CoreCommandRouter::volumioGetState Jul 03 15:27:13 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 03 15:27:15 volumio volumio[832]: verbose: New Socket.io Connection to 192.168.10.27:3000 from 192.168.10.17 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::volumioPlay Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::play index 2 Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::stop Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::stPlaybackTimer Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::updateTrackBlock Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrackBlock Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::serviceStop Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::serviceStop Jul 03 15:27:19 volumio volumio[832]: info: [1751574439791] ControllerPandora::stop Jul 03 15:27:19 volumio volumio[832]: info: ControllerMpd::stop Jul 03 15:27:19 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 15:27:19 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:19 volumio volumio[832]: info: sendMpdCommand stop took 6 milliseconds Jul 03 15:27:19 volumio volumio[832]: info: ControllerMpd::clear Jul 03 15:27:19 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:19 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:19 volumio volumio[832]: info: sendMpdCommand clear took 1 milliseconds Jul 03 15:27:19 volumio volumio[832]: info: [1751574439806] ControllerPandora::pushState Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:19 volumio volumio[832]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"I Walk the Line","name":"I Walk the Line","artist":"Johnny Cash","album":"I Walk the Line","albumart":"http://cont-2.p-cdn.us/images/98/ec/9f/88/b8ab450c84c67590790f0245/1080W_1080H.jpg","realUri":"http://audio-sv5-t1-1-v4v6.pandora.com/access/5546377555030381860.mp3?version=5&lid=640185022&token=jS%2FaS5G35gp0qrYT3kUOavk9Zlu7PQSN5jIR%2FXgDsMrPeKBmv%2BwmWGPIf%2FfZOrbSlbvD%2Bi%2FLqQuQFqlxa8KPsRtRgYT%2F1%2BwLMh4jTTb9heEwTOt%2F0WfecgqpIVkxcogcpxAXWxFU%2FDJqbEudZE9QnYuCX9f2Uihjlp5muXoYbzYKtKSG46FCD2%2BbFw8jD%2Bp8JvdylYbhLklu%2FY7A3h8u9vZItIciec9anROiXQysQxpl8vYfpQr0eQLW2kXRbxSLSF0VJfBpjgYvzxLNwcBvPg6%2FPQQYUkRHxMQO2%2FZWMr1gpI%2BDiVzKJS6QQ7GEbkSjxecj0jtTociGvOlb6HxkYA%3D%3D","isStreaming":true,"duration":155,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://audio-sv5-t1-1-v4v6.pandora.com/access/5546377555030381860.mp3?version=5&lid=640185022&token=jS%2FaS5G35gp0qrYT3kUOavk9Zlu7PQSN5jIR%2FXgDsMrPeKBmv%2BwmWGPIf%2FfZOrbSlbvD%2Bi%2FLqQuQFqlxa8KPsRtRgYT%2F1%2BwLMh4jTTb9heEwTOt%2F0WfecgqpIVkxcogcpxAXWxFU%2FDJqbEudZE9QnYuCX9f2Uihjlp5muXoYbzYKtKSG46FCD2%2BbFw8jD%2Bp8JvdylYbhLklu%2FY7A3h8u9vZItIciec9anROiXQysQxpl8vYfpQr0eQLW2kXRbxSLSF0VJfBpjgYvzxLNwcBvPg6%2FPQQYUkRHxMQO2%2FZWMr1gpI%2BDiVzKJS6QQ7GEbkSjxecj0jtTociGvOlb6HxkYA%3D%3D","seek":0,"status":"stop"} Jul 03 15:27:19 volumio volumio[832]: verbose: CURRENT POSITION 0 Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::syncState stateService stop Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::syncState currentStatus stop Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:19 volumio volumio[832]: info: No code Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::play index undefined Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::startPlaybackTimer Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:19 volumio volumio[832]: info: [1751574439823] ControllerPandora::clearAddPlayTrack Jul 03 15:27:19 volumio volumio[832]: info: ControllerMpd::clear Jul 03 15:27:19 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:19 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:19 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:19 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:19 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:19 volumio volumio[832]: error: updateQueue error: null Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: info: sendMpdCommand status took 28 milliseconds Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 28ms Jul 03 15:27:19 volumio volumio[832]: info: sendMpdCommand clear took 5 milliseconds Jul 03 15:27:19 volumio volumio[832]: info: sendMpdCommand status took 4 milliseconds Jul 03 15:27:19 volumio volumio[832]: info: sendMpdCommand status took 3 milliseconds Jul 03 15:27:19 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:19 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:19 volumio volumio[832]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current pandora Received mpd Jul 03 15:27:19 volumio volumio[832]: info: [1751574439833] ControllerPandora::checkForExpiredStations Jul 03 15:27:19 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:19 volumio volumio[832]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current pandora Received mpd Jul 03 15:27:19 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:19 volumio volumio[832]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current pandora Received mpd Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 43ms Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:19 volumio volumio[832]: info: [1751574439842] ControllerPandora::removeTrack Jul 03 15:27:19 volumio volumio[832]: info: [1751574439842] [Pandora] removeTrack: Not removing track with uri: null at queue index: -1 Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 19ms Jul 03 15:27:19 volumio volumio[832]: info: [1751574439844] ControllerPandora::appendTracksToMpd Jul 03 15:27:19 volumio volumio[832]: info: [1751574439844] [Pandora] appendTracksToMpd: Added 1 track(s) to mpd Jul 03 15:27:19 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand addid Jul 03 15:27:19 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand play Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:19 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:19 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:19 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:19 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:19 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:19 volumio volumio[832]: error: updateQueue error: null Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 36ms Jul 03 15:27:19 volumio volumio[832]: info: sendMpdCommand addid took 18 milliseconds Jul 03 15:27:19 volumio volumio[832]: info: sendMpdCommand play took 19 milliseconds Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 18ms Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 16ms Jul 03 15:27:19 volumio volumio[832]: verbose: MPD COMMAND [object Object] Jul 03 15:27:19 volumio volumio[832]: verbose: MPD COMMAND [object Object] Jul 03 15:27:19 volumio volumio[832]: info: [1751574439865] ControllerPandora::pushState Jul 03 15:27:19 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:19 volumio volumio[832]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"(Sittin' On) the Dock of the Bay","name":"(Sittin' On) the Dock of the Bay","artist":"Otis Redding","album":"The Very Best of Otis Redding","albumart":"http://cont-1.p-cdn.us/images/84/dc/d2/32/404348f5b7701204be5e67a8/1080W_1080H.jpg","realUri":"http://t1-4.p-cdn.us/access/6091367393615339342.mp3?version=5&lid=640185022&token=rg1Yx%2FpkvAwt0TLD7QoF9YMsHyCVdvNlRO029lzjRr%2Fhb5VWgsjI8zH1hBxoMUAVHEMIvKF3uH022DyIgX3N%2FFplzo%2FYfWX7Lls4sG9Z5mnsz05zl1BDUYZjj4v0gJVWvJDqWEoCyt6KyYgNMNupp3XDS9%2BhSkJRyW%2FBXpeJQwg2PitGFX%2Fazqc0yvx2gx2%2FOjL5gqCixyvvpI6r93ANmh7CbksbzonTbu3jfTWWCNPQDGzBclrmBDTV51KRF%2FdCatYQwCfjaefT7QGylYi2TYFEgXHGjzbd9H%2BDw0X5GDq0T%2FzODKxi27VmSbTMYnGoWJe%2FSxo2B7LEo6YOpPpAAQ%3D%3D","isStreaming":true,"duration":167,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-4.p-cdn.us/access/6091367393615339342.mp3?version=5&lid=640185022&token=rg1Yx%2FpkvAwt0TLD7QoF9YMsHyCVdvNlRO029lzjRr%2Fhb5VWgsjI8zH1hBxoMUAVHEMIvKF3uH022DyIgX3N%2FFplzo%2FYfWX7Lls4sG9Z5mnsz05zl1BDUYZjj4v0gJVWvJDqWEoCyt6KyYgNMNupp3XDS9%2BhSkJRyW%2FBXpeJQwg2PitGFX%2Fazqc0yvx2gx2%2FOjL5gqCixyvvpI6r93ANmh7CbksbzonTbu3jfTWWCNPQDGzBclrmBDTV51KRF%2FdCatYQwCfjaefT7QGylYi2TYFEgXHGjzbd9H%2BDw0X5GDq0T%2FzODKxi27VmSbTMYnGoWJe%2FSxo2B7LEo6YOpPpAAQ%3D%3D","seek":0,"status":"play"} Jul 03 15:27:19 volumio volumio[832]: verbose: CURRENT POSITION 2 Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::syncState stateService play Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::syncState currentStatus stop Jul 03 15:27:19 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 15:27:19 volumio volumio[832]: info: [1751574439866] ControllerPandora::fetchAndAddTracks Jul 03 15:27:19 volumio volumio[832]: info: [1751574439866] ControllerPandora::getStationTracks Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:19 volumio volumio[832]: info: [1751574439866] [Pandora] PandoraHandler::getSongMaxDiff: 2 Jul 03 15:27:19 volumio volumio[832]: info: [1751574439866] ControllerPandora::fetchAndAddTracks::getSqInfo Jul 03 15:27:19 volumio volumio[832]: info: [1751574439866] ControllerPandora::getStationTracks Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:19 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:19 volumio volumio[832]: info: [1751574439867] [Pandora] fetchAndAddTracks: diff1: 2 sQPos1: 2 Jul 03 15:27:19 volumio volumio[832]: info: [1751574439867] [Pandora] fetchAndAddTracks: Fetching tracks Jul 03 15:27:19 volumio volumio[832]: info: [1751574439867] ControllerPandora::PandoraHandler::fillStationData Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 16ms Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 9ms Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 8ms Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: info: Jul 03 15:27:19 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:19 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 6ms Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 3ms Jul 03 15:27:19 volumio volumio[832]: info: ------------------------------ 2ms Jul 03 15:27:20 volumio volumio[832]: info: [1751574440112] ControllerPandora::pandoraListener Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:20 volumio volumio[832]: info: Jul 03 15:27:20 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:20 volumio volumio[832]: info: Jul 03 15:27:20 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:20 volumio volumio[832]: info: Jul 03 15:27:20 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:20 volumio volumio[832]: info: [1751574440123] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist Jul 03 15:27:20 volumio volumio[832]: info: Jul 03 15:27:20 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:20 volumio volumio[832]: info: Jul 03 15:27:20 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand status took 21 milliseconds Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand status took 21 milliseconds Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand status took 19 milliseconds Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 15:27:20 volumio volumio[832]: info: Jul 03 15:27:20 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand status took 13 milliseconds Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand status took 10 milliseconds Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand status took 4 milliseconds Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseTrackInfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseTrackInfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseTrackInfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseTrackInfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:20 volumio volumio[832]: info: [1751574440154] ControllerPandora::pushState Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:20 volumio volumio[832]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":167,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"(Sittin' On) the Dock of the Bay","artist":"Otis Redding","album":"The Very Best of Otis Redding","uri":"http://t1-4.p-cdn.us/access/6091367393615339342.mp3?version=5&lid=640185022&token=rg1Yx%2FpkvAwt0TLD7QoF9YMsHyCVdvNlRO029lzjRr%2Fhb5VWgsjI8zH1hBxoMUAVHEMIvKF3uH022DyIgX3N%2FFplzo%2FYfWX7Lls4sG9Z5mnsz05zl1BDUYZjj4v0gJVWvJDqWEoCyt6KyYgNMNupp3XDS9%2BhSkJRyW%2FBXpeJQwg2PitGFX%2Fazqc0yvx2gx2%2FOjL5gqCixyvvpI6r93ANmh7CbksbzonTbu3jfTWWCNPQDGzBclrmBDTV51KRF%2FdCatYQwCfjaefT7QGylYi2TYFEgXHGjzbd9H%2BDw0X5GDq0T%2FzODKxi27VmSbTMYnGoWJe%2FSxo2B7LEo6YOpPpAAQ%3D%3D","trackType":"mp3"} Jul 03 15:27:20 volumio volumio[832]: verbose: CURRENT POSITION 2 Jul 03 15:27:20 volumio volumio[832]: info: CoreStateMachine::syncState stateService play Jul 03 15:27:20 volumio volumio[832]: info: CoreStateMachine::syncState currentStatus play Jul 03 15:27:20 volumio volumio[832]: info: Received an update from plugin. extracting info from payload Jul 03 15:27:20 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:20 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:20 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:20 volumio volumio[832]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:20 volumio volumio[832]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:20 volumio volumio[832]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Jul 03 15:27:20 volumio volumio[832]: info: ------------------------------ 53ms Jul 03 15:27:20 volumio volumio[832]: info: ------------------------------ 52ms Jul 03 15:27:20 volumio volumio[832]: info: ------------------------------ 51ms Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand playlistinfo took 23 milliseconds Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 03 15:27:20 volumio volumio[832]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseTrackInfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseTrackInfo Jul 03 15:27:20 volumio volumio[832]: verbose: ControllerMpd::parseTrackInfo Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:20 volumio volumio[832]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:20 volumio volumio[832]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Jul 03 15:27:20 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getTrack 2 Jul 03 15:27:20 volumio volumio[832]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Jul 03 15:27:20 volumio volumio[832]: info: ------------------------------ 43ms Jul 03 15:27:20 volumio volumio[832]: info: ------------------------------ 40ms Jul 03 15:27:20 volumio volumio[832]: info: ------------------------------ 33ms Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::volumioGetQueue Jul 03 15:27:20 volumio volumio[832]: info: CoreStateMachine::getQueue Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:20 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:20 volumio volumio[832]: info: [1751574440579] [Pandora] PandoraHandler::fetchTracks::fetchStationPlaylist: Retrieved Spirit In The Sky (Deluxe Edition) Radio playlist Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: [1751574440579] ControllerPandora::PandoraHandler::fetchTracks::fillNewTracks Jul 03 15:27:20 volumio volumio[832]: info: [1751574440579] [Pandora] PandoraHandler::fetchTracks::fillNewTracks: Fetched 4 track(s) Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::addQueueItems Jul 03 15:27:20 volumio volumio[832]: info: Preload queue cleared Jul 03 15:27:20 volumio volumio[832]: info: Adding Item to queue: /pandora/stationToken=144106394130338806trackId=1771087411393842807 Jul 03 15:27:20 volumio volumio[832]: info: Exploding uri /pandora/stationToken=144106394130338806trackId=1771087411393842807 in service pandora Jul 03 15:27:20 volumio volumio[832]: info: [1751574440580] ControllerPandora::explodeUri Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: Adding Item to queue: /pandora/stationToken=144106394130338806trackId=6898422042783215910 Jul 03 15:27:20 volumio volumio[832]: info: Exploding uri /pandora/stationToken=144106394130338806trackId=6898422042783215910 in service pandora Jul 03 15:27:20 volumio volumio[832]: info: [1751574440581] ControllerPandora::explodeUri Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: Adding Item to queue: /pandora/stationToken=144106394130338806trackId=904847330054343133 Jul 03 15:27:20 volumio volumio[832]: info: Exploding uri /pandora/stationToken=144106394130338806trackId=904847330054343133 in service pandora Jul 03 15:27:20 volumio volumio[832]: info: [1751574440581] ControllerPandora::explodeUri Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: Adding Item to queue: /pandora/stationToken=144106394130338806trackId=850350753101125866 Jul 03 15:27:20 volumio volumio[832]: info: Exploding uri /pandora/stationToken=144106394130338806trackId=850350753101125866 in service pandora Jul 03 15:27:20 volumio volumio[832]: info: [1751574440582] ControllerPandora::explodeUri Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: CoreCommandRouter::volumioPushQueue Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::saveQueue Jul 03 15:27:20 volumio volumio[832]: info: CoreStateMachine::updateTrackBlock Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getTrackBlock Jul 03 15:27:20 volumio volumio[832]: info: [1751574440592] ControllerPandora::getStationTracks Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: [1751574440592] [Pandora] PandoraHandler::getSongMaxDiff: 6 Jul 03 15:27:20 volumio volumio[832]: info: [1751574440592] ControllerPandora::fetchAndAddTracks::getSqInfo Jul 03 15:27:20 volumio volumio[832]: info: [1751574440592] ControllerPandora::getStationTracks Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: [1751574440593] [Pandora] fetchAndAddTracks: diff2 > 0: 6 sQPos2: 2 Jul 03 15:27:20 volumio volumio[832]: info: [1751574440593] ControllerPandora::removeOldTrackBlock Jul 03 15:27:20 volumio volumio[832]: info: [1751574440593] ControllerPandora::removeStationTracks Jul 03 15:27:20 volumio volumio[832]: info: [1751574440593] ControllerPandora::getStationTracks Jul 03 15:27:20 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:20 volumio volumio[832]: info: [1751574440594] [Pandora] removeStationTracks: Removing 2 tracks from queue Jul 03 15:27:30 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:30 volumio volumio[832]: info: [1751574450594] ControllerPandora::removeTrack Jul 03 15:27:30 volumio volumio[832]: info: CoreStateMachine::removeQueueItem Jul 03 15:27:30 volumio volumio[832]: info: CorePlayQueue::removeQueueItem 0 Jul 03 15:27:30 volumio volumio[832]: info: CorePlayQueue::saveQueue Jul 03 15:27:30 volumio volumio[832]: info: CoreCommandRouter::volumioPushQueue Jul 03 15:27:30 volumio volumio[832]: info: [1751574450598] [Pandora] removeTrack: Removed track with uri: /pandora/stationToken=144106394130338806trackId=5546377555030381860 at queue index: 0 Jul 03 15:27:30 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:30 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:30 volumio volumio[832]: info: sendMpdCommand status took 13 milliseconds Jul 03 15:27:30 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:30 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 15:27:30 volumio volumio[832]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 03 15:27:30 volumio volumio[832]: verbose: ControllerMpd::parseTrackInfo Jul 03 15:27:30 volumio volumio[832]: info: [1751574450613] ControllerPandora::pushState Jul 03 15:27:30 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:30 volumio volumio[832]: info: CorePlayQueue::getTrack 1 Jul 03 15:27:30 volumio volumio[832]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11359,"duration":167,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"(Sittin' On) the Dock of the Bay","artist":"Otis Redding","album":"The Very Best of Otis Redding","uri":"http://t1-4.p-cdn.us/access/6091367393615339342.mp3?version=5&lid=640185022&token=rg1Yx%2FpkvAwt0TLD7QoF9YMsHyCVdvNlRO029lzjRr%2Fhb5VWgsjI8zH1hBxoMUAVHEMIvKF3uH022DyIgX3N%2FFplzo%2FYfWX7Lls4sG9Z5mnsz05zl1BDUYZjj4v0gJVWvJDqWEoCyt6KyYgNMNupp3XDS9%2BhSkJRyW%2FBXpeJQwg2PitGFX%2Fazqc0yvx2gx2%2FOjL5gqCixyvvpI6r93ANmh7CbksbzonTbu3jfTWWCNPQDGzBclrmBDTV51KRF%2FdCatYQwCfjaefT7QGylYi2TYFEgXHGjzbd9H%2BDw0X5GDq0T%2FzODKxi27VmSbTMYnGoWJe%2FSxo2B7LEo6YOpPpAAQ%3D%3D","trackType":"mp3"} Jul 03 15:27:30 volumio volumio[832]: verbose: CURRENT POSITION 1 Jul 03 15:27:30 volumio volumio[832]: info: CoreStateMachine::syncState stateService play Jul 03 15:27:30 volumio volumio[832]: info: CoreStateMachine::syncState currentStatus play Jul 03 15:27:30 volumio volumio[832]: info: Received an update from plugin. extracting info from payload Jul 03 15:27:30 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:30 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:30 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:30 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:30 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:30 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 15:27:30 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:30 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:35 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 03 15:27:35 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 03 15:27:35 volumio volumio[832]: info: Discovery: Getting this device information Jul 03 15:27:35 volumio volumio[832]: info: CoreCommandRouter::volumioGetState Jul 03 15:27:35 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 03 15:27:40 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:40 volumio volumio[832]: info: [1751574460594] ControllerPandora::removeTrack Jul 03 15:27:40 volumio volumio[832]: info: CoreStateMachine::removeQueueItem Jul 03 15:27:40 volumio volumio[832]: info: CorePlayQueue::removeQueueItem 0 Jul 03 15:27:40 volumio volumio[832]: info: CorePlayQueue::saveQueue Jul 03 15:27:40 volumio volumio[832]: info: CoreCommandRouter::volumioPushQueue Jul 03 15:27:40 volumio volumio[832]: info: [1751574460598] [Pandora] removeTrack: Removed track with uri: /pandora/stationToken=144106394130338806trackId=3568992691165485238 at queue index: 0 Jul 03 15:27:40 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:40 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:40 volumio volumio[832]: info: sendMpdCommand status took 12 milliseconds Jul 03 15:27:40 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:40 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 15:27:40 volumio volumio[832]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 03 15:27:40 volumio volumio[832]: verbose: ControllerMpd::parseTrackInfo Jul 03 15:27:40 volumio volumio[832]: info: [1751574460613] ControllerPandora::pushState Jul 03 15:27:40 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:40 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:40 volumio volumio[832]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21359,"duration":167,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"(Sittin' On) the Dock of the Bay","artist":"Otis Redding","album":"The Very Best of Otis Redding","uri":"http://t1-4.p-cdn.us/access/6091367393615339342.mp3?version=5&lid=640185022&token=rg1Yx%2FpkvAwt0TLD7QoF9YMsHyCVdvNlRO029lzjRr%2Fhb5VWgsjI8zH1hBxoMUAVHEMIvKF3uH022DyIgX3N%2FFplzo%2FYfWX7Lls4sG9Z5mnsz05zl1BDUYZjj4v0gJVWvJDqWEoCyt6KyYgNMNupp3XDS9%2BhSkJRyW%2FBXpeJQwg2PitGFX%2Fazqc0yvx2gx2%2FOjL5gqCixyvvpI6r93ANmh7CbksbzonTbu3jfTWWCNPQDGzBclrmBDTV51KRF%2FdCatYQwCfjaefT7QGylYi2TYFEgXHGjzbd9H%2BDw0X5GDq0T%2FzODKxi27VmSbTMYnGoWJe%2FSxo2B7LEo6YOpPpAAQ%3D%3D","trackType":"mp3"} Jul 03 15:27:40 volumio volumio[832]: verbose: CURRENT POSITION 0 Jul 03 15:27:40 volumio volumio[832]: info: CoreStateMachine::syncState stateService play Jul 03 15:27:40 volumio volumio[832]: info: CoreStateMachine::syncState currentStatus play Jul 03 15:27:40 volumio volumio[832]: info: Received an update from plugin. extracting info from payload Jul 03 15:27:40 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:40 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:40 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:40 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:40 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:40 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 15:27:40 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:40 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::volumioPlay Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::play index 3 Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::stop Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::stPlaybackTimer Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::updateTrackBlock Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrackBlock Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::serviceStop Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::serviceStop Jul 03 15:27:51 volumio volumio[832]: info: [1751574471748] ControllerPandora::stop Jul 03 15:27:51 volumio volumio[832]: info: ControllerMpd::stop Jul 03 15:27:51 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 15:27:51 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:51 volumio volumio[832]: info: sendMpdCommand stop took 7 milliseconds Jul 03 15:27:51 volumio volumio[832]: info: ControllerMpd::clear Jul 03 15:27:51 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:51 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:51 volumio volumio[832]: info: sendMpdCommand clear took 3 milliseconds Jul 03 15:27:51 volumio volumio[832]: info: [1751574471761] ControllerPandora::pushState Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:51 volumio volumio[832]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"(Sittin' On) the Dock of the Bay","name":"(Sittin' On) the Dock of the Bay","artist":"Otis Redding","album":"The Very Best of Otis Redding","albumart":"http://cont-1.p-cdn.us/images/84/dc/d2/32/404348f5b7701204be5e67a8/1080W_1080H.jpg","realUri":"http://t1-4.p-cdn.us/access/6091367393615339342.mp3?version=5&lid=640185022&token=rg1Yx%2FpkvAwt0TLD7QoF9YMsHyCVdvNlRO029lzjRr%2Fhb5VWgsjI8zH1hBxoMUAVHEMIvKF3uH022DyIgX3N%2FFplzo%2FYfWX7Lls4sG9Z5mnsz05zl1BDUYZjj4v0gJVWvJDqWEoCyt6KyYgNMNupp3XDS9%2BhSkJRyW%2FBXpeJQwg2PitGFX%2Fazqc0yvx2gx2%2FOjL5gqCixyvvpI6r93ANmh7CbksbzonTbu3jfTWWCNPQDGzBclrmBDTV51KRF%2FdCatYQwCfjaefT7QGylYi2TYFEgXHGjzbd9H%2BDw0X5GDq0T%2FzODKxi27VmSbTMYnGoWJe%2FSxo2B7LEo6YOpPpAAQ%3D%3D","isStreaming":true,"duration":167,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-4.p-cdn.us/access/6091367393615339342.mp3?version=5&lid=640185022&token=rg1Yx%2FpkvAwt0TLD7QoF9YMsHyCVdvNlRO029lzjRr%2Fhb5VWgsjI8zH1hBxoMUAVHEMIvKF3uH022DyIgX3N%2FFplzo%2FYfWX7Lls4sG9Z5mnsz05zl1BDUYZjj4v0gJVWvJDqWEoCyt6KyYgNMNupp3XDS9%2BhSkJRyW%2FBXpeJQwg2PitGFX%2Fazqc0yvx2gx2%2FOjL5gqCixyvvpI6r93ANmh7CbksbzonTbu3jfTWWCNPQDGzBclrmBDTV51KRF%2FdCatYQwCfjaefT7QGylYi2TYFEgXHGjzbd9H%2BDw0X5GDq0T%2FzODKxi27VmSbTMYnGoWJe%2FSxo2B7LEo6YOpPpAAQ%3D%3D","seek":0,"status":"stop"} Jul 03 15:27:51 volumio volumio[832]: verbose: CURRENT POSITION 0 Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::syncState stateService stop Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::syncState currentStatus stop Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:51 volumio volumio[832]: info: No code Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 0 Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::play index undefined Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 3 Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::startPlaybackTimer Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 3 Jul 03 15:27:51 volumio volumio[832]: info: [1751574471778] ControllerPandora::clearAddPlayTrack Jul 03 15:27:51 volumio volumio[832]: info: ControllerMpd::clear Jul 03 15:27:51 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:51 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:51 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces state update: player Jul 03 15:27:51 volumio volumio[832]: info: ControllerMpd::getState Jul 03 15:27:51 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand status Jul 03 15:27:51 volumio volumio[832]: error: updateQueue error: null Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: info: sendMpdCommand status took 23 milliseconds Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 25ms Jul 03 15:27:51 volumio volumio[832]: info: sendMpdCommand clear took 4 milliseconds Jul 03 15:27:51 volumio volumio[832]: info: sendMpdCommand status took 3 milliseconds Jul 03 15:27:51 volumio volumio[832]: info: sendMpdCommand status took 2 milliseconds Jul 03 15:27:51 volumio volumio[832]: verbose: ControllerMpd::parseState Jul 03 15:27:51 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 3 Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 3 Jul 03 15:27:51 volumio volumio[832]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current pandora Received mpd Jul 03 15:27:51 volumio volumio[832]: info: [1751574471790] ControllerPandora::checkForExpiredStations Jul 03 15:27:51 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 3 Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 3 Jul 03 15:27:51 volumio volumio[832]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current pandora Received mpd Jul 03 15:27:51 volumio volumio[832]: info: ControllerMpd::pushState Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::pushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 3 Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::volumioPushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 3 Jul 03 15:27:51 volumio volumio[832]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current pandora Received mpd Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 40ms Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:51 volumio volumio[832]: info: [1751574471798] ControllerPandora::removeTrack Jul 03 15:27:51 volumio volumio[832]: info: [1751574471798] [Pandora] removeTrack: Not removing track with uri: null at queue index: -1 Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 19ms Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 18ms Jul 03 15:27:51 volumio volumio[832]: info: [1751574471800] ControllerPandora::appendTracksToMpd Jul 03 15:27:51 volumio volumio[832]: info: [1751574471800] [Pandora] appendTracksToMpd: Added 1 track(s) to mpd Jul 03 15:27:51 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand addid Jul 03 15:27:51 volumio volumio[832]: verbose: ControllerMpd::sendMpdCommand play Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:51 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:51 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:51 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:51 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:51 volumio volumio[832]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 03 15:27:51 volumio volumio[832]: error: updateQueue error: null Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 35ms Jul 03 15:27:51 volumio volumio[832]: info: sendMpdCommand addid took 17 milliseconds Jul 03 15:27:51 volumio volumio[832]: info: sendMpdCommand play took 17 milliseconds Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 15ms Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 15ms Jul 03 15:27:51 volumio volumio[832]: verbose: MPD COMMAND [object Object] Jul 03 15:27:51 volumio volumio[832]: verbose: MPD COMMAND [object Object] Jul 03 15:27:51 volumio volumio[832]: info: [1751574471819] ControllerPandora::pushState Jul 03 15:27:51 volumio volumio[832]: info: CoreCommandRouter::servicePushState Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getTrack 3 Jul 03 15:27:51 volumio volumio[832]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Dreams (2004 Remaster)","name":"Dreams (2004 Remaster)","artist":"Fleetwood Mac","album":"Rumours (Deluxe Edition)","albumart":"http://cont-5.p-cdn.us/images/af/d0/8e/c7/393a49ddb7788b7668f897c9/1080W_1080H.jpg","realUri":"http://t1-2.p-cdn.us/access/392150873347761018.mp3?version=5&lid=640185022&token=rg1Yx%2FpkvAxyvzGRk3WvK0gkJyB%2FimiRZ01YIEiTSaubwP%2FR0jacdQq7R4hfhFb7vFQ08LURRc15wmt5y3hFKDkVOJmohqZf2mdVG6f4ZKj3qKhWQCXURqMtVmEY4oVdmua0zH1PIx2GESnDAYBtH%2FcVmAaB8oUj5ZTnuTOxeUF0bWRKex%2F29HdUMZOPaYctFxnWV8bkhDc7iLystK3hlyyyxWXPUE8GkjeiqPqb0R2bU1RUXSHuN32lhWEypEM1F%2FWO%2B6FiWvaDVCsWqlAHfAPIlHPuhPsHu0AZvYjz8ZqFB%2BJB9dIG2fLdmJbPNDDlSZU1sGQCt7XGwey86cGwKg%3D%3D","isStreaming":true,"duration":258,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-2.p-cdn.us/access/392150873347761018.mp3?version=5&lid=640185022&token=rg1Yx%2FpkvAxyvzGRk3WvK0gkJyB%2FimiRZ01YIEiTSaubwP%2FR0jacdQq7R4hfhFb7vFQ08LURRc15wmt5y3hFKDkVOJmohqZf2mdVG6f4ZKj3qKhWQCXURqMtVmEY4oVdmua0zH1PIx2GESnDAYBtH%2FcVmAaB8oUj5ZTnuTOxeUF0bWRKex%2F29HdUMZOPaYctFxnWV8bkhDc7iLystK3hlyyyxWXPUE8GkjeiqPqb0R2bU1RUXSHuN32lhWEypEM1F%2FWO%2B6FiWvaDVCsWqlAHfAPIlHPuhPsHu0AZvYjz8ZqFB%2BJB9dIG2fLdmJbPNDDlSZU1sGQCt7XGwey86cGwKg%3D%3D","seek":0,"status":"play"} Jul 03 15:27:51 volumio volumio[832]: verbose: CURRENT POSITION 3 Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::syncState stateService play Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::syncState currentStatus stop Jul 03 15:27:51 volumio volumio[832]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 15:27:51 volumio volumio[832]: info: [1751574471820] ControllerPandora::fetchAndAddTracks Jul 03 15:27:51 volumio volumio[832]: info: [1751574471820] ControllerPandora::getStationTracks Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:51 volumio volumio[832]: info: [1751574471820] [Pandora] PandoraHandler::getSongMaxDiff: 4 Jul 03 15:27:51 volumio volumio[832]: info: [1751574471820] ControllerPandora::fetchAndAddTracks::getSqInfo Jul 03 15:27:51 volumio volumio[832]: info: [1751574471820] ControllerPandora::getStationTracks Jul 03 15:27:51 volumio volumio[832]: info: CorePlayQueue::getQueue Jul 03 15:27:51 volumio volumio[832]: info: [1751574471821] [Pandora] fetchAndAddTracks: diff1: 4 sQPos1: 3 Jul 03 15:27:51 volumio volumio[832]: info: [1751574471821] [Pandora] fetchAndAddTracks: Fetching tracks Jul 03 15:27:51 volumio volumio[832]: info: [1751574471821] ControllerPandora::PandoraHandler::fillStationData Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 14ms Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 7ms Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: info: Jul 03 15:27:51 volumio volumio[832]: ---------------------------- MPD announces system playlist update Jul 03 15:27:51 volumio volumio[832]: info: Ignoring MPD Status Update Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 5ms Jul 03 15:27:51 volumio volumio[832]: info: ------------------------------ 2ms Jul 03 15:27:52 volumio volumio[832]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 03 15:27:52 volumio volumio[832]: SyntaxError: Unexpected token u in JSON at position 0 Jul 03 15:27:52 volumio volumio[832]: at JSON.parse () Jul 03 15:27:52 volumio volumio[832]: at Request._callback (/data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:41:31) Jul 03 15:27:52 volumio volumio[832]: at Request.self.callback (/data/plugins/music_service/pandora/node_modules/request/request.js:185:22) Jul 03 15:27:52 volumio volumio[832]: at Request.emit (events.js:315:20) Jul 03 15:27:52 volumio volumio[832]: at Request. (/data/plugins/music_service/pandora/node_modules/request/request.js:1154:10) Jul 03 15:27:52 volumio volumio[832]: at Request.emit (events.js:315:20) Jul 03 15:27:52 volumio volumio[832]: at IncomingMessage. (/data/plugins/music_service/pandora/node_modules/request/request.js:1076:12) Jul 03 15:27:52 volumio volumio[832]: at Object.onceWrapper (events.js:421:28) Jul 03 15:27:52 volumio volumio[832]: at IncomingMessage.emit (events.js:327:22) Jul 03 15:27:52 volumio volumio[832]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 03 15:27:52 volumio volumio[832]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 03 15:27:52 volumio volumio[832]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 03 15:27:52 volumio sudo[7836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-03 15:26 Jul 03 15:27:52 volumio sudo[7836]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"