-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Wed 2025-01-15 14:17:51 CST. -- Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:00 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:00 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:01 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:01 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:02 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:02 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:03 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:03 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:04 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:04 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:09 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:09 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 15 14:16:15 volumio volumio[865]: info: Retrying Login Due to Network Error Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:15 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:15 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:25 volumio volumio[865]: info: MyVolumio login type: Token Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:27 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:27 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:34 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:34 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:40 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:40 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:46 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:46 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:55 volumio volumio[865]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 15 14:16:55 volumio volumio[865]: info: Retrying Login Due to Network Error Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPlay Jan 15 14:16:58 volumio volumio[865]: verbose: UNSET VOLATILE: Service: airplay_emulation Jan 15 14:16:58 volumio volumio[865]: info: Stopping Airplay Playback and sending pause command to client via USR2 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::play index 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::stop Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::stPlaybackTimer Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::updateTrackBlock Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrackBlock Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 0 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::serviceStop Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 0 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::serviceStop Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::stop Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand stop took 27 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::play index undefined Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::startPlaybackTimer Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand stop took 16 milliseconds Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand clear Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:16:58 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand clear took 43 milliseconds Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac" Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:16:58 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:16:58 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:16:58 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:16:58 volumio volumio[865]: error: updateQueue error: null Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:16:58 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 69ms Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand add "INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac" took 66 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 61ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 57ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 53ms Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand play Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:16:58 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:16:58 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:16:58 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:16:58 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 60 seconds. Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 63ms Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand play took 36 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 34ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 32ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 30ms Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand status took 70 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:58 volumio volumio[865]: info: Jan 15 14:16:58 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:58 volumio sudo[3311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 1229 Jan 15 14:16:58 volumio sudo[3311]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand status took 109 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand status took 108 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand status took 109 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand status took 46 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand playlistinfo took 46 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand status took 39 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand status took 19 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand status took 13 milliseconds Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:58 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 142ms Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand playlistinfo took 19 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand playlistinfo took 20 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand playlistinfo took 21 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand playlistinfo took 23 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 15 14:16:58 volumio volumio[865]: info: sendMpdCommand playlistinfo took 21 milliseconds Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:58 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"841 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:58 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:58 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:58 volumio sudo[3311]: pam_unix(sudo:session): session closed for user root Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:58 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:58 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:58 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:58 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:58 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:58 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:58 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:58 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:58 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:58 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:58 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:58 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:58 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:58 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 336ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 335ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 335ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 275ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 272ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 268ms Jan 15 14:16:58 volumio volumio[865]: info: ------------------------------ 248ms Jan 15 14:16:58 volumio volumio[865]: info: Shairport-Sync paused with USR2 Jan 15 14:16:58 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioSeek Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::seek Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","service":"mpd","name":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=108&web=%E7%BE%A4%E6%98%9F/%E5%A4%A7%E6%8F%90%E7%90%B4%E4%B8%8E%E5%90%89%E4%BB%96%E7%9A%84%E5%AF%B9%E8%AF%9D%206N%E7%BA%AF%E9%93%B6%E9%95%80%E8%86%9C/extralarge&path=%2FINTERNAL%2Fmusic%2F%E3%80%8A%E5%A4%A7%E6%8F%90%E7%90%B4%E4%B8%8E%E5%90%89%E4%BB%96%E7%9A%84%E5%AF%B9%E8%AF%9D%E3%80%8B6N%E7%BA%AF%E9%93%B6%E9%95%80%E8%86%9C%20%5BFLAC%5D&metadata=false","duration":223,"trackType":"flac","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::startPlaybackTimer Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: ControllerMpd::seek Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:59 volumio volumio[865]: error: null Jan 15 14:16:59 volumio volumio[865]: info: Jan 15 14:16:59 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:59 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:59 volumio volumio[865]: info: Jan 15 14:16:59 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:59 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:59 volumio volumio[865]: info: Jan 15 14:16:59 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:59 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:59 volumio volumio[865]: info: Jan 15 14:16:59 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:16:59 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:16:59 volumio volumio[865]: info: sendMpdCommand status took 18 milliseconds Jan 15 14:16:59 volumio volumio[865]: info: sendMpdCommand status took 15 milliseconds Jan 15 14:16:59 volumio volumio[865]: info: sendMpdCommand status took 12 milliseconds Jan 15 14:16:59 volumio volumio[865]: info: sendMpdCommand status took 3 milliseconds Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:16:59 volumio volumio[865]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 15 14:16:59 volumio volumio[865]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 15 14:16:59 volumio volumio[865]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:59 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:16:59 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":155000,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"665 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:59 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:59 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:59 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":155000,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"665 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:59 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:59 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:59 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":155709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"729 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:59 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:59 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:59 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":155709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"793 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:16:59 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:16:59 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:59 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:16:59 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:16:59 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:16:59 volumio volumio[865]: info: ------------------------------ 118ms Jan 15 14:16:59 volumio volumio[865]: info: ------------------------------ 116ms Jan 15 14:16:59 volumio volumio[865]: info: ------------------------------ 115ms Jan 15 14:16:59 volumio volumio[865]: info: ------------------------------ 107ms Jan 15 14:16:59 volumio volumio[865]: info: Restarting Shairport-Sync after stop Jan 15 14:16:59 volumio sudo[3324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 15 14:16:59 volumio sudo[3324]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 14:17:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 15 14:17:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:00 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:00 volumio volumio[865]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Jan 15 14:17:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:00 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:00 volumio volumio[865]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Jan 15 14:17:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:00 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:00 volumio volumio[865]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Jan 15 14:17:00 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:00 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:00 volumio volumio[865]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Jan 15 14:17:00 volumio shairport-sync[1229]: {"time":1736921741599,"response":"startAirplayPlayback Success"}Execution of on-stop command failed to start Jan 15 14:17:00 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 15 14:17:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 15 14:17:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 15 14:17:00 volumio sudo[3324]: pam_unix(sudo:session): session closed for user root Jan 15 14:17:00 volumio volumio[865]: info: Shairport-Sync retarted Jan 15 14:17:05 volumio volumio[865]: info: MyVolumio login type: Token Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPlay Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::play index 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::stop Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::stPlaybackTimer Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::updateTrackBlock Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrackBlock Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::serviceStop Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::serviceStop Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::stop Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand stop took 18 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::play index undefined Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::startPlaybackTimer Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 38 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand stop took 37 milliseconds Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand clear Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:16 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand clear took 12 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 10 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 7 milliseconds Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac" Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService stop Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: No code Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService stop Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: No code Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService stop Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: No code Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 113ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 70ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 69ms Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:16 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:16 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:16 volumio volumio[865]: error: updateQueue error: null Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:16 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 74 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 73ms Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand add "INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac" took 69 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 8ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 7ms Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand play Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService stop Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: No code Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 98ms Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:16 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:16 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:16 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:16 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! Jan 15 14:17:16 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 60 seconds. Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 89ms Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand play took 83 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 63ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 61ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 59ms Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:16 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 11 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 11 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 9 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 7 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 7ms Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 6 milliseconds Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: Jan 15 14:17:16 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand playlistinfo took 16 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand playlistinfo took 16 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand playlistinfo took 17 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand playlistinfo took 17 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand playlistinfo took 18 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 14 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 13 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand status took 11 milliseconds Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:16 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:16 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:16 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:16 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 82ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 108ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 105ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 104ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 102ms Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand playlistinfo took 67 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand playlistinfo took 67 milliseconds Jan 15 14:17:16 volumio volumio[865]: info: sendMpdCommand playlistinfo took 66 milliseconds Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:16 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:16 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:16 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:16 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:16 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:16 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:16 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 140ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 139ms Jan 15 14:17:16 volumio volumio[865]: info: ------------------------------ 138ms Jan 15 14:17:16 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 15 14:17:19 volumio volumio[865]: info: Airplay started streaming, receiving metadatas Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioStop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::stPlaybackTimer Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::updateTrackBlock Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrackBlock Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::serviceStop Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::serviceStop Jan 15 14:17:19 volumio volumio[865]: info: ControllerMpd::stop Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:19 volumio volumio[865]: info: Airplay started streaming, receiving metadatas Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioStop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:19 volumio volumio[865]: info: Airplay started streaming, receiving metadatas Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioStop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:19 volumio volumio[865]: info: Airplay started streaming, receiving metadatas Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioStop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:19 volumio volumio[865]: info: Jan 15 14:17:19 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:19 volumio volumio[865]: info: sendMpdCommand stop took 24 milliseconds Jan 15 14:17:19 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:19 volumio volumio[865]: info: sendMpdCommand status took 3 milliseconds Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:19 volumio volumio[865]: info: Jan 15 14:17:19 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:19 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:19 volumio volumio[865]: info: Jan 15 14:17:19 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:19 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:19 volumio volumio[865]: info: Jan 15 14:17:19 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:19 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:19 volumio volumio[865]: info: sendMpdCommand playlistinfo took 67 milliseconds Jan 15 14:17:19 volumio volumio[865]: info: sendMpdCommand status took 27 milliseconds Jan 15 14:17:19 volumio volumio[865]: info: sendMpdCommand status took 13 milliseconds Jan 15 14:17:19 volumio volumio[865]: info: sendMpdCommand status took 7 milliseconds Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:19 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio shairport-sync[3327]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 15 14:17:19 volumio shairport-sync[3327]: Dload Upload Total Spent Left Speed Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:19 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::syncState stateService stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: No code Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: ------------------------------ 139ms Jan 15 14:17:19 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 60 seconds. Jan 15 14:17:19 volumio volumio[865]: info: sendMpdCommand playlistinfo took 60 milliseconds Jan 15 14:17:19 volumio volumio[865]: info: sendMpdCommand playlistinfo took 57 milliseconds Jan 15 14:17:19 volumio volumio[865]: info: sendMpdCommand playlistinfo took 52 milliseconds Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:19 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:19 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:19 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::syncState stateService stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: No code Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:19 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::syncState stateService stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: No code Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:19 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::syncState stateService stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: No code Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:19 volumio volumio[865]: info: ------------------------------ 202ms Jan 15 14:17:19 volumio volumio[865]: info: ------------------------------ 196ms Jan 15 14:17:19 volumio volumio[865]: info: ------------------------------ 186ms Jan 15 14:17:19 volumio volumio[865]: info: Jan 15 14:17:19 volumio volumio[865]: ---------------------------- Client requests Start Airplay PlaybackRoutine Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Jan 15 14:17:19 volumio volumio[865]: info: Airplay playback start Jan 15 14:17:19 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:19 volumio volumio[865]: info: CoreCommandRouter::volumioStop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::stop Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:19 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:19 volumio shairport-sync[3327]: [158B blob data] Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:20 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:20 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:20 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:20 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:20 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:20 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:20 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:21 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:21 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPlay Jan 15 14:17:24 volumio volumio[865]: verbose: UNSET VOLATILE: Service: airplay_emulation Jan 15 14:17:24 volumio volumio[865]: info: Stopping Airplay Playback and sending pause command to client via USR2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::play index 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::stop Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::stPlaybackTimer Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::updateTrackBlock Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrackBlock Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::serviceStop Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::serviceStop Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::stop Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand stop took 17 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::play index undefined Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::startPlaybackTimer Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand stop took 1 milliseconds Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand clear Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:24 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand clear took 33 milliseconds Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac" Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:24 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:24 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:24 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:24 volumio volumio[865]: error: updateQueue error: null Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:24 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 13ms Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand add "INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac" took 12 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 11ms Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 9ms Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 8ms Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand play Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:24 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:24 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:24 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 26ms Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand play took 26 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 25ms Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 23ms Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:24 volumio sudo[3400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 3327 Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:24 volumio sudo[3400]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 24ms Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand status took 18 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand status took 16 milliseconds Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:24 volumio sudo[3400]: pam_unix(sudo:session): session closed for user root Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:24 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 60 seconds. Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand status took 48 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand status took 47 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand status took 40 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand playlistinfo took 37 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand playlistinfo took 37 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand status took 22 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand status took 19 milliseconds Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":426,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"537 Kbps","isStreaming":false,"title":"Fragile / Layor 脆弱 / 莱雅","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac","trackType":"flac"} Jan 15 14:17:24 volumio volumio[865]: verbose: CURRENT POSITION 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":426,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"530 Kbps","isStreaming":false,"title":"Fragile / Layor 脆弱 / 莱雅","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac","trackType":"flac"} Jan 15 14:17:24 volumio volumio[865]: verbose: CURRENT POSITION 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:24 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 89ms Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 95ms Jan 15 14:17:24 volumio volumio[865]: info: Jan 15 14:17:24 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:24 volumio volumio[865]: info: Shairport-Sync paused with USR2 Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand playlistinfo took 54 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand playlistinfo took 54 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand playlistinfo took 56 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand playlistinfo took 54 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand playlistinfo took 52 milliseconds Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand status took 17 milliseconds Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":426,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"519 Kbps","isStreaming":false,"title":"Fragile / Layor 脆弱 / 莱雅","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac","trackType":"flac"} Jan 15 14:17:24 volumio volumio[865]: verbose: CURRENT POSITION 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:24 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":426,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"519 Kbps","isStreaming":false,"title":"Fragile / Layor 脆弱 / 莱雅","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac","trackType":"flac"} Jan 15 14:17:24 volumio volumio[865]: verbose: CURRENT POSITION 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:24 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":426,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"519 Kbps","isStreaming":false,"title":"Fragile / Layor 脆弱 / 莱雅","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac","trackType":"flac"} Jan 15 14:17:24 volumio volumio[865]: verbose: CURRENT POSITION 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:24 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":426,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"519 Kbps","isStreaming":false,"title":"Fragile / Layor 脆弱 / 莱雅","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac","trackType":"flac"} Jan 15 14:17:24 volumio volumio[865]: verbose: CURRENT POSITION 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:24 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":426,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"519 Kbps","isStreaming":false,"title":"Fragile / Layor 脆弱 / 莱雅","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac","trackType":"flac"} Jan 15 14:17:24 volumio volumio[865]: verbose: CURRENT POSITION 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:24 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 199ms Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 196ms Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 194ms Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 175ms Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 172ms Jan 15 14:17:24 volumio volumio[865]: info: sendMpdCommand playlistinfo took 209 milliseconds Jan 15 14:17:24 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:24 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":800,"duration":426,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"522 Kbps","isStreaming":false,"title":"Fragile / Layor 脆弱 / 莱雅","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac","trackType":"flac"} Jan 15 14:17:24 volumio volumio[865]: verbose: CURRENT POSITION 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:24 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:24 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:24 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:24 volumio volumio[865]: info: ------------------------------ 273ms Jan 15 14:17:24 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 15 14:17:25 volumio volumio[865]: info: Restarting Shairport-Sync after stop Jan 15 14:17:25 volumio sudo[3410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 15 14:17:25 volumio sudo[3410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 14:17:25 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 15 14:17:25 volumio shairport-sync[3327]: {"time":1736921839761,"response":"startAirplayPlayback Success"} Jan 15 14:17:25 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 15 14:17:25 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 15 14:17:25 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 15 14:17:25 volumio sudo[3410]: pam_unix(sudo:session): session closed for user root Jan 15 14:17:25 volumio volumio[865]: info: Shairport-Sync retarted Jan 15 14:17:32 volumio volumio[865]: info: CoreCommandRouter::volumioPlay Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::play index 3 Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::stop Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::stPlaybackTimer Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::updateTrackBlock Jan 15 14:17:32 volumio volumio[865]: info: CorePlayQueue::getTrackBlock Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:32 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:32 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:32 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::serviceStop Jan 15 14:17:32 volumio volumio[865]: info: CorePlayQueue::getTrack 2 Jan 15 14:17:32 volumio volumio[865]: info: CoreCommandRouter::serviceStop Jan 15 14:17:32 volumio volumio[865]: info: ControllerMpd::stop Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 14:17:32 volumio volumio[865]: info: Jan 15 14:17:32 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand stop took 56 milliseconds Jan 15 14:17:32 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::play index undefined Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 14:17:32 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::startPlaybackTimer Jan 15 14:17:32 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 14:17:32 volumio volumio[865]: info: Jan 15 14:17:32 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:32 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:32 volumio volumio[865]: info: Jan 15 14:17:32 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:32 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:32 volumio volumio[865]: info: Jan 15 14:17:32 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:32 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand status took 33 milliseconds Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand stop took 31 milliseconds Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand status took 14 milliseconds Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand status took 10 milliseconds Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand status took 8 milliseconds Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand clear Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:32 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 60 seconds. Jan 15 14:17:32 volumio volumio[865]: info: Jan 15 14:17:32 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:32 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand playlistinfo took 17 milliseconds Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand clear took 17 milliseconds Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand playlistinfo took 16 milliseconds Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 15 14:17:32 volumio volumio[865]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac" Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:32 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:32 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:32 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:32 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:32 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:32 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:32 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:32 volumio volumio[865]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fragile / Layor 脆弱 / 莱雅","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/02 Fragile - Layor 脆弱 - 莱雅.flac","trackType":"flac"} Jan 15 14:17:32 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::syncState stateService stop Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:32 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:32 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:32 volumio volumio[865]: info: No code Jan 15 14:17:32 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:32 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:32 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:32 volumio volumio[865]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 15 14:17:32 volumio volumio[865]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 15 14:17:32 volumio volumio[865]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 127ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 112ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 104ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 102ms Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:33 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:33 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:33 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:33 volumio volumio[865]: error: updateQueue error: null Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:33 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 96ms Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand add "INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac" took 88 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 29ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 28ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 25ms Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand play Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:33 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:33 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces system playlist update Jan 15 14:17:33 volumio volumio[865]: info: Ignoring MPD Status Update Jan 15 14:17:33 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 78ms Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand play took 60 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 62ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 60ms Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 58ms Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand status took 18 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand status took 13 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand status took 10 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand status took 7 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand status took 4 milliseconds Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:33 volumio volumio[865]: info: Jan 15 14:17:33 volumio volumio[865]: ---------------------------- MPD announces state update: player Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::getState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand status Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand playlistinfo took 13 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand status took 10 milliseconds Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:33 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus stop Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:33 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:33 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:33 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:33 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:33 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:33 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:33 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:33 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 97ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 124ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 108ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 105ms Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 102ms Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand status took 88 milliseconds Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand playlistinfo took 76 milliseconds Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseState Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:33 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:33 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 123ms Jan 15 14:17:33 volumio volumio[865]: info: sendMpdCommand playlistinfo took 138 milliseconds Jan 15 14:17:33 volumio volumio[865]: verbose: ControllerMpd::parseTrackInfo Jan 15 14:17:33 volumio volumio[865]: info: ControllerMpd::pushState Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::servicePushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Armandos Rhumba 阿曼多的伦巴","artist":"群星","album":"大提琴与吉他的对话 6N纯银镀膜","uri":"INTERNAL/music/《大提琴与吉他的对话》6N纯银镀膜 [FLAC]/03 Armandos Rhumba 阿曼多的伦巴.flac","trackType":"flac"} Jan 15 14:17:33 volumio volumio[865]: verbose: CURRENT POSITION 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState stateService play Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::syncState currentStatus play Jan 15 14:17:33 volumio volumio[865]: info: Received an update from plugin. extracting info from payload Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: CoreStateMachine::pushState Jan 15 14:17:33 volumio volumio[865]: info: CorePlayQueue::getTrack 3 Jan 15 14:17:33 volumio volumio[865]: info: CoreCommandRouter::volumioPushState Jan 15 14:17:33 volumio volumio[865]: info: ------------------------------ 255ms Jan 15 14:17:33 volumio volumio[865]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 15 14:17:35 volumio volumio[865]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 15 14:17:35 volumio volumio[865]: info: Retrying Login Due to Network Error Jan 15 14:17:45 volumio volumio[865]: info: MyVolumio login type: Token Jan 15 14:17:50 volumio volumio[865]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 14:17:50 volumio volumio[865]: Error: connect ETIMEDOUT 31.13.84.2:443 Jan 15 14:17:50 volumio volumio[865]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jan 15 14:17:50 volumio volumio[865]: errno: -110, Jan 15 14:17:50 volumio volumio[865]: code: 'ETIMEDOUT', Jan 15 14:17:50 volumio volumio[865]: syscall: 'connect', Jan 15 14:17:50 volumio volumio[865]: address: '31.13.84.2', Jan 15 14:17:50 volumio volumio[865]: port: 443 Jan 15 14:17:50 volumio volumio[865]: } Jan 15 14:17:50 volumio volumio[865]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 14:17:51 volumio sudo[3436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-15 14:16 Jan 15 14:17:51 volumio sudo[3436]: 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="ef589a0572b08c3d1e9a984ec6a655ef3698e415" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="abe72e92bc7de90ab6193cbc17e21ad2750980a2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 28 May 2024 12:17:12 PM CEST" VOLUMIO_VERSION="3.695" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8f37ff40efaaf3752fac55d6a95d61cb"