-- Logs begin at Thu 2025-04-24 20:07:05 CST, end at Thu 2025-04-24 21:26:40 CST. -- Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::ClearQueue Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::clearPlayQueue Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88940 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88940 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88941 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88941 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88942 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88942 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPlay Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::play index 2 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88943 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88943 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88944 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88944 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88945 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88945 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88946 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88946 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88947 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88947 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88948 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88948 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88949 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88949 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88950 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88950 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88951 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88951 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88952 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88952 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88953 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7705/l/9323/t/88953 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::play index undefined Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::startPlaybackTimer Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: [1745501104166] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 3 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Apr 24 21:25:04 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand clear took 1 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/88942/download.pcm" Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Apr 24 21:25:04 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Apr 24 21:25:04 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:04 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/88942/download.pcm" Apr 24 21:25:04 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:04 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Apr 24 21:25:04 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ------------------------------ 20ms Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ------------------------------ 18ms Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand add "http://192.168.3.220:9000/music/88942/download.pcm" took 1 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand play Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Apr 24 21:25:04 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Apr 24 21:25:04 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ------------------------------ 3ms Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand play took 2 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Apr 24 21:25:04 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Apr 24 21:25:04 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Apr 24 21:25:04 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 7 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 6 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 7 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:04 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88942/download.pcm","trackType":"pcm"} Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:04 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88942/download.pcm","trackType":"pcm"} Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:04 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88942/download.pcm","trackType":"pcm"} Apr 24 21:25:04 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ------------------------------ 64ms Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ------------------------------ 65ms Apr 24 21:25:04 thinkpadhome volumio[1243]: info: ------------------------------ 64ms Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 24 21:25:04 thinkpadhome volumio[1243]: info: Discovery: Getting this device information Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioGetState Apr 24 21:25:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 21:25:11 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 24 21:25:12 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:15 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92942 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92943 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92944 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92945 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92946 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92947 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92948 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92949 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92950 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92951 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92952 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92953 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92954 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92955 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92956 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92957 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92958 Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92942 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: No valid Plugin REST Endpoint Apr 24 21:25:16 thinkpadhome volumio[1243]: info: No valid Plugin REST Endpoint Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92943 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92944 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92945 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92946 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92947 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92948 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92949 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92950 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92951 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92952 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92953 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92954 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92955 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92956 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92957 in service upnp_browser Apr 24 21:25:16 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92958 in service upnp_browser Apr 24 21:25:19 thinkpadhome volumio[1243]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 24 21:25:19 thinkpadhome volumio[1243]: info: Retrying Login Due to Network Error Apr 24 21:25:20 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:20 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 21:25:20 thinkpadhome volumio[1243]: info: CoreStateMachine::ClearQueue Apr 24 21:25:20 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:20 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:20 thinkpadhome volumio[1243]: info: CorePlayQueue::clearPlayQueue Apr 24 21:25:20 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:20 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:20 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:25:20 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:25:20 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:20 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/folder/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t Apr 24 21:25:20 thinkpadhome volumio[1243]: info: Exploding uri upnp/folder/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t in service upnp_browser Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPlay Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::play index 0 Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::play index undefined Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 0 Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::startPlaybackTimer Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 0 Apr 24 21:25:21 thinkpadhome volumio[1243]: info: [1745501121088] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 2 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Apr 24 21:25:21 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand clear took 1 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/92942/download.pcm" Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Apr 24 21:25:21 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Apr 24 21:25:21 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:21 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:25:21 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:21 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/92942/download.pcm" Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ------------------------------ 51ms Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ------------------------------ 51ms Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Apr 24 21:25:21 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand add "http://192.168.3.220:9000/music/92942/download.pcm" took 1 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand play Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Apr 24 21:25:21 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Apr 24 21:25:21 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ------------------------------ 4ms Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand play took 3 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Apr 24 21:25:21 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Apr 24 21:25:21 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:21 thinkpadhome volumio[1243]: info: Apr 24 21:25:21 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand status took 7 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 6 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand status took 5 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 2 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 0 Apr 24 21:25:21 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/92942/download.pcm","trackType":"pcm"} Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 0 Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 0 Apr 24 21:25:21 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/92942/download.pcm","trackType":"pcm"} Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 0 Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ------------------------------ 84ms Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ------------------------------ 84ms Apr 24 21:25:21 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 74 milliseconds Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 0 Apr 24 21:25:21 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/92942/download.pcm","trackType":"pcm"} Apr 24 21:25:21 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 0 Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:21 thinkpadhome volumio[1243]: info: ------------------------------ 97ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::ClearQueue Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::clearPlayQueue Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92942 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92942 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92943 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92943 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92944 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92944 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPlay Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::play index 2 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92945 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92945 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92946 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92946 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92947 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92947 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92948 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92948 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92949 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92949 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92950 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92950 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92951 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92951 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92952 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92952 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92953 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92953 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92954 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92954 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92955 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92955 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92956 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92956 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92957 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92957 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92958 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92958 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::play index undefined Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::startPlaybackTimer Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: [1745501129514] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 3 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand clear took 0 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/92944/download.pcm" Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Apr 24 21:25:29 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Apr 24 21:25:29 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Apr 24 21:25:29 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/92944/download.pcm" Apr 24 21:25:29 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:29 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:29 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Apr 24 21:25:29 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ------------------------------ 30ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ------------------------------ 30ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ------------------------------ 30ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand add "http://192.168.3.220:9000/music/92944/download.pcm" took 2 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand play Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Apr 24 21:25:29 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Apr 24 21:25:29 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ------------------------------ 3ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand play took 2 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ------------------------------ 3ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ------------------------------ 3ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Apr 24 21:25:29 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Apr 24 21:25:29 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:29 thinkpadhome volumio[1243]: info: Apr 24 21:25:29 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand status took 7 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 10 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand status took 10 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 7 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:29 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/92944/download.pcm","trackType":"pcm"} Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:29 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/92944/download.pcm","trackType":"pcm"} Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ------------------------------ 49ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ------------------------------ 49ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 36 milliseconds Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:29 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/92944/download.pcm","trackType":"pcm"} Apr 24 21:25:29 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:29 thinkpadhome volumio[1243]: info: ------------------------------ 80ms Apr 24 21:25:29 thinkpadhome volumio[1243]: info: MyVolumio login type: Token Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::ClearQueue Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::clearPlayQueue Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92942 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92942 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92943 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92943 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92944 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92944 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPlay Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::play index 2 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92945 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92945 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92946 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92946 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92947 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92947 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92948 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92948 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92949 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92949 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92950 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92950 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92951 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92951 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92952 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92952 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92953 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92953 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92954 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92954 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92955 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92955 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92956 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92956 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92957 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92957 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92958 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7917/l/9617/t/92958 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::play index undefined Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::startPlaybackTimer Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: [1745501130635] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 2 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Apr 24 21:25:30 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand clear took 1 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/92944/download.pcm" Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Apr 24 21:25:30 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Apr 24 21:25:30 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:30 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ------------------------------ 1ms Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/92944/download.pcm" Apr 24 21:25:30 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:30 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Apr 24 21:25:30 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ------------------------------ 16ms Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ------------------------------ 15ms Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand add "http://192.168.3.220:9000/music/92944/download.pcm" took 1 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand play Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Apr 24 21:25:30 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Apr 24 21:25:30 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ------------------------------ 3ms Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand play took 3 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ------------------------------ 1ms Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Apr 24 21:25:30 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Apr 24 21:25:30 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:30 thinkpadhome volumio[1243]: info: Apr 24 21:25:30 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand status took 5 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand status took 5 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand status took 7 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 12 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 11 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 9 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:30 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/92944/download.pcm","trackType":"pcm"} Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:30 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/92944/download.pcm","trackType":"pcm"} Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:30 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/92944/download.pcm","trackType":"pcm"} Apr 24 21:25:30 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ------------------------------ 47ms Apr 24 21:25:30 thinkpadhome volumio[1243]: info: ------------------------------ 47ms Apr 24 21:25:34 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 24 21:25:34 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 24 21:25:34 thinkpadhome volumio[1243]: info: Discovery: Getting this device information Apr 24 21:25:34 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioGetState Apr 24 21:25:34 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 21:25:42 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 24 21:25:42 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:44 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88956 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88957 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88958 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88959 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88960 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88961 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88962 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88963 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88964 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88965 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88966 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88967 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88968 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88969 Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88956 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88957 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88958 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88959 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: No valid Plugin REST Endpoint Apr 24 21:25:44 thinkpadhome volumio[1243]: info: No valid Plugin REST Endpoint Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88960 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88961 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88962 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88963 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88964 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88965 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88966 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88967 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88968 in service upnp_browser Apr 24 21:25:44 thinkpadhome volumio[1243]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88969 in service upnp_browser Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::ClearQueue Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::clearPlayQueue Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88956 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88956 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88957 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88957 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88958 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88958 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPlay Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::play index 2 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88959 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88959 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88960 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88960 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88961 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88961 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88962 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88962 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88963 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88963 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88964 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88964 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88965 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88965 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88966 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88966 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88967 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88967 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88968 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88968 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88969 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/a/7713/l/9324/t/88969 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::play index undefined Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::startPlaybackTimer Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: [1745501147243] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 1 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand clear took 1 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/88958/download.pcm" Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Apr 24 21:25:47 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Apr 24 21:25:47 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Apr 24 21:25:47 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/88958/download.pcm" Apr 24 21:25:47 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:47 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:47 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ------------------------------ 36ms Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ------------------------------ 37ms Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ------------------------------ 36ms Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand add "http://192.168.3.220:9000/music/88958/download.pcm" took 1 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand play Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Apr 24 21:25:47 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Apr 24 21:25:47 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand play took 4 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Apr 24 21:25:47 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ------------------------------ 3ms Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ------------------------------ 3ms Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Apr 24 21:25:47 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Apr 24 21:25:47 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:47 thinkpadhome volumio[1243]: info: Apr 24 21:25:47 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand status took 5 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand status took 5 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 6 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand clearerror took 5 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:47 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:47 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:25:47 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:25:47 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: No code Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ------------------------------ 35ms Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ------------------------------ 35ms Apr 24 21:25:47 thinkpadhome volumio[1243]: info: ------------------------------ 36ms Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Retrieving Cloud Streaming UI Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Getting Tidal Cloud Configuration Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Getting Qobuz Cloud Configuration Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Asking plugin for UI Config Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Getting Spotify Cloud Configuration Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Asking plugin for UI Config Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Saving Spotify Acccount Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Got Tidal Cloud Configuration Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Got it Apr 24 21:25:57 thinkpadhome volumio[1243]: info: Got it Apr 24 21:25:57 thinkpadhome volumio[1243]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 24 21:25:57 thinkpadhome volumio[1243]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioGetBrowseSources Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioGetBrowseSources Apr 24 21:25:57 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioGetBrowseSources Apr 24 21:25:58 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 21:25:58 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 24 21:25:59 thinkpadhome volumio[1243]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 24 21:25:59 thinkpadhome volumio[1243]: info: Retrying Login Due to Network Error Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand rescan Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:00 thinkpadhome volumio[1243]: info: Apr 24 21:26:00 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: update Apr 24 21:26:00 thinkpadhome volumio[1243]: info: sendMpdCommand rescan took 2 milliseconds Apr 24 21:26:00 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:00 thinkpadhome volumio[1243]: info: Apr 24 21:26:00 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: update Apr 24 21:26:00 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:00 thinkpadhome volumio[1243]: info: Apr 24 21:26:00 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: update Apr 24 21:26:00 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:00 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:26:00 thinkpadhome volumio[1243]: info: sendMpdCommand status took 6 milliseconds Apr 24 21:26:00 thinkpadhome volumio[1243]: info: sendMpdCommand status took 5 milliseconds Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: Command Router : Notfying DB Updatetrue Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::Close All Modals sent Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: Command Router : Notfying DB Updatetrue Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::Close All Modals sent Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: Command Router : Notfying DB Updatetrue Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::Close All Modals sent Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:00 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 47 milliseconds Apr 24 21:26:00 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 28 milliseconds Apr 24 21:26:00 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:00 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:26:00 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:00 thinkpadhome volumio[1243]: info: ------------------------------ 219ms Apr 24 21:26:00 thinkpadhome volumio[1243]: info: ------------------------------ 219ms Apr 24 21:26:00 thinkpadhome volumio[1243]: info: ------------------------------ 220ms Apr 24 21:26:02 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 24 21:26:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 24 21:26:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 24 21:26:04 thinkpadhome volumio[1243]: info: Discovery: Getting this device information Apr 24 21:26:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioGetState Apr 24 21:26:04 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 21:26:09 thinkpadhome volumio[1243]: info: MyVolumio login type: Token Apr 24 21:26:15 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 21:26:15 thinkpadhome volumio[1243]: info: CURURI: music-library Apr 24 21:26:15 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:15 thinkpadhome volumio[1243]: info: MPD Database updated - AlbumList cache refreshed Apr 24 21:26:15 thinkpadhome volumio[1243]: info: Apr 24 21:26:15 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: database Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:15 thinkpadhome volumio[1243]: info: Apr 24 21:26:15 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: update Apr 24 21:26:15 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:15 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:15 thinkpadhome volumio[1243]: info: MPD Database updated - AlbumList cache refreshed Apr 24 21:26:15 thinkpadhome volumio[1243]: info: Apr 24 21:26:15 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: database Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:15 thinkpadhome volumio[1243]: info: Apr 24 21:26:15 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: update Apr 24 21:26:15 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:15 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:15 thinkpadhome volumio[1243]: info: MPD Database updated - AlbumList cache refreshed Apr 24 21:26:15 thinkpadhome volumio[1243]: info: Apr 24 21:26:15 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: database Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:15 thinkpadhome volumio[1243]: info: Apr 24 21:26:15 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: update Apr 24 21:26:15 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:15 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:15 thinkpadhome volumio[1243]: info: sendMpdCommand status took 424 milliseconds Apr 24 21:26:15 thinkpadhome volumio[1243]: info: sendMpdCommand status took 423 milliseconds Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:15 thinkpadhome volumio[1243]: info: Command Router : Notfying DB Updatefalse Apr 24 21:26:15 thinkpadhome volumio[1243]: info: CoreCommandRouter::Close All Modals sent Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:15 thinkpadhome volumio[1243]: info: sendMpdCommand status took 681 milliseconds Apr 24 21:26:15 thinkpadhome volumio[1243]: info: sendMpdCommand status took 680 milliseconds Apr 24 21:26:15 thinkpadhome volumio[1243]: info: sendMpdCommand status took 679 milliseconds Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:15 thinkpadhome volumio[1243]: info: Command Router : Notfying DB Updatefalse Apr 24 21:26:15 thinkpadhome volumio[1243]: info: CoreCommandRouter::Close All Modals sent Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:15 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:16 thinkpadhome volumio[1243]: info: sendMpdCommand status took 871 milliseconds Apr 24 21:26:16 thinkpadhome volumio[1243]: info: sendMpdCommand status took 871 milliseconds Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: Command Router : Notfying DB Updatefalse Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::Close All Modals sent Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:16 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 419 milliseconds Apr 24 21:26:16 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 419 milliseconds Apr 24 21:26:16 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 193 milliseconds Apr 24 21:26:16 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 193 milliseconds Apr 24 21:26:16 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 24 21:26:16 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: 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":"download.pcm","artist":null,"album":null,"uri":"http://192.168.3.220:9000/music/88958/download.pcm","trackType":"pcm"} Apr 24 21:26:16 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ------------------------------ 1010ms Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ------------------------------ 1011ms Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ------------------------------ 1010ms Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ------------------------------ 1011ms Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ------------------------------ 1009ms Apr 24 21:26:16 thinkpadhome volumio[1243]: info: ------------------------------ 1009ms Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 21:26:16 thinkpadhome volumio[1243]: info: CURURI: music-library/USB Apr 24 21:26:16 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:17 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 21:26:17 thinkpadhome volumio[1243]: info: CURURI: music-library/USB/系统 Apr 24 21:26:17 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:17 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/2023_08_02【耳舐めASMR】彼氏のイイナリ_ドえっち水着強制着用_こっそりイチャあまレロクチュ唾液交換プレイ【冒頭無料.mp3 Apr 24 21:26:17 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/2023_08_23【耳舐めASMR】愛情たっぷりスロウ耳舐め_ぐっすり熟睡したいアナタへ【冒頭無料_KU100】.mp3 Apr 24 21:26:17 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/2023_09_02【耳舐めASMR】キス多め_夏休みの宿題やらない生徒vs担任巨乳女教師_ヒミツの居残り授業【冒頭無料KU100】.mp3 Apr 24 21:26:17 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/长城 Beyond.mp3 Apr 24 21:26:17 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/2023_08_02【耳舐めASMR】彼氏のイイナリ_ドえっち水着強制着用_こっそりイチャあまレロクチュ唾液交換プレイ【冒頭無料.mp3 in service mpd Apr 24 21:26:18 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F2023_08_02%E3%80%90%E8%80%B3%E8%88%90%E3%82%81ASMR%E3%80%91%E5%BD%BC%E6%B0%8F%E3%81%AE%E3%82%A4%E3%82%A4%E3%83%8A%E3%83%AA_%E3%83%89%E3%81%88%E3%81%A3%E3%81%A1%E6%B0%B4%E7%9D%80%E5%BC%B7%E5%88%B6%E7%9D%80%E7%94%A8_%E3%81%93%E3%81%A3%E3%81%9D%E3%82%8A%E3%82%A4%E3%83%81%E3%83%A3%E3%81%82%E3%81%BE%E3%83%AC%E3%83%AD%E3%82%AF%E3%83%81%E3%83%A5%E5%94%BE%E6%B6%B2%E4%BA%A4%E6%8F%9B%E3%83%97%E3%83%AC%E3%82%A4%E3%80%90%E5%86%92%E9%A0%AD%E7%84%A1%E6%96%99.mp3&metadata=false Apr 24 21:26:18 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/2023_08_02【耳舐めASMR】彼氏のイイナリ_ドえっち水着強制着用_こっそりイチャあまレロクチュ唾液交換プレイ【冒頭無料.mp3 Apr 24 21:26:18 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/2023_08_23【耳舐めASMR】愛情たっぷりスロウ耳舐め_ぐっすり熟睡したいアナタへ【冒頭無料_KU100】.mp3 in service mpd Apr 24 21:26:18 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/2023_09_02【耳舐めASMR】キス多め_夏休みの宿題やらない生徒vs担任巨乳女教師_ヒミツの居残り授業【冒頭無料KU100】.mp3 in service mpd Apr 24 21:26:18 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/长城 Beyond.mp3 in service mpd Apr 24 21:26:18 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F2023_08_23%E3%80%90%E8%80%B3%E8%88%90%E3%82%81ASMR%E3%80%91%E6%84%9B%E6%83%85%E3%81%9F%E3%81%A3%E3%81%B7%E3%82%8A%E3%82%B9%E3%83%AD%E3%82%A6%E8%80%B3%E8%88%90%E3%82%81_%E3%81%90%E3%81%A3%E3%81%99%E3%82%8A%E7%86%9F%E7%9D%A1%E3%81%97%E3%81%9F%E3%81%84%E3%82%A2%E3%83%8A%E3%82%BF%E3%81%B8%E3%80%90%E5%86%92%E9%A0%AD%E7%84%A1%E6%96%99_KU100%E3%80%91.mp3&metadata=false Apr 24 21:26:18 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/2023_08_23【耳舐めASMR】愛情たっぷりスロウ耳舐め_ぐっすり熟睡したいアナタへ【冒頭無料_KU100】.mp3 Apr 24 21:26:18 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F2023_09_02%E3%80%90%E8%80%B3%E8%88%90%E3%82%81ASMR%E3%80%91%E3%82%AD%E3%82%B9%E5%A4%9A%E3%82%81_%E5%A4%8F%E4%BC%91%E3%81%BF%E3%81%AE%E5%AE%BF%E9%A1%8C%E3%82%84%E3%82%89%E3%81%AA%E3%81%84%E7%94%9F%E5%BE%92vs%E6%8B%85%E4%BB%BB%E5%B7%A8%E4%B9%B3%E5%A5%B3%E6%95%99%E5%B8%AB_%E3%83%92%E3%83%9F%E3%83%84%E3%81%AE%E5%B1%85%E6%AE%8B%E3%82%8A%E6%8E%88%E6%A5%AD%E3%80%90%E5%86%92%E9%A0%AD%E7%84%A1%E6%96%99KU100%E3%80%91.mp3&metadata=false Apr 24 21:26:18 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/2023_09_02【耳舐めASMR】キス多め_夏休みの宿題やらない生徒vs担任巨乳女教師_ヒミツの居残り授業【冒頭無料KU100】.mp3 Apr 24 21:26:18 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=Beyond//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E9%95%BF%E5%9F%8E%20%20%20Beyond.mp3&metadata=false Apr 24 21:26:18 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/长城 Beyond.mp3 Apr 24 21:26:20 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 21:26:20 thinkpadhome volumio[1243]: info: CURURI: music-library/USB/系统/HIFI男生四兄弟 Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/01. 乾杯，朋友.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/02. 谢谢最深爱的你.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/04. 明月千里寄相思.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/05. 酒乾倘卖无.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/06. 穿过你的黑发我的手.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/07. 是不是这样的夜晚你才会这样的想起我.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/08. 啊，停不住的爱人.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/09. 明天你是否依然爱我.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/10. 最远的你是我最近的爱.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/11. 晚秋.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/12. 阳光总在风雨后.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Preloading song: music-library/USB/系统/HIFI男生四兄弟/13. 故乡的云.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/01. 乾杯，朋友.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F01.%20%E4%B9%BE%E6%9D%AF%EF%BC%8C%E6%9C%8B%E5%8F%8B.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/01. 乾杯，朋友.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/02. 谢谢最深爱的你.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F02.%20%E8%B0%A2%E8%B0%A2%E6%9C%80%E6%B7%B1%E7%88%B1%E7%9A%84%E4%BD%A0.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/02. 谢谢最深爱的你.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/03. 天黑黑.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F03.%20%E5%A4%A9%E9%BB%91%E9%BB%91.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/04. 明月千里寄相思.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F04.%20%E6%98%8E%E6%9C%88%E5%8D%83%E9%87%8C%E5%AF%84%E7%9B%B8%E6%80%9D.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/04. 明月千里寄相思.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/05. 酒乾倘卖无.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F05.%20%E9%85%92%E4%B9%BE%E5%80%98%E5%8D%96%E6%97%A0.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/05. 酒乾倘卖无.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/06. 穿过你的黑发我的手.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F06.%20%E7%A9%BF%E8%BF%87%E4%BD%A0%E7%9A%84%E9%BB%91%E5%8F%91%E6%88%91%E7%9A%84%E6%89%8B.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/06. 穿过你的黑发我的手.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/07. 是不是这样的夜晚你才会这样的想起我.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F07.%20%E6%98%AF%E4%B8%8D%E6%98%AF%E8%BF%99%E6%A0%B7%E7%9A%84%E5%A4%9C%E6%99%9A%E4%BD%A0%E6%89%8D%E4%BC%9A%E8%BF%99%E6%A0%B7%E7%9A%84%E6%83%B3%E8%B5%B7%E6%88%91.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/07. 是不是这样的夜晚你才会这样的想起我.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/08. 啊，停不住的爱人.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F08.%20%E5%95%8A%EF%BC%8C%E5%81%9C%E4%B8%8D%E4%BD%8F%E7%9A%84%E7%88%B1%E4%BA%BA.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/08. 啊，停不住的爱人.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/09. 明天你是否依然爱我.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F09.%20%E6%98%8E%E5%A4%A9%E4%BD%A0%E6%98%AF%E5%90%A6%E4%BE%9D%E7%84%B6%E7%88%B1%E6%88%91.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/09. 明天你是否依然爱我.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/10. 最远的你是我最近的爱.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F10.%20%E6%9C%80%E8%BF%9C%E7%9A%84%E4%BD%A0%E6%98%AF%E6%88%91%E6%9C%80%E8%BF%91%E7%9A%84%E7%88%B1.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/10. 最远的你是我最近的爱.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/11. 晚秋.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F11.%20%E6%99%9A%E7%A7%8B.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/11. 晚秋.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/12. 阳光总在风雨后.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F12.%20%E9%98%B3%E5%85%89%E6%80%BB%E5%9C%A8%E9%A3%8E%E9%9B%A8%E5%90%8E.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/12. 阳光总在风雨后.wav Apr 24 21:26:21 thinkpadhome volumio[1243]: info: Exploding uri music-library/USB/系统/HIFI男生四兄弟/13. 故乡的云.wav in service mpd Apr 24 21:26:21 thinkpadhome volumio[1243]: info: ALBUMART /albumart?cacheid=881&web=%3F%3F/HIFI%3F%3F-%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E7%94%B7%E7%94%9F%E5%9B%9B%E5%85%84%E5%BC%9F%2F13.%20%E6%95%85%E4%B9%A1%E7%9A%84%E4%BA%91.wav&metadata=false Apr 24 21:26:21 thinkpadhome volumio[1243]: info: URI /mnt/USB/系统/HIFI男生四兄弟/13. 故乡的云.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::ClearQueue Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::clearPlayQueue Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/01. 乾杯，朋友.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/01. 乾杯，朋友.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/02. 谢谢最深爱的你.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/02. 谢谢最深爱的你.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPlay Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::play index 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/04. 明月千里寄相思.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/04. 明月千里寄相思.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/05. 酒乾倘卖无.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/05. 酒乾倘卖无.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/06. 穿过你的黑发我的手.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/06. 穿过你的黑发我的手.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/07. 是不是这样的夜晚你才会这样的想起我.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/07. 是不是这样的夜晚你才会这样的想起我.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/08. 啊，停不住的爱人.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/08. 啊，停不住的爱人.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/09. 明天你是否依然爱我.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/09. 明天你是否依然爱我.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/10. 最远的你是我最近的爱.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/10. 最远的你是我最近的爱.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/11. 晚秋.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/11. 晚秋.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/12. 阳光总在风雨后.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/12. 阳光总在风雨后.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/13. 故乡的云.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/13. 故乡的云.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::play index undefined Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::startPlaybackTimer Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 2 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand clear took 8 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/HIFI男生四兄弟/03. 天黑黑.wav" Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:22 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 4ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand add "USB/系统/HIFI男生四兄弟/03. 天黑黑.wav" took 3 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 3ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand play took 1 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 1ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 0ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Apr 24 21:26:22 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand status took 3 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand status took 2 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand status took 1 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand status took 5 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 23ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 27ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 26ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 27ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 27ms Apr 24 21:26:22 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:22 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:22 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:22 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:22 thinkpadhome volumio[1243]: info: ------------------------------ 33ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::ClearQueue Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::stPlaybackTimer Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::serviceStop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::serviceStop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::stop Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::clearPlayQueue Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/01. 乾杯，朋友.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/01. 乾杯，朋友.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/02. 谢谢最深爱的你.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/02. 谢谢最深爱的你.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPlay Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::play index 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/04. 明月千里寄相思.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/04. 明月千里寄相思.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/05. 酒乾倘卖无.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/05. 酒乾倘卖无.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/06. 穿过你的黑发我的手.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/06. 穿过你的黑发我的手.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/07. 是不是这样的夜晚你才会这样的想起我.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/07. 是不是这样的夜晚你才会这样的想起我.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/08. 啊，停不住的爱人.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/08. 啊，停不住的爱人.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/09. 明天你是否依然爱我.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/09. 明天你是否依然爱我.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/10. 最远的你是我最近的爱.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/10. 最远的你是我最近的爱.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/11. 晚秋.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/11. 晚秋.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/12. 阳光总在风雨后.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/12. 阳光总在风雨后.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/13. 故乡的云.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/13. 故乡的云.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::play index undefined Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::startPlaybackTimer Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 27 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 8 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand clear took 3 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand status took 2 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand status took 1 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/HIFI男生四兄弟/03. 天黑黑.wav" Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 25ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 25ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:23 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 32ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 30 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand add "USB/系统/HIFI男生四兄弟/03. 天黑黑.wav" took 30 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 8ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 7ms Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand play Apr 24 21:26:23 thinkpadhome volumio[1243]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 37ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 8ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand play took 6 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 12ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 11ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand status took 3 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand status took 2 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand status took 2 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Apr 24 21:26:23 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand status took 5 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand status took 3 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 26ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 30ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 29ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 21 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:23 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:23 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:23 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 49ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 47ms Apr 24 21:26:23 thinkpadhome volumio[1243]: info: ------------------------------ 45ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::ClearQueue Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::stPlaybackTimer Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::serviceStop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::serviceStop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::stop Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::clearPlayQueue Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/01. 乾杯，朋友.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/01. 乾杯，朋友.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/02. 谢谢最深爱的你.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/02. 谢谢最深爱的你.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPlay Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::play index 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::addQueueItems Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::addQueueItems Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Preload queue cleared Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/04. 明月千里寄相思.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/04. 明月千里寄相思.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/05. 酒乾倘卖无.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/05. 酒乾倘卖无.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/06. 穿过你的黑发我的手.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/06. 穿过你的黑发我的手.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/07. 是不是这样的夜晚你才会这样的想起我.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/07. 是不是这样的夜晚你才会这样的想起我.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/08. 啊，停不住的爱人.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/08. 啊，停不住的爱人.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/09. 明天你是否依然爱我.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/09. 明天你是否依然爱我.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/10. 最远的你是我最近的爱.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/10. 最远的你是我最近的爱.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/11. 晚秋.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/11. 晚秋.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/12. 阳光总在风雨后.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/12. 阳光总在风雨后.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Adding Item to queue: music-library/USB/系统/HIFI男生四兄弟/13. 故乡的云.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Using cached record of: music-library/USB/系统/HIFI男生四兄弟/13. 故乡的云.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::stop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushQueue Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::saveQueue Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::play index undefined Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::updateTrackBlock Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrackBlock Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::startPlaybackTimer Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/HIFI男生四兄弟/03. 天黑黑.wav Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 18 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand stop took 3 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand status took 4 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand clear took 3 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand status took 2 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/HIFI男生四兄弟/03. 天黑黑.wav" Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService stop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: No code Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 23ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 23ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:26 thinkpadhome volumio[1243]: error: updateQueue error: null Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 24ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 23 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand add "USB/系统/HIFI男生四兄弟/03. 天黑黑.wav" took 23 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 2ms Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand play Apr 24 21:26:26 thinkpadhome volumio[1243]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 31ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces system playlist update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Ignoring MPD Status Update Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 16ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand play took 14 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 13ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Apr 24 21:26:26 thinkpadhome volumio[1243]: ---------------------------- MPD announces state update: player Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::getState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand status Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 18ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand status took 9 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand status took 8 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand status took 7 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand status took 7 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseState Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: ControllerMpd::parseTrackInfo Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus stop Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ControllerMpd::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::servicePushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"HIFI??-???","uri":"USB/系统/HIFI男生四兄弟/03. 天黑黑.wav","trackType":"wav"} Apr 24 21:26:26 thinkpadhome volumio[1243]: verbose: CURRENT POSITION 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState stateService play Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::syncState currentStatus play Apr 24 21:26:26 thinkpadhome volumio[1243]: info: Received an update from plugin. extracting info from payload Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreStateMachine::pushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:26 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioPushState Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 41ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 51ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 50ms Apr 24 21:26:26 thinkpadhome volumio[1243]: info: ------------------------------ 50ms Apr 24 21:26:34 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 24 21:26:34 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 24 21:26:34 thinkpadhome volumio[1243]: info: Discovery: Getting this device information Apr 24 21:26:34 thinkpadhome volumio[1243]: info: CoreCommandRouter::volumioGetState Apr 24 21:26:34 thinkpadhome volumio[1243]: info: CorePlayQueue::getTrack 2 Apr 24 21:26:34 thinkpadhome volumio[1243]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 24 21:26:39 thinkpadhome volumio[1243]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 24 21:26:39 thinkpadhome volumio[1243]: info: Retrying Login Due to Network Error Apr 24 21:26:40 thinkpadhome volumio[1243]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 21:26:40 thinkpadhome volumio[1243]: Error: connect ETIMEDOUT 104.244.43.234:80 Apr 24 21:26:40 thinkpadhome volumio[1243]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Apr 24 21:26:40 thinkpadhome volumio[1243]: errno: -110, Apr 24 21:26:40 thinkpadhome volumio[1243]: code: 'ETIMEDOUT', Apr 24 21:26:40 thinkpadhome volumio[1243]: syscall: 'connect', Apr 24 21:26:40 thinkpadhome volumio[1243]: address: '104.244.43.234', Apr 24 21:26:40 thinkpadhome volumio[1243]: port: 80 Apr 24 21:26:40 thinkpadhome volumio[1243]: } Apr 24 21:26:40 thinkpadhome volumio[1243]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 21:26:40 thinkpadhome sudo[13462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-24 21:25 Apr 24 21:26:40 thinkpadhome sudo[13462]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"