-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Mon 2025-02-17 23:35:03 CST. -- Feb 17 23:34:00 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:00 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:00 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:00 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:00 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:00 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:00 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:00 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:00 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:00 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:00 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:00 volumio volumio[13946]: info: Adding Item to queue: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:00 volumio volumio[13946]: info: Using cached record of: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:00 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:00 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:00 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:00 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:00 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:00 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:00 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:00 volumio volumio[13946]: info: CoreStateMachine::play index 1 Feb 17 23:34:00 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:00 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:00 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:00 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:00 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:00 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:00 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:01 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:01 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:01 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:01 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:01 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:01 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:01 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:01 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:01 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:01 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:01 volumio volumio[13946]: info: Adding Item to queue: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:01 volumio volumio[13946]: info: Using cached record of: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:01 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:01 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:01 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:01 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::play index 1 Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:01 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:01 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:01 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:01 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:01 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:01 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:01 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:01 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:01 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:01 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:01 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:01 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:03 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:03 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:03 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:03 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:03 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:03 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:03 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:03 volumio volumio[13946]: info: Adding Item to queue: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:03 volumio volumio[13946]: info: Using cached record of: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:03 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:03 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:03 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:03 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:03 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:03 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::play index 1 Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:03 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:03 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:03 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:03 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:03 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:03 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:03 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:03 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:03 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:03 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:03 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:03 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:03 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:03 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:03 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:04 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:04 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:04 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:04 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:04 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:04 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:04 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:04 volumio volumio[13946]: info: Adding Item to queue: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:04 volumio volumio[13946]: info: Using cached record of: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:04 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:04 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:04 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:04 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:04 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:04 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::play index 1 Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:04 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:04 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:04 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:04 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:04 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:04 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:04 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:04 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:04 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:04 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:04 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:04 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:04 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:04 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:04 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:07 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:07 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:07 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:07 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:09 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:09 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:09 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:09 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:09 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:09 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:09 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:09 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:12 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:12 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:12 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:12 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:12 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:12 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::play index 5 Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::getTrack 5 Feb 17 23:34:12 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:12 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:12 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:12 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:12 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:12 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:12 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:12 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::play index 5 Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:12 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:12 volumio volumio[13946]: info: CorePlayQueue::getTrack 5 Feb 17 23:34:13 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:13 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:13 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:13 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:13 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:13 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:13 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:13 volumio volumio[13946]: info: Adding Item to queue: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:13 volumio volumio[13946]: info: Using cached record of: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1428 Feb 17 23:34:13 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:13 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1060 Feb 17 23:34:13 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:13 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1061 Feb 17 23:34:13 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:13 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1064 Feb 17 23:34:13 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:13 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1065 Feb 17 23:34:13 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:13 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1067 Feb 17 23:34:13 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:13 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:13 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:13 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::play index 5 Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:13 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:13 volumio volumio[13946]: info: CorePlayQueue::getTrack 5 Feb 17 23:34:19 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 17 23:34:19 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:21 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 17 23:34:21 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 Feb 17 23:34:21 volumio volumio[13946]: info: Preloading song: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 Feb 17 23:34:21 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 in service upnp_browser Feb 17 23:34:21 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 in service upnp_browser Feb 17 23:34:21 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 in service upnp_browser Feb 17 23:34:21 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 in service upnp_browser Feb 17 23:34:21 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 in service upnp_browser Feb 17 23:34:21 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: Exploding uri upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 in service upnp_browser Feb 17 23:34:22 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 17 23:34:22 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 17 23:34:22 volumio volumio[13946]: info: Discovery: Getting this device information Feb 17 23:34:22 volumio volumio[13946]: info: CoreCommandRouter::volumioGetState Feb 17 23:34:22 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:22 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 17 23:34:26 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:26 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:26 volumio volumio[13946]: info: Adding Item to queue: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1423 Feb 17 23:34:26 volumio volumio[13946]: info: Exploding uri upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1423 in service upnp_browser Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::play index 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::startPlaybackTimer Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: info: [1739806466478] ControllerUPNPBrowser::clearAddPlayTrack Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand stop took 3 milliseconds Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:26 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand clear took 2 milliseconds Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.106:50002/m/NDLNA/998.flac" Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:26 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:26 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:26 volumio volumio[13946]: error: updateQueue error: null Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 6ms Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.106:50002/m/NDLNA/998.flac" Feb 17 23:34:26 volumio volumio[13946]: error: updateQueue error: null Feb 17 23:34:26 volumio volumio[13946]: error: updateQueue error: null Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:26 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 48ms Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 47ms Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand add "http://192.168.1.106:50002/m/NDLNA/998.flac" took 3 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand play Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:26 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:26 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 5ms Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand play took 4 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 4ms Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 3ms Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand status took 13 milliseconds Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:26 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand status took 15 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand status took 13 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand status took 7 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 9ms Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand status took 7 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand status took 5 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand status took 4 milliseconds Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:26 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus stop Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:26 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:26 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:26 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:26 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 49ms Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 72ms Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 71ms Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:26 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:26 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:26 volumio volumio[13946]: info: Feb 17 23:34:26 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 52 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 53 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 52 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 51 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 5ms Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand status took 5 milliseconds Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 5ms Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand status took 4 milliseconds Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"702 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:26 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:26 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"740 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:26 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:26 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"713 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:26 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:26 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"707 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:26 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:26 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 153ms Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 153ms Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 150ms Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 149ms Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 159 milliseconds Feb 17 23:34:26 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:26 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:26 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:26 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:26 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:26 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 214ms Feb 17 23:34:26 volumio volumio[13946]: info: ------------------------------ 213ms Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:26 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:26 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:29 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::stPlaybackTimer Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::serviceStop Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::serviceStop Feb 17 23:34:29 volumio volumio[13946]: info: [1739806469637] ControllerUPNPBrowser::stop Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:29 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::play index 1 Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:29 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 Feb 17 23:34:29 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 Feb 17 23:34:29 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:29 volumio volumio[13946]: info: Feb 17 23:34:29 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:29 volumio volumio[13946]: info: sendMpdCommand stop took 43 milliseconds Feb 17 23:34:29 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:29 volumio volumio[13946]: info: Feb 17 23:34:29 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:29 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:29 volumio volumio[13946]: info: Feb 17 23:34:29 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:29 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:29 volumio volumio[13946]: info: sendMpdCommand status took 3 milliseconds Feb 17 23:34:29 volumio volumio[13946]: info: sendMpdCommand status took 2 milliseconds Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:29 volumio volumio[13946]: info: sendMpdCommand status took 4 milliseconds Feb 17 23:34:29 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:29 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: 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":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:29 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::syncState stateService stop Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus stop Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: No code Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: 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":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:29 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::syncState stateService stop Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus stop Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: No code Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: ------------------------------ 72ms Feb 17 23:34:29 volumio volumio[13946]: info: ------------------------------ 72ms Feb 17 23:34:29 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 65 milliseconds Feb 17 23:34:29 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:29 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: 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":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:29 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::syncState stateService stop Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus stop Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: No code Feb 17 23:34:29 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:29 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:29 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:29 volumio volumio[13946]: info: ------------------------------ 97ms Feb 17 23:34:34 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:34 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:34 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:34 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:34 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:34 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:34 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:34 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:36 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:36 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::play index 1 Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:36 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:36 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:36 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::play index 1 Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:36 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 Feb 17 23:34:36 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 Feb 17 23:34:36 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:36 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:36 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:36 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:37 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:37 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:37 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:37 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:37 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:37 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:37 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@998 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@999 Feb 17 23:34:37 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:37 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:37 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:37 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::play index 1 Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:37 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:37 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1000 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1001 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1002 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1003 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1004 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1005 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1006 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1007 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1008 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1009 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1010 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1011 Feb 17 23:34:37 volumio volumio[13946]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 Feb 17 23:34:37 volumio volumio[13946]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@1012 Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:37 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:37 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:37 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:37 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:37 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:49 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 17 23:34:49 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:51 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 17 23:34:51 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 17 23:34:52 volumio volumio[13946]: info: Discovery: Getting this device information Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetState Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 17 23:34:52 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::ClearQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::clearPlayQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::addQueueItems Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::addQueueItems Feb 17 23:34:52 volumio volumio[13946]: info: Preload queue cleared Feb 17 23:34:52 volumio volumio[13946]: info: Adding Item to queue: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1423 Feb 17 23:34:52 volumio volumio[13946]: info: Using cached record of: upnp/folder/http://192.168.1.106:50001/ContentDirectory/control@22$1423 Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::saveQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::play index 0 Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::startPlaybackTimer Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:52 volumio volumio[13946]: info: [1739806492646] ControllerUPNPBrowser::clearAddPlayTrack Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand stop took 6 milliseconds Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:52 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand clear took 2 milliseconds Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.106:50002/m/NDLNA/998.flac" Feb 17 23:34:52 volumio volumio[13946]: error: updateQueue error: null Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 5ms Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:52 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:52 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:52 volumio volumio[13946]: error: updateQueue error: null Feb 17 23:34:52 volumio volumio[13946]: error: updateQueue error: null Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.106:50002/m/NDLNA/998.flac" Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 23ms Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 21ms Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:52 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand add "http://192.168.1.106:50002/m/NDLNA/998.flac" took 2 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand play Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:52 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:52 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 6ms Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand play took 5 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 5ms Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 4ms Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand status took 22 milliseconds Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:52 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand status took 22 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand status took 21 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:52 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:52 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus stop Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 30ms Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:52 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:52 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:52 volumio volumio[13946]: info: Feb 17 23:34:52 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 11ms Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand status took 10 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 6ms Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand status took 5 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 5ms Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand status took 7 milliseconds Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:52 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"688 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:52 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:52 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:52 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"688 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:52 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:52 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 81ms Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 79ms Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 43 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 43 milliseconds Feb 17 23:34:52 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 43 milliseconds Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:52 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:52 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"702 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:52 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:52 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:52 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"701 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:52 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:52 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:52 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"701 Kbps","isStreaming":false,"title":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:52 volumio volumio[13946]: verbose: CURRENT POSITION 0 Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:52 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 124ms Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 119ms Feb 17 23:34:52 volumio volumio[13946]: info: ------------------------------ 118ms Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:52 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:52 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPlay Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::play index 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::stop Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::stPlaybackTimer Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::updateTrackBlock Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrackBlock Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::serviceStop Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 0 Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::serviceStop Feb 17 23:34:58 volumio volumio[13946]: info: [1739806498110] ControllerUPNPBrowser::stop Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand stop took 10 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::play index undefined Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::startPlaybackTimer Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: info: [1739806498121] ControllerUPNPBrowser::clearAddPlayTrack Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand status took 5 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand stop took 3 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand status took 2 milliseconds Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:58 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand status took 4 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand clear took 2 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.106:50002/m/NDLNA/999.flac" Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: 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":"凡人歌","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/998.flac","trackType":"flac"} Feb 17 23:34:58 volumio volumio[13946]: verbose: CURRENT POSITION 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState stateService stop Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus stop Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: No code Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 45ms Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 42ms Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:58 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:58 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:58 volumio volumio[13946]: error: updateQueue error: null Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 45ms Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 40 milliseconds Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:58 volumio volumio[13946]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 51ms Feb 17 23:34:58 volumio volumio[13946]: error: updateQueue error: null Feb 17 23:34:58 volumio volumio[13946]: error: updateQueue error: null Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.106:50002/m/NDLNA/999.flac" Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 19ms Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 17ms Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:58 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand add "http://192.168.1.106:50002/m/NDLNA/999.flac" took 3 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand play Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:58 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:58 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 6ms Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand play took 5 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 5ms Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 3ms Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:58 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand status took 15 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand status took 18 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand status took 16 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 6ms Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand status took 3 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"鬼迷心窍","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/999.flac","trackType":"flac"} Feb 17 23:34:58 volumio volumio[13946]: verbose: CURRENT POSITION 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus stop Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 26ms Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:58 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces system playlist update Feb 17 23:34:58 volumio volumio[13946]: info: Ignoring MPD Status Update Feb 17 23:34:58 volumio volumio[13946]: info: Feb 17 23:34:58 volumio volumio[13946]: ---------------------------- MPD announces state update: player Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::getState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand status Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 8ms Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand status took 7 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 8ms Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"309 Kbps","isStreaming":false,"title":"鬼迷心窍","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/999.flac","trackType":"flac"} Feb 17 23:34:58 volumio volumio[13946]: verbose: CURRENT POSITION 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:58 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":204,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"312 Kbps","isStreaming":false,"title":"鬼迷心窍","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/999.flac","trackType":"flac"} Feb 17 23:34:58 volumio volumio[13946]: verbose: CURRENT POSITION 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:58 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"439 Kbps","isStreaming":false,"title":"鬼迷心窍","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/999.flac","trackType":"flac"} Feb 17 23:34:58 volumio volumio[13946]: verbose: CURRENT POSITION 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:58 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 109ms Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 108ms Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 96ms Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand status took 83 milliseconds Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 70 milliseconds Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseState Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"458 Kbps","isStreaming":false,"title":"鬼迷心窍","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/999.flac","trackType":"flac"} Feb 17 23:34:58 volumio volumio[13946]: verbose: CURRENT POSITION 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:58 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 126ms Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: sendMpdCommand playlistinfo took 93 milliseconds Feb 17 23:34:58 volumio volumio[13946]: verbose: ControllerMpd::parseTrackInfo Feb 17 23:34:58 volumio volumio[13946]: info: ControllerMpd::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::servicePushState Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getTrack 1 Feb 17 23:34:58 volumio volumio[13946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"482 Kbps","isStreaming":false,"title":"鬼迷心窍","artist":"李宗盛","album":"The Classic of Jonathan Lee Vol.1","uri":"http://192.168.1.106:50002/m/NDLNA/999.flac","trackType":"flac"} Feb 17 23:34:58 volumio volumio[13946]: verbose: CURRENT POSITION 1 Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState stateService play Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::syncState currentStatus play Feb 17 23:34:58 volumio volumio[13946]: info: Received an update from plugin. extracting info from payload Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::pushState Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioPushState Feb 17 23:34:58 volumio volumio[13946]: info: ------------------------------ 201ms Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreCommandRouter::volumioGetQueue Feb 17 23:34:58 volumio volumio[13946]: info: CoreStateMachine::getQueue Feb 17 23:34:58 volumio volumio[13946]: info: CorePlayQueue::getQueue Feb 17 23:35:03 volumio volumio[13946]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 23:35:03 volumio volumio[13946]: Error: connect ETIMEDOUT 157.240.10.36:443 Feb 17 23:35:03 volumio volumio[13946]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 17 23:35:03 volumio volumio[13946]: errno: -110, Feb 17 23:35:03 volumio volumio[13946]: code: 'ETIMEDOUT', Feb 17 23:35:03 volumio volumio[13946]: syscall: 'connect', Feb 17 23:35:03 volumio volumio[13946]: address: '157.240.10.36', Feb 17 23:35:03 volumio volumio[13946]: port: 443 Feb 17 23:35:03 volumio volumio[13946]: } Feb 17 23:35:03 volumio volumio[13946]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 23:35:03 volumio sudo[15911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-17 23:34 Feb 17 23:35:03 volumio sudo[15911]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"