-- Logs begin at Mon 2025-09-01 00:53:41 EDT, end at Mon 2025-09-01 02:05:42 EDT. -- Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: [1756706642994] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:02 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:02 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: [1756706642997] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: [1756706642997] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: [1756706642998] ControllerPandora::stop Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:02 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:02 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:03 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 0 milliseconds Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: [1756706643000] ControllerPandora::pushState Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:03 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:03 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: [1756706643009] ControllerPandora::removeTrack Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: [1756706643009] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: Sep 01 02:04:03 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: Sep 01 02:04:03 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: Sep 01 02:04:03 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: Sep 01 02:04:03 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:03 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:03 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: ------------------------------ 5ms Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: ------------------------------ 4ms Sep 01 02:04:03 volumiopi3bplus volumio[992]: info: ------------------------------ 3ms Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: [1756706648010] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:08 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:08 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: [1756706648013] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: [1756706648013] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: [1756706648013] ControllerPandora::stop Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:08 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:08 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: Sep 01 02:04:08 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: [1756706648016] ControllerPandora::pushState Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:08 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:08 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: [1756706648023] ControllerPandora::removeTrack Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: [1756706648023] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: Sep 01 02:04:08 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: Sep 01 02:04:08 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: Sep 01 02:04:08 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:08 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:08 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:08 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:08 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: [1756706653023] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:13 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:13 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: [1756706653026] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: [1756706653026] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: [1756706653026] ControllerPandora::stop Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:13 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:13 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: Sep 01 02:04:13 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: [1756706653029] ControllerPandora::pushState Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:13 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:13 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: [1756706653037] ControllerPandora::removeTrack Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: [1756706653037] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: Sep 01 02:04:13 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: Sep 01 02:04:13 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: Sep 01 02:04:13 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:13 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:13 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:13 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: ------------------------------ 12ms Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: ------------------------------ 3ms Sep 01 02:04:13 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: [1756706658038] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:18 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:18 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: [1756706658041] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: [1756706658041] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: [1756706658041] ControllerPandora::stop Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:18 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:18 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: Sep 01 02:04:18 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: [1756706658044] ControllerPandora::pushState Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:18 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:18 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: [1756706658051] ControllerPandora::removeTrack Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: [1756706658051] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: Sep 01 02:04:18 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: Sep 01 02:04:18 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: Sep 01 02:04:18 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:18 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:18 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:18 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:18 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: [1756706663051] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:23 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:23 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: [1756706663054] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: [1756706663054] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: [1756706663054] ControllerPandora::stop Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:23 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 0 milliseconds Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:23 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: Sep 01 02:04:23 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 3 milliseconds Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: [1756706663058] ControllerPandora::pushState Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:23 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:23 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: [1756706663065] ControllerPandora::removeTrack Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: [1756706663065] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: Sep 01 02:04:23 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: Sep 01 02:04:23 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: Sep 01 02:04:23 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:23 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:23 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:23 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: ------------------------------ 3ms Sep 01 02:04:23 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: [1756706668066] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:28 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 0 milliseconds Sep 01 02:04:28 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: [1756706668069] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: [1756706668069] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: [1756706668069] ControllerPandora::stop Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:28 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 0 milliseconds Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:28 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: Sep 01 02:04:28 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: [1756706668072] ControllerPandora::pushState Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:28 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:28 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: [1756706668079] ControllerPandora::removeTrack Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: [1756706668079] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: Sep 01 02:04:28 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: Sep 01 02:04:28 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: Sep 01 02:04:28 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:28 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:28 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:28 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: ------------------------------ 10ms Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:28 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: [1756706673080] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:33 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:33 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: [1756706673082] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: [1756706673082] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: [1756706673084] ControllerPandora::stop Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:33 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:33 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: Sep 01 02:04:33 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: [1756706673087] ControllerPandora::pushState Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:33 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:33 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: [1756706673094] ControllerPandora::removeTrack Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: [1756706673094] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: Sep 01 02:04:33 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: Sep 01 02:04:33 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: Sep 01 02:04:33 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:33 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:33 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:33 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: ------------------------------ 10ms Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:33 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: [1756706678094] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:38 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:38 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: [1756706678097] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: [1756706678097] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: [1756706678097] ControllerPandora::stop Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:38 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 0 milliseconds Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:38 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: Sep 01 02:04:38 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: [1756706678100] ControllerPandora::pushState Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:38 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:38 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: [1756706678107] ControllerPandora::removeTrack Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: [1756706678107] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: Sep 01 02:04:38 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: Sep 01 02:04:38 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: Sep 01 02:04:38 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:38 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:38 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:38 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: ------------------------------ 3ms Sep 01 02:04:38 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: [1756706683108] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:43 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:43 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: [1756706683112] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: [1756706683112] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: [1756706683112] ControllerPandora::stop Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:43 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:43 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: Sep 01 02:04:43 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: [1756706683115] ControllerPandora::pushState Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:43 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:43 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: [1756706683122] ControllerPandora::removeTrack Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: [1756706683122] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: Sep 01 02:04:43 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: Sep 01 02:04:43 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: Sep 01 02:04:43 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:43 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:43 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:43 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:43 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: [1756706688123] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:48 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:48 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: [1756706688125] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: [1756706688125] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: [1756706688126] ControllerPandora::stop Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:48 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 0 milliseconds Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:48 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: Sep 01 02:04:48 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 1 milliseconds Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: [1756706688128] ControllerPandora::pushState Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:48 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:48 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: [1756706688135] ControllerPandora::removeTrack Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: [1756706688136] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: Sep 01 02:04:48 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: Sep 01 02:04:48 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: Sep 01 02:04:48 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:48 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:48 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:48 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:48 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: [1756706693136] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:53 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:53 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: [1756706693139] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: [1756706693139] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: [1756706693140] ControllerPandora::stop Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:53 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 0 milliseconds Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:53 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: Sep 01 02:04:53 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 1 milliseconds Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: [1756706693142] ControllerPandora::pushState Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:53 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:53 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: [1756706693149] ControllerPandora::removeTrack Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: [1756706693150] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: Sep 01 02:04:53 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: Sep 01 02:04:53 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: Sep 01 02:04:53 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:53 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:53 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:53 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:04:53 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: [1756706698150] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:04:58 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:04:58 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: [1756706698153] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: [1756706698153] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: [1756706698153] ControllerPandora::stop Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:04:58 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 0 milliseconds Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:04:58 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: Sep 01 02:04:58 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: [1756706698156] ControllerPandora::pushState Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:04:58 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:04:58 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: No code Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: [1756706698163] ControllerPandora::removeTrack Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: [1756706698163] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: Sep 01 02:04:58 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: Sep 01 02:04:58 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: Sep 01 02:04:58 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:04:58 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:58 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:58 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: ------------------------------ 10ms Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: ------------------------------ 3ms Sep 01 02:04:58 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: [1756706703164] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:05:03 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:05:03 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: [1756706703167] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: [1756706703167] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: [1756706703167] ControllerPandora::stop Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:05:03 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 0 milliseconds Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:05:03 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: Sep 01 02:05:03 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: [1756706703170] ControllerPandora::pushState Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:03 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:05:03 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: No code Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: [1756706703177] ControllerPandora::removeTrack Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: [1756706703177] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: Sep 01 02:05:03 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: Sep 01 02:05:03 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: Sep 01 02:05:03 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:03 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:03 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:03 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: ------------------------------ 3ms Sep 01 02:05:03 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: [1756706708178] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:05:08 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 0 milliseconds Sep 01 02:05:08 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: [1756706708181] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: [1756706708181] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: [1756706708181] ControllerPandora::stop Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:05:08 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:05:08 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: Sep 01 02:05:08 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: [1756706708184] ControllerPandora::pushState Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:08 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:05:08 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: No code Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: [1756706708191] ControllerPandora::removeTrack Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: [1756706708191] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: Sep 01 02:05:08 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: Sep 01 02:05:08 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: Sep 01 02:05:08 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:08 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:08 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:08 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:05:08 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: [1756706713192] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:05:13 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:05:13 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: [1756706713194] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: [1756706713194] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: [1756706713195] ControllerPandora::stop Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:05:13 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 0 milliseconds Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:05:13 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: Sep 01 02:05:13 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 1 milliseconds Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: [1756706713197] ControllerPandora::pushState Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:13 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:05:13 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: No code Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: [1756706713204] ControllerPandora::removeTrack Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: [1756706713204] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: Sep 01 02:05:13 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: Sep 01 02:05:13 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: Sep 01 02:05:13 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:13 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:13 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:13 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: ------------------------------ 3ms Sep 01 02:05:13 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: [1756706718205] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:05:18 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 0 milliseconds Sep 01 02:05:18 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: [1756706718208] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: [1756706718208] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: [1756706718208] ControllerPandora::stop Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:05:18 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:05:18 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: Sep 01 02:05:18 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: [1756706718211] ControllerPandora::pushState Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:18 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:05:18 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: No code Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: [1756706718218] ControllerPandora::removeTrack Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: [1756706718218] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: Sep 01 02:05:18 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: Sep 01 02:05:18 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: Sep 01 02:05:18 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:18 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:18 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:18 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: ------------------------------ 10ms Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:05:18 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: [1756706723218] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:05:23 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:05:23 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: [1756706723220] [Pandora] StreamLifeChecker::heartMonitor: Nirvana - Breed by 90s90s Grunge timed out. Advancing track Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: [1756706723221] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: [1756706723221] ControllerPandora::stop Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:05:23 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:05:23 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: Sep 01 02:05:23 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 1 milliseconds Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: [1756706723224] ControllerPandora::pushState Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:23 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:05:23 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: No code Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: [1756706723231] ControllerPandora::removeTrack Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: [1756706723231] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: Sep 01 02:05:23 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: Sep 01 02:05:23 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: Sep 01 02:05:23 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:23 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:23 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:23 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:05:23 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:05:25 volumiopi3bplus volumio[992]: info: [1756706725923] [80s80s] Pushing the next song state No Doubt - Sunday Morning and getting next track. Sep 01 02:05:25 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:05:25 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:25 volumiopi3bplus volumio[992]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received 80s80s Sep 01 02:05:25 volumiopi3bplus volumio[992]: info: [1756706725923] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=253&count=1 Sep 01 02:05:26 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:26 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:26 volumiopi3bplus volumio[992]: info: Prefetching next song Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: [1756706728231] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:05:28 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:05:28 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: [1756706728234] [Pandora] StreamLifeChecker::heartMonitor: No Doubt - Sunday Morning by 90s90s Grunge timed out. Advancing track Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: [1756706728234] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: [1756706728234] ControllerPandora::stop Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:05:28 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:05:28 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: Sep 01 02:05:28 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: [1756706728237] ControllerPandora::pushState Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:28 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:05:28 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: No code Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: [1756706728244] ControllerPandora::removeTrack Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: [1756706728244] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: Sep 01 02:05:28 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: Sep 01 02:05:28 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: Sep 01 02:05:28 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:28 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: ------------------------------ 11ms Sep 01 02:05:28 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:28 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: ------------------------------ 5ms Sep 01 02:05:28 volumiopi3bplus volumio[992]: info: ------------------------------ 4ms Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: [1756706733245] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:05:33 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 2 milliseconds Sep 01 02:05:33 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: [1756706733248] [Pandora] StreamLifeChecker::heartMonitor: No Doubt - Sunday Morning by 90s90s Grunge timed out. Advancing track Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: [1756706733248] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: [1756706733249] ControllerPandora::stop Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:05:33 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 1 milliseconds Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:05:33 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: Sep 01 02:05:33 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 2 milliseconds Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: [1756706733252] ControllerPandora::pushState Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:33 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:05:33 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: No code Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: [1756706733259] ControllerPandora::removeTrack Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: [1756706733259] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: Sep 01 02:05:33 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: Sep 01 02:05:33 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: Sep 01 02:05:33 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:33 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:33 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:33 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: ------------------------------ 12ms Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: ------------------------------ 3ms Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: ------------------------------ 2ms Sep 01 02:05:33 volumiopi3bplus volumio[992]: info: ------------------------------ 1ms Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: [1756706738259] ControllerPandora::StreamLifeChecker::heartMonitor Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: ControllerMpd::getState Sep 01 02:05:38 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand status Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: sendMpdCommand status took 1 milliseconds Sep 01 02:05:38 volumiopi3bplus volumio[992]: verbose: ControllerMpd::parseState Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: [1756706738262] [Pandora] StreamLifeChecker::heartMonitor: No Doubt - Sunday Morning by 90s90s Grunge timed out. Advancing track Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: [1756706738262] [Pandora] handleMediaButton: User chose "skip" function Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: [1756706738262] ControllerPandora::stop Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: ControllerMpd::stop Sep 01 02:05:38 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: sendMpdCommand stop took 2 milliseconds Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: ControllerMpd::clear Sep 01 02:05:38 volumiopi3bplus volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: Sep 01 02:05:38 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: sendMpdCommand clear took 1 milliseconds Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: [1756706738265] ControllerPandora::pushState Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::servicePushState Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CorePlayQueue::getTrack 0 Sep 01 02:05:38 volumiopi3bplus volumio[992]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Miracles","name":"Miracles","artist":"Jefferson Starship","album":"Red Octopus","albumart":"http://mediaserver-cont-sv5-1-v4v6.pandora.com/images/f4/52/39/e4/7c1642d08330d707930e0a78/1080W_1080H.jpg","realUri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","isStreaming":true,"duration":412,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-5.p-cdn.us/access/3972181355678673713.mp3?version=5&lid=145177365&token=1xv7%2Bz66bDit4os585%2BQVBQnUI5mJNfotNdssHv2VVuA9E7b8C0oIc1Y8GjQ9MnrKScvzepqVqI4%2BdMveD0yAk%2FVYEyGBVkHXC6%2FbgbGjAhUlYSbr1cYnOxz2vrvVPrnXuvOXXAEqY%2FUVPQwInXQeQbKwHeB2%2FFOrksnMklQS5KcRCyJPVBk6RFQYtYAJs0aerRj%2FkUAmjXrFHD9RsWZUX0HZYSGSg2vLXOkKxIuvcGOx592Z8o19WUINJQySU%2FguUIW0FTUkXptobcTEECtDWr9LtSBZEAG0UCQty3JJF01T6REmivFQg6ErL1WqhfEl34%2FkAR6LK9%2FTJnCTs3UUg%3D%3D","seek":11257,"status":"stop"} Sep 01 02:05:38 volumiopi3bplus volumio[992]: verbose: CURRENT POSITION 0 Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState stateService stop Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::syncState currentStatus stop Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: No code Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::pushState Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreCommandRouter::volumioPushState Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CoreStateMachine::setConsumeUpdateService pandora Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: CorePlayQueue::getQueue Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: [1756706738272] ControllerPandora::removeTrack Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: [1756706738272] [Pandora] removeTrack: Not removing track with uri: http://streams.90s90s.de/grunge/mp3-192/volumio at queue index: 0 Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: Sep 01 02:05:38 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: Sep 01 02:05:38 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: Sep 01 02:05:38 volumiopi3bplus volumio[992]: ---------------------------- MPD announces system playlist update Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: Ignoring MPD Status Update Sep 01 02:05:38 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: ------------------------------ 10ms Sep 01 02:05:38 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:38 volumiopi3bplus volumio[992]: error: updateQueue error: null Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: ------------------------------ 7ms Sep 01 02:05:38 volumiopi3bplus volumio[992]: info: ------------------------------ 6ms Sep 01 02:05:41 volumiopi3bplus volumio[992]: info: [1756706741426] [80s80s] Failed to query api, status code: 503 Sep 01 02:05:41 volumiopi3bplus volumio[992]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 02:05:41 volumiopi3bplus volumio[992]: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/80s80s/fake-data.json' Sep 01 02:05:41 volumiopi3bplus volumio[992]: at Object.openSync (fs.js:476:3) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at Object.readFileSync (fs.js:377:35) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at ClientRequest. (/data/plugins/music_service/80s80s/index.js:485:23) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at Object.onceWrapper (events.js:422:26) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at ClientRequest.emit (events.js:315:20) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at Socket.socketOnData (_http_client.js:509:22) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at Socket.emit (events.js:315:20) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at addChunk (internal/streams/readable.js:309:12) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at readableAddChunk (internal/streams/readable.js:284:9) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at Socket.Readable.push (internal/streams/readable.js:223:10) Sep 01 02:05:41 volumiopi3bplus volumio[992]: at TCP.onStreamRead (internal/stream_base_commons.js:188:23) { Sep 01 02:05:41 volumiopi3bplus volumio[992]: errno: -2, Sep 01 02:05:41 volumiopi3bplus volumio[992]: syscall: 'open', Sep 01 02:05:41 volumiopi3bplus volumio[992]: code: 'ENOENT', Sep 01 02:05:41 volumiopi3bplus volumio[992]: path: '/data/plugins/music_service/80s80s/fake-data.json' Sep 01 02:05:41 volumiopi3bplus volumio[992]: } Sep 01 02:05:41 volumiopi3bplus volumio[992]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 02:05:42 volumiopi3bplus sudo[21935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-01 02:04 Sep 01 02:05:42 volumiopi3bplus sudo[21935]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"