-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Mon 2025-02-17 22:39:46 CST. -- Feb 17 22:38:22 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 17 22:38:22 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 17 22:38:22 volumio volumio[5377]: info: Discovery: Getting this device information Feb 17 22:38:22 volumio volumio[5377]: info: CoreCommandRouter::volumioGetState Feb 17 22:38:22 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 17 22:38:52 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 17 22:38:52 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 17 22:38:52 volumio volumio[5377]: info: Discovery: Getting this device information Feb 17 22:38:52 volumio volumio[5377]: info: CoreCommandRouter::volumioGetState Feb 17 22:38:52 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 17 22:39:22 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 17 22:39:22 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 17 22:39:22 volumio volumio[5377]: info: Discovery: Getting this device information Feb 17 22:39:22 volumio volumio[5377]: info: CoreCommandRouter::volumioGetState Feb 17 22:39:22 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 17 22:39:35 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 17 22:39:35 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:37 volumio volumio[5377]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Josh%20Groban/Awake/050422f3-7bb5-4192-bcec-6f3e99494f3a.png' Feb 17 22:39:37 volumio volumio[5377]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Josh%20Groban/Closer/5b6fb84d-39de-4795-b30d-6d6bf353f25a.png' Feb 17 22:39:37 volumio volumio[5377]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Josh%20Groban/Closer/5b6fb84d-39de-4795-b30d-6d6bf353f25a.png' Feb 17 22:39:37 volumio volumio[5377]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Josh%20Groban/Closer/5b6fb84d-39de-4795-b30d-6d6bf353f25a.png' Feb 17 22:39:41 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::ClearQueue Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::stop Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::stPlaybackTimer Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::updateTrackBlock Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrackBlock Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::serviceStop Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::serviceStop Feb 17 22:39:41 volumio volumio[5377]: info: [1739803181857] ControllerUPNPBrowser::stop Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::clearPlayQueue Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::saveQueue Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushQueue Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::addQueueItems Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::addQueueItems Feb 17 22:39:41 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@938 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@938 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@939 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@939 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@955 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@955 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@949 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@949 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@951 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@951 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@963 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@963 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushQueue Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::saveQueue Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::updateTrackBlock Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrackBlock Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPlay Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::play index 5 Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::addQueueItems Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::addQueueItems Feb 17 22:39:41 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@947 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@947 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@918 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@918 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@946 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@946 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@916 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@916 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@924 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@924 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@935 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@935 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@921 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@921 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@937 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@937 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@933 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@933 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@914 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@914 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@957 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@957 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@961 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@961 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@927 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@927 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@928 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@928 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@929 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@929 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@930 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@930 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@960 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@960 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@953 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@953 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@941 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@941 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@943 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@943 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@959 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@959 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@964 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@964 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@966 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@966 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@945 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@945 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@944 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@944 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@958 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@958 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@952 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@952 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@940 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@940 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@942 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@942 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@954 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@954 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@948 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@948 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@950 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@950 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@962 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@962 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@932 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@932 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@913 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@913 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@956 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@956 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@925 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@925 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@931 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@931 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@919 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@919 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@934 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@934 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@923 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@923 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@936 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@936 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@967 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@967 Feb 17 22:39:41 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@965 Feb 17 22:39:41 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@965 Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::stop Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushQueue Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::saveQueue Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::play index undefined Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::updateTrackBlock Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrackBlock Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 5 Feb 17 22:39:41 volumio volumio[5377]: info: Feb 17 22:39:41 volumio volumio[5377]: ---------------------------- MPD announces state update: player Feb 17 22:39:41 volumio volumio[5377]: info: sendMpdCommand stop took 62 milliseconds Feb 17 22:39:41 volumio volumio[5377]: info: ControllerMpd::getState Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::sendMpdCommand status Feb 17 22:39:41 volumio volumio[5377]: info: Feb 17 22:39:41 volumio volumio[5377]: ---------------------------- MPD announces state update: player Feb 17 22:39:41 volumio volumio[5377]: info: ControllerMpd::getState Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::sendMpdCommand status Feb 17 22:39:41 volumio volumio[5377]: info: Feb 17 22:39:41 volumio volumio[5377]: ---------------------------- MPD announces state update: player Feb 17 22:39:41 volumio volumio[5377]: info: ControllerMpd::getState Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::sendMpdCommand status Feb 17 22:39:41 volumio volumio[5377]: info: sendMpdCommand status took 7 milliseconds Feb 17 22:39:41 volumio volumio[5377]: info: sendMpdCommand status took 6 milliseconds Feb 17 22:39:41 volumio volumio[5377]: info: sendMpdCommand status took 5 milliseconds Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::parseState Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::parseState Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::parseState Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 22:39:41 volumio volumio[5377]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 17 22:39:41 volumio volumio[5377]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 17 22:39:41 volumio volumio[5377]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::parseTrackInfo Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::parseTrackInfo Feb 17 22:39:41 volumio volumio[5377]: verbose: ControllerMpd::parseTrackInfo Feb 17 22:39:41 volumio volumio[5377]: info: ControllerMpd::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::servicePushState Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: 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":"出走","uri":"http://192.168.1.106:50002/m/NDLNA/897.flac","trackType":"flac"} Feb 17 22:39:41 volumio volumio[5377]: verbose: CURRENT POSITION 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::syncState stateService stop Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::syncState currentStatus stop Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:41 volumio volumio[5377]: info: No code Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:41 volumio volumio[5377]: info: ControllerMpd::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::servicePushState Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: 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":"出走","uri":"http://192.168.1.106:50002/m/NDLNA/897.flac","trackType":"flac"} Feb 17 22:39:41 volumio volumio[5377]: verbose: CURRENT POSITION 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::syncState stateService stop Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::syncState currentStatus stop Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:41 volumio volumio[5377]: info: No code Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:41 volumio volumio[5377]: info: ControllerMpd::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::servicePushState Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: 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":"出走","uri":"http://192.168.1.106:50002/m/NDLNA/897.flac","trackType":"flac"} Feb 17 22:39:41 volumio volumio[5377]: verbose: CURRENT POSITION 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::syncState stateService stop Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::syncState currentStatus stop Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:41 volumio volumio[5377]: info: No code Feb 17 22:39:41 volumio volumio[5377]: info: CoreStateMachine::pushState Feb 17 22:39:41 volumio volumio[5377]: info: CorePlayQueue::getTrack 0 Feb 17 22:39:41 volumio volumio[5377]: info: CoreCommandRouter::volumioPushState Feb 17 22:39:42 volumio volumio[5377]: info: ------------------------------ 99ms Feb 17 22:39:42 volumio volumio[5377]: info: ------------------------------ 98ms Feb 17 22:39:42 volumio volumio[5377]: info: ------------------------------ 98ms Feb 17 22:39:44 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:44 volumio volumio[5377]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::ClearQueue Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::stop Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:44 volumio volumio[5377]: info: CorePlayQueue::clearPlayQueue Feb 17 22:39:44 volumio volumio[5377]: info: CorePlayQueue::saveQueue Feb 17 22:39:44 volumio volumio[5377]: info: CoreCommandRouter::volumioPushQueue Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::addQueueItems Feb 17 22:39:44 volumio volumio[5377]: info: CorePlayQueue::addQueueItems Feb 17 22:39:44 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@938 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@938 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@939 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@939 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@955 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@955 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@949 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@949 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@951 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@951 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@963 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@963 Feb 17 22:39:44 volumio volumio[5377]: info: CoreCommandRouter::volumioPushQueue Feb 17 22:39:44 volumio volumio[5377]: info: CorePlayQueue::saveQueue Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::updateTrackBlock Feb 17 22:39:44 volumio volumio[5377]: info: CorePlayQueue::getTrackBlock Feb 17 22:39:44 volumio volumio[5377]: info: CoreCommandRouter::volumioPlay Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::play index 5 Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::addQueueItems Feb 17 22:39:44 volumio volumio[5377]: info: CorePlayQueue::addQueueItems Feb 17 22:39:44 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@947 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@947 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@918 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@918 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@946 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@946 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@916 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@916 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@924 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@924 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@935 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@935 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@921 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@921 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@937 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@937 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@933 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@933 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@914 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@914 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@957 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@957 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@961 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@961 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@927 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@927 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@928 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@928 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@929 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@929 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@930 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@930 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@960 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@960 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@953 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@953 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@941 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@941 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@943 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@943 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@959 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@959 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@964 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@964 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@966 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@966 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@945 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@945 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@944 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@944 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@958 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@958 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@952 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@952 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@940 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@940 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@942 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@942 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@954 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@954 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@948 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@948 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@950 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@950 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@962 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@962 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@932 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@932 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@913 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@913 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@956 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@956 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@925 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@925 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@931 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@931 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@919 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@919 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@934 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@934 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@923 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@923 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@936 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@936 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@967 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@967 Feb 17 22:39:44 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@965 Feb 17 22:39:44 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@965 Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::stop Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:44 volumio volumio[5377]: info: CoreCommandRouter::volumioPushQueue Feb 17 22:39:44 volumio volumio[5377]: info: CorePlayQueue::saveQueue Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::play index undefined Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:44 volumio volumio[5377]: info: CoreStateMachine::updateTrackBlock Feb 17 22:39:44 volumio volumio[5377]: info: CorePlayQueue::getTrackBlock Feb 17 22:39:44 volumio volumio[5377]: info: CorePlayQueue::getTrack 5 Feb 17 22:39:45 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:45 volumio volumio[5377]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::ClearQueue Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::stop Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:45 volumio volumio[5377]: info: CorePlayQueue::clearPlayQueue Feb 17 22:39:45 volumio volumio[5377]: info: CorePlayQueue::saveQueue Feb 17 22:39:45 volumio volumio[5377]: info: CoreCommandRouter::volumioPushQueue Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::addQueueItems Feb 17 22:39:45 volumio volumio[5377]: info: CorePlayQueue::addQueueItems Feb 17 22:39:45 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@938 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@938 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@939 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@939 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@955 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@955 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@949 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@949 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@951 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@951 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@963 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@963 Feb 17 22:39:45 volumio volumio[5377]: info: CoreCommandRouter::volumioPushQueue Feb 17 22:39:45 volumio volumio[5377]: info: CorePlayQueue::saveQueue Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::updateTrackBlock Feb 17 22:39:45 volumio volumio[5377]: info: CorePlayQueue::getTrackBlock Feb 17 22:39:45 volumio volumio[5377]: info: CoreCommandRouter::volumioPlay Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::play index 5 Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::addQueueItems Feb 17 22:39:45 volumio volumio[5377]: info: CorePlayQueue::addQueueItems Feb 17 22:39:45 volumio volumio[5377]: info: Preload queue cleared Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@947 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@947 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@918 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@918 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@946 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@946 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@916 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@916 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@924 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@924 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@935 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@935 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@921 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@921 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@937 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@937 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@933 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@933 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@914 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@914 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@957 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@957 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@961 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@961 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@927 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@927 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@928 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@928 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@929 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@929 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@930 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@930 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@960 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@960 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@953 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@953 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@941 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@941 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@943 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@943 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@959 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@959 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@964 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@964 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@966 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@966 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@945 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@945 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@944 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@944 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@958 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@958 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@952 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@952 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@940 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@940 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@942 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@942 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@954 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@954 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@948 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@948 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@950 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@950 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@962 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@962 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@932 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@932 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@913 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@913 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@956 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@956 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@925 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@925 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@931 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@931 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@919 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@919 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@934 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@934 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@923 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@923 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@936 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@936 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@967 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@967 Feb 17 22:39:45 volumio volumio[5377]: info: Adding Item to queue: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@965 Feb 17 22:39:45 volumio volumio[5377]: info: Using cached record of: upnp/http://192.168.1.106:50001/ContentDirectory/control@22$@965 Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::stop Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:45 volumio volumio[5377]: info: CoreCommandRouter::volumioPushQueue Feb 17 22:39:45 volumio volumio[5377]: info: CorePlayQueue::saveQueue Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::play index undefined Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 22:39:45 volumio volumio[5377]: info: CoreStateMachine::updateTrackBlock Feb 17 22:39:45 volumio volumio[5377]: info: CorePlayQueue::getTrackBlock Feb 17 22:39:45 volumio volumio[5377]: info: CorePlayQueue::getTrack 5 Feb 17 22:39:45 volumio volumio[5377]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 22:39:45 volumio volumio[5377]: Error: connect ETIMEDOUT 108.160.169.175:443 Feb 17 22:39:45 volumio volumio[5377]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 17 22:39:45 volumio volumio[5377]: errno: -110, Feb 17 22:39:45 volumio volumio[5377]: code: 'ETIMEDOUT', Feb 17 22:39:45 volumio volumio[5377]: syscall: 'connect', Feb 17 22:39:45 volumio volumio[5377]: address: '108.160.169.175', Feb 17 22:39:45 volumio volumio[5377]: port: 443 Feb 17 22:39:45 volumio volumio[5377]: } Feb 17 22:39:45 volumio volumio[5377]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 22:39:46 volumio sudo[6489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-17 22:38 Feb 17 22:39:46 volumio sudo[6489]: 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"