-- Logs begin at Thu 2025-04-24 19:01:18 CST, end at Thu 2025-04-24 19:53:41 CST. -- Apr 24 19:52:00 thinkpadhome volumio[10910]: info: BOOT COMPLETED Apr 24 19:52:02 thinkpadhome volumio[10910]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 24 19:52:02 thinkpadhome volumio[10910]: info: Retrying Login Due to Network Error Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPlay Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::play index 6 Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::play index undefined Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::startPlaybackTimer Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:05 thinkpadhome volumio[10910]: info: [1745495525166] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand stop took 0 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Apr 24 19:52:05 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand clear took 0 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/93981/download.pcm" Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Apr 24 19:52:05 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Apr 24 19:52:05 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:05 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ------------------------------ 2ms Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/93981/download.pcm" Apr 24 19:52:05 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:05 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Apr 24 19:52:05 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ------------------------------ 20ms Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ------------------------------ 20ms Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand add "http://192.168.3.220:9000/music/93981/download.pcm" took 1 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand play Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Apr 24 19:52:05 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Apr 24 19:52:05 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ------------------------------ 3ms Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand play took 2 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ------------------------------ 1ms Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ------------------------------ 1ms Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Apr 24 19:52:05 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Apr 24 19:52:05 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:05 thinkpadhome volumio[10910]: info: Apr 24 19:52:05 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand status took 4 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand status took 4 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand status took 4 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 7 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 6 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 6 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:05 thinkpadhome volumio[10910]: 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/93981/download.pcm","trackType":"pcm"} Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 6 Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:05 thinkpadhome volumio[10910]: 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/93981/download.pcm","trackType":"pcm"} Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 6 Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:05 thinkpadhome volumio[10910]: 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/93981/download.pcm","trackType":"pcm"} Apr 24 19:52:05 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 6 Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ------------------------------ 50ms Apr 24 19:52:05 thinkpadhome volumio[10910]: info: ------------------------------ 50ms Apr 24 19:52:07 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioRemoveQueueItem Apr 24 19:52:07 thinkpadhome volumio[10910]: info: CoreStateMachine::removeQueueItem Apr 24 19:52:07 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:07 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:07 thinkpadhome volumio[10910]: info: CorePlayQueue::removeQueueItem 6 Apr 24 19:52:07 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:07 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:12 thinkpadhome volumio[10910]: info: MyVolumio login type: Token Apr 24 19:52:21 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Preloading song: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 in service upnp_browser Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 in service upnp_browser Apr 24 19:52:21 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: No valid Plugin REST Endpoint Apr 24 19:52:22 thinkpadhome volumio[10910]: info: No valid Plugin REST Endpoint Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 in service upnp_browser Apr 24 19:52:22 thinkpadhome volumio[10910]: info: Exploding uri upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 in service upnp_browser Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::ClearQueue Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::clearPlayQueue Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPlay Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::play index 0 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::play index undefined Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::startPlaybackTimer Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: [1745495544738] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand stop took 2 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Apr 24 19:52:24 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand clear took 1 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/66945/download.pcm" Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Apr 24 19:52:24 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Apr 24 19:52:24 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:24 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ------------------------------ 3ms Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/66945/download.pcm" Apr 24 19:52:24 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:24 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Apr 24 19:52:24 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ------------------------------ 13ms Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ------------------------------ 13ms Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand add "http://192.168.3.220:9000/music/66945/download.pcm" took 2 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand play Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Apr 24 19:52:24 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Apr 24 19:52:24 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ------------------------------ 4ms Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand play took 3 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ------------------------------ 2ms Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ------------------------------ 2ms Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Apr 24 19:52:24 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Apr 24 19:52:24 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand status took 6 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:24 thinkpadhome volumio[10910]: info: Apr 24 19:52:24 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand status took 11 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 6 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand status took 4 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:24 thinkpadhome volumio[10910]: 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/66945/download.pcm","trackType":"pcm"} Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 0 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ------------------------------ 36ms Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 28 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 27 milliseconds Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:24 thinkpadhome volumio[10910]: 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/66945/download.pcm","trackType":"pcm"} Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 0 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:24 thinkpadhome volumio[10910]: 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/66945/download.pcm","trackType":"pcm"} Apr 24 19:52:24 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 0 Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ------------------------------ 70ms Apr 24 19:52:24 thinkpadhome volumio[10910]: info: ------------------------------ 64ms Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::ClearQueue Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::clearPlayQueue Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPlay Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::play index 0 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::play index undefined Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::startPlaybackTimer Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: [1745495548586] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand stop took 4 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Apr 24 19:52:28 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand clear took 1 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/66945/download.pcm" Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Apr 24 19:52:28 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Apr 24 19:52:28 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:28 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ------------------------------ 5ms Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/66945/download.pcm" Apr 24 19:52:28 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:28 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Apr 24 19:52:28 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ------------------------------ 15ms Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ------------------------------ 15ms Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand add "http://192.168.3.220:9000/music/66945/download.pcm" took 2 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand play Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Apr 24 19:52:28 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Apr 24 19:52:28 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ------------------------------ 3ms Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand play took 2 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ------------------------------ 1ms Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ------------------------------ 1ms Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Apr 24 19:52:28 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand status took 3 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Apr 24 19:52:28 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:28 thinkpadhome volumio[10910]: info: Apr 24 19:52:28 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 4 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand status took 2 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand status took 1 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:28 thinkpadhome volumio[10910]: 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/66945/download.pcm","trackType":"pcm"} Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 0 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ------------------------------ 23ms Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:28 thinkpadhome volumio[10910]: 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/66945/download.pcm","trackType":"pcm"} Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 0 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:28 thinkpadhome volumio[10910]: 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/66945/download.pcm","trackType":"pcm"} Apr 24 19:52:28 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 0 Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ------------------------------ 49ms Apr 24 19:52:28 thinkpadhome volumio[10910]: info: ------------------------------ 49ms Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::ClearQueue Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::clearPlayQueue Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPlay Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::play index 0 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::play index undefined Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::startPlaybackTimer Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:29 thinkpadhome volumio[10910]: info: [1745495549911] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand stop took 3 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Apr 24 19:52:29 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand clear took 0 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/66945/download.pcm" Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Apr 24 19:52:29 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Apr 24 19:52:29 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:29 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ------------------------------ 4ms Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/66945/download.pcm" Apr 24 19:52:29 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:29 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Apr 24 19:52:29 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ------------------------------ 22ms Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ------------------------------ 22ms Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand add "http://192.168.3.220:9000/music/66945/download.pcm" took 1 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand play Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Apr 24 19:52:29 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Apr 24 19:52:29 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ------------------------------ 3ms Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand play took 2 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ------------------------------ 3ms Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ------------------------------ 2ms Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Apr 24 19:52:29 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Apr 24 19:52:29 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:29 thinkpadhome volumio[10910]: info: Apr 24 19:52:29 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand status took 4 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand status took 4 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand status took 4 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 17 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 18 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 17 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:29 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:29 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:29 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:30 thinkpadhome volumio[10910]: 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/66945/download.pcm","trackType":"pcm"} Apr 24 19:52:30 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 0 Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:30 thinkpadhome volumio[10910]: 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/66945/download.pcm","trackType":"pcm"} Apr 24 19:52:30 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 0 Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 0 Apr 24 19:52:30 thinkpadhome volumio[10910]: 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/66945/download.pcm","trackType":"pcm"} Apr 24 19:52:30 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 0 Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:30 thinkpadhome volumio[10910]: info: ------------------------------ 79ms Apr 24 19:52:30 thinkpadhome volumio[10910]: info: ------------------------------ 78ms Apr 24 19:52:30 thinkpadhome volumio[10910]: info: ------------------------------ 78ms Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::ClearQueue Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::clearPlayQueue Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPlay Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::play index 6 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::play index undefined Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::startPlaybackTimer Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: [1745495551575] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand stop took 2 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Apr 24 19:52:31 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand clear took 1 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/66951/download.pcm" Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Apr 24 19:52:31 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Apr 24 19:52:31 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:31 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ------------------------------ 15ms Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/66951/download.pcm" Apr 24 19:52:31 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:31 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Apr 24 19:52:31 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ------------------------------ 15ms Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ------------------------------ 15ms Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand add "http://192.168.3.220:9000/music/66951/download.pcm" took 1 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand play Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Apr 24 19:52:31 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Apr 24 19:52:31 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ------------------------------ 3ms Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand play took 2 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ------------------------------ 2ms Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ------------------------------ 1ms Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Apr 24 19:52:31 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Apr 24 19:52:31 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand status took 3 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:31 thinkpadhome volumio[10910]: info: Apr 24 19:52:31 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand status took 8 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 5 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:31 thinkpadhome volumio[10910]: 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/66951/download.pcm","trackType":"pcm"} Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 6 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ------------------------------ 29ms Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand status took 30 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 26 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:31 thinkpadhome volumio[10910]: 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/66951/download.pcm","trackType":"pcm"} Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 6 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ------------------------------ 84ms Apr 24 19:52:31 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 47 milliseconds Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:31 thinkpadhome volumio[10910]: 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/66951/download.pcm","trackType":"pcm"} Apr 24 19:52:31 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 6 Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:31 thinkpadhome volumio[10910]: info: ------------------------------ 98ms Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::ClearQueue Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::clearPlayQueue Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66945 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66946 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66947 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66948 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66949 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66950 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66951 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPlay Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::play index 6 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66952 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66953 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66954 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66955 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66956 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66957 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66958 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Adding Item to queue: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Using cached record of: upnp/http://192.168.3.220:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/l/7976/t/66959 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::play index undefined Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::startPlaybackTimer Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: [1745495552176] ControllerUPNPBrowser::clearAddPlayTrack Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand stop took 2 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Apr 24 19:52:32 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand clear took 0 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.220:9000/music/66951/download.pcm" Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Apr 24 19:52:32 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Apr 24 19:52:32 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:32 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ------------------------------ 19ms Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.220:9000/music/66951/download.pcm" Apr 24 19:52:32 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:32 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Apr 24 19:52:32 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ------------------------------ 19ms Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ------------------------------ 17ms Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand add "http://192.168.3.220:9000/music/66951/download.pcm" took 1 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand play Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Apr 24 19:52:32 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Apr 24 19:52:32 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ------------------------------ 2ms Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand play took 2 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ------------------------------ 1ms Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ------------------------------ 1ms Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Apr 24 19:52:32 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Apr 24 19:52:32 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand status took 3 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:32 thinkpadhome volumio[10910]: info: Apr 24 19:52:32 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand status took 7 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 4 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand status took 3 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:32 thinkpadhome volumio[10910]: 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/66951/download.pcm","trackType":"pcm"} Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 6 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ------------------------------ 21ms Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand clearerror took 20 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:32 thinkpadhome volumio[10910]: 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/66951/download.pcm","trackType":"pcm"} Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 6 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 6 Apr 24 19:52:32 thinkpadhome volumio[10910]: 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/66951/download.pcm","trackType":"pcm"} Apr 24 19:52:32 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 6 Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: No code Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ------------------------------ 49ms Apr 24 19:52:32 thinkpadhome volumio[10910]: info: ------------------------------ 47ms Apr 24 19:52:42 thinkpadhome volumio[10910]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 24 19:52:42 thinkpadhome volumio[10910]: info: Retrying Login Due to Network Error Apr 24 19:52:43 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 19:52:43 thinkpadhome volumio[10910]: info: CURURI: music-library Apr 24 19:52:43 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:44 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 19:52:44 thinkpadhome volumio[10910]: info: CURURI: music-library/USB Apr 24 19:52:45 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:46 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 19:52:46 thinkpadhome volumio[10910]: info: CURURI: music-library/USB/系统 Apr 24 19:52:46 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:46 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/2023_08_02【耳舐めASMR】彼氏のイイナリ_ドえっち水着強制着用_こっそりイチャあまレロクチュ唾液交換プレイ【冒頭無料.mp3 Apr 24 19:52:46 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/2023_08_23【耳舐めASMR】愛情たっぷりスロウ耳舐め_ぐっすり熟睡したいアナタへ【冒頭無料_KU100】.mp3 Apr 24 19:52:46 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/2023_09_02【耳舐めASMR】キス多め_夏休みの宿題やらない生徒vs担任巨乳女教師_ヒミツの居残り授業【冒頭無料KU100】.mp3 Apr 24 19:52:46 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/长城 Beyond.mp3 Apr 24 19:52:46 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/2023_08_02【耳舐めASMR】彼氏のイイナリ_ドえっち水着強制着用_こっそりイチャあまレロクチュ唾液交換プレイ【冒頭無料.mp3 in service mpd Apr 24 19:52:46 thinkpadhome volumio[10910]: 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 19:52:46 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/2023_08_02【耳舐めASMR】彼氏のイイナリ_ドえっち水着強制着用_こっそりイチャあまレロクチュ唾液交換プレイ【冒頭無料.mp3 Apr 24 19:52:46 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/2023_08_23【耳舐めASMR】愛情たっぷりスロウ耳舐め_ぐっすり熟睡したいアナタへ【冒頭無料_KU100】.mp3 in service mpd Apr 24 19:52:46 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/2023_09_02【耳舐めASMR】キス多め_夏休みの宿題やらない生徒vs担任巨乳女教師_ヒミツの居残り授業【冒頭無料KU100】.mp3 in service mpd Apr 24 19:52:46 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/长城 Beyond.mp3 in service mpd Apr 24 19:52:46 thinkpadhome volumio[10910]: 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 19:52:46 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/2023_08_23【耳舐めASMR】愛情たっぷりスロウ耳舐め_ぐっすり熟睡したいアナタへ【冒頭無料_KU100】.mp3 Apr 24 19:52:46 thinkpadhome volumio[10910]: 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 19:52:46 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/2023_09_02【耳舐めASMR】キス多め_夏休みの宿題やらない生徒vs担任巨乳女教師_ヒミツの居残り授業【冒頭無料KU100】.mp3 Apr 24 19:52:46 thinkpadhome volumio[10910]: 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 19:52:46 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/长城 Beyond.mp3 Apr 24 19:52:52 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 19:52:52 thinkpadhome volumio[10910]: info: CURURI: music-library/USB/系统/HIFI顶级人声测试碟-刘芳 Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/01. 青花瓷.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/02. 丁香花.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/03. 朋友别哭.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/04. 雨衹蝴蝶.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/06. 单身情歌.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/07. 回心转意.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/08. 窗外.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/09. 小薇.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/10. 我想我是海.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/11. 哭砂.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/12. 纸飞机.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/13. 千里之外.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/14. 东风破.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/15. 醉清风.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/01. 青花瓷.wav in service mpd Apr 24 19:52:52 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F01.%20%E9%9D%92%E8%8A%B1%E7%93%B7.wav&metadata=false Apr 24 19:52:52 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/01. 青花瓷.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/02. 丁香花.wav in service mpd Apr 24 19:52:52 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F02.%20%E4%B8%81%E9%A6%99%E8%8A%B1.wav&metadata=false Apr 24 19:52:52 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/02. 丁香花.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/03. 朋友别哭.wav in service mpd Apr 24 19:52:52 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F03.%20%E6%9C%8B%E5%8F%8B%E5%88%AB%E5%93%AD.wav&metadata=false Apr 24 19:52:52 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/03. 朋友别哭.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/04. 雨衹蝴蝶.wav in service mpd Apr 24 19:52:52 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F04.%20%E9%9B%A8%E8%A1%B9%E8%9D%B4%E8%9D%B6.wav&metadata=false Apr 24 19:52:52 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/04. 雨衹蝴蝶.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav in service mpd Apr 24 19:52:52 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F05.%20%E6%81%8B%E6%9B%B21990.wav&metadata=false Apr 24 19:52:52 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: MyVolumio login type: Token Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/06. 单身情歌.wav in service mpd Apr 24 19:52:52 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F06.%20%E5%8D%95%E8%BA%AB%E6%83%85%E6%AD%8C.wav&metadata=false Apr 24 19:52:52 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/06. 单身情歌.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/07. 回心转意.wav in service mpd Apr 24 19:52:52 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F07.%20%E5%9B%9E%E5%BF%83%E8%BD%AC%E6%84%8F.wav&metadata=false Apr 24 19:52:52 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/07. 回心转意.wav Apr 24 19:52:52 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/08. 窗外.wav in service mpd Apr 24 19:52:52 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F08.%20%E7%AA%97%E5%A4%96.wav&metadata=false Apr 24 19:52:52 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/08. 窗外.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/09. 小薇.wav in service mpd Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F09.%20%E5%B0%8F%E8%96%87.wav&metadata=false Apr 24 19:52:53 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/09. 小薇.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/10. 我想我是海.wav in service mpd Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F10.%20%E6%88%91%E6%83%B3%E6%88%91%E6%98%AF%E6%B5%B7.wav&metadata=false Apr 24 19:52:53 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/10. 我想我是海.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/11. 哭砂.wav in service mpd Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F11.%20%E5%93%AD%E7%A0%82.wav&metadata=false Apr 24 19:52:53 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/11. 哭砂.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/12. 纸飞机.wav in service mpd Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F12.%20%E7%BA%B8%E9%A3%9E%E6%9C%BA.wav&metadata=false Apr 24 19:52:53 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/12. 纸飞机.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/13. 千里之外.wav in service mpd Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F13.%20%E5%8D%83%E9%87%8C%E4%B9%8B%E5%A4%96.wav&metadata=false Apr 24 19:52:53 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/13. 千里之外.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/14. 东风破.wav in service mpd Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F14.%20%E4%B8%9C%E9%A3%8E%E7%A0%B4.wav&metadata=false Apr 24 19:52:53 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/14. 东风破.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-刘芳/15. 醉清风.wav in service mpd Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%EF%BF%BD%EF%BF%BD%EF%BF%BD%EF%BF%BD%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%88%98%E8%8A%B3%2F15.%20%E9%86%89%E6%B8%85%E9%A3%8E.wav&metadata=false Apr 24 19:52:53 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-刘芳/15. 醉清风.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::ClearQueue Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::clearPlayQueue Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/01. 青花瓷.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/01. 青花瓷.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/02. 丁香花.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/02. 丁香花.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/03. 朋友别哭.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/03. 朋友别哭.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/04. 雨衹蝴蝶.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/04. 雨衹蝴蝶.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPlay Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::play index 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/06. 单身情歌.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/06. 单身情歌.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/07. 回心转意.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/07. 回心转意.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/08. 窗外.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/08. 窗外.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/09. 小薇.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/09. 小薇.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/10. 我想我是海.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/10. 我想我是海.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/11. 哭砂.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/11. 哭砂.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/12. 纸飞机.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/12. 纸飞机.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/13. 千里之外.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/13. 千里之外.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/14. 东风破.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/14. 东风破.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/15. 醉清风.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-刘芳/15. 醉清风.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::play index undefined Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::startPlaybackTimer Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand stop took 2 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand clear took 0 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav" Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:53 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 3ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand add "USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav" took 2 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 2ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 2ms Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 3ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand play took 2 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 1ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 1ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand status took 2 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand status took 2 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand status took 2 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Apr 24 19:52:53 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand status took 4 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand status took 3 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand status took 3 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ��??1990","artist":"HI-FI ????????????????","album":"???????����?","uri":"USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav","trackType":"wav"} Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ��??1990","artist":"HI-FI ????????????????","album":"???????����?","uri":"USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav","trackType":"wav"} Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ��??1990","artist":"HI-FI ????????????????","album":"???????����?","uri":"USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav","trackType":"wav"} Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 20ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 33ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 33ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 27 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ��??1990","artist":"HI-FI ????????????????","album":"???????����?","uri":"USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav","trackType":"wav"} Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ��??1990","artist":"HI-FI ????????????????","album":"???????����?","uri":"USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav","trackType":"wav"} Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ��??1990","artist":"HI-FI ????????????????","album":"???????����?","uri":"USB/系统/HIFI顶级人声测试碟-刘芳/05. 恋曲1990.wav","trackType":"wav"} Apr 24 19:52:53 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:52:53 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:52:53 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 69ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 67ms Apr 24 19:52:53 thinkpadhome volumio[10910]: info: ------------------------------ 66ms Apr 24 19:53:15 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume45 Apr 24 19:53:15 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:15 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:15 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:15 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:21 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume- Apr 24 19:53:21 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:21 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:21 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:21 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:22 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume- Apr 24 19:53:22 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:22 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:22 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:22 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:22 thinkpadhome volumio[10910]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 24 19:53:22 thinkpadhome volumio[10910]: info: Retrying Login Due to Network Error Apr 24 19:53:23 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume- Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:23 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume- Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:23 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume- Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:23 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:23 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume- Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:24 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume- Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:24 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume- Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:24 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:24 thinkpadhome volumio[10910]: info: VolumeController::SetAlsaVolume- Apr 24 19:53:25 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:25 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:25 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:25 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:32 thinkpadhome volumio[10910]: info: MyVolumio login type: Token Apr 24 19:53:34 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 24 19:53:34 thinkpadhome volumio[10910]: info: CURURI: music-library/USB/系统/HIFI顶级人声测试碟-张学友 Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/01. 祝福.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/02. 吻别.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/03. 一千个伤心的理由.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/04. 楚歌（粤语）.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/06. 相思风雨中.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/07. 饿狼传说（粤语）.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/08. 一路上有你.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/09. 情网.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/10. 如果这都不算爱.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/11. 只想一生跟你走（粤语）.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/12. 等你等到我心痛.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/13. 想和你去吹吹风.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/14. 旧情绵绵（粤语）.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/15. 忘记你我做不到.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Preloading song: music-library/USB/系统/HIFI顶级人声测试碟-张学友/16. 分手总是在雨天（粤语）.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/01. 祝福.wav in service mpd Apr 24 19:53:34 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F01.%20%E7%A5%9D%E7%A6%8F.wav&metadata=false Apr 24 19:53:34 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/01. 祝福.wav Apr 24 19:53:34 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/02. 吻别.wav in service mpd Apr 24 19:53:34 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F02.%20%E5%90%BB%E5%88%AB.wav&metadata=false Apr 24 19:53:34 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/02. 吻别.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/03. 一千个伤心的理由.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F03.%20%E4%B8%80%E5%8D%83%E4%B8%AA%E4%BC%A4%E5%BF%83%E7%9A%84%E7%90%86%E7%94%B1.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/03. 一千个伤心的理由.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/04. 楚歌（粤语）.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F04.%20%E6%A5%9A%E6%AD%8C%EF%BC%88%E7%B2%A4%E8%AF%AD%EF%BC%89.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/04. 楚歌（粤语）.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F05.%20%E6%88%91%E7%AD%89%E5%88%B0%E8%8A%B1%E5%84%BF%E4%B9%9F%E8%B0%A2%E4%BA%86.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/06. 相思风雨中.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F06.%20%E7%9B%B8%E6%80%9D%E9%A3%8E%E9%9B%A8%E4%B8%AD.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/06. 相思风雨中.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/07. 饿狼传说（粤语）.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F07.%20%E9%A5%BF%E7%8B%BC%E4%BC%A0%E8%AF%B4%EF%BC%88%E7%B2%A4%E8%AF%AD%EF%BC%89.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/07. 饿狼传说（粤语）.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/08. 一路上有你.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F08.%20%E4%B8%80%E8%B7%AF%E4%B8%8A%E6%9C%89%E4%BD%A0.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/08. 一路上有你.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/09. 情网.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F09.%20%E6%83%85%E7%BD%91.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/09. 情网.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/10. 如果这都不算爱.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F10.%20%E5%A6%82%E6%9E%9C%E8%BF%99%E9%83%BD%E4%B8%8D%E7%AE%97%E7%88%B1.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/10. 如果这都不算爱.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/11. 只想一生跟你走（粤语）.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F11.%20%E5%8F%AA%E6%83%B3%E4%B8%80%E7%94%9F%E8%B7%9F%E4%BD%A0%E8%B5%B0%EF%BC%88%E7%B2%A4%E8%AF%AD%EF%BC%89.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/11. 只想一生跟你走（粤语）.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/12. 等你等到我心痛.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F12.%20%E7%AD%89%E4%BD%A0%E7%AD%89%E5%88%B0%E6%88%91%E5%BF%83%E7%97%9B.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/12. 等你等到我心痛.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/13. 想和你去吹吹风.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F13.%20%E6%83%B3%E5%92%8C%E4%BD%A0%E5%8E%BB%E5%90%B9%E5%90%B9%E9%A3%8E.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/13. 想和你去吹吹风.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/14. 旧情绵绵（粤语）.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F14.%20%E6%97%A7%E6%83%85%E7%BB%B5%E7%BB%B5%EF%BC%88%E7%B2%A4%E8%AF%AD%EF%BC%89.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/14. 旧情绵绵（粤语）.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/15. 忘记你我做不到.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F15.%20%E5%BF%98%E8%AE%B0%E4%BD%A0%E6%88%91%E5%81%9A%E4%B8%8D%E5%88%B0.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/15. 忘记你我做不到.wav Apr 24 19:53:35 thinkpadhome volumio[10910]: info: Exploding uri music-library/USB/系统/HIFI顶级人声测试碟-张学友/16. 分手总是在雨天（粤语）.wav in service mpd Apr 24 19:53:35 thinkpadhome volumio[10910]: info: ALBUMART /albumart?cacheid=881&web=HI-FI%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%3F%3F%3F%3F%3F%D1%A7%3F%3FDXD%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2FHIFI%E9%A1%B6%E7%BA%A7%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E7%A2%9F-%E5%BC%A0%E5%AD%A6%E5%8F%8B%2F16.%20%E5%88%86%E6%89%8B%E6%80%BB%E6%98%AF%E5%9C%A8%E9%9B%A8%E5%A4%A9%EF%BC%88%E7%B2%A4%E8%AF%AD%EF%BC%89.wav&metadata=false Apr 24 19:53:35 thinkpadhome volumio[10910]: info: URI /mnt/USB/系统/HIFI顶级人声测试碟-张学友/16. 分手总是在雨天（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::ClearQueue Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::stPlaybackTimer Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::serviceStop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::serviceStop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::stop Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::clearPlayQueue Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/01. 祝福.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/01. 祝福.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/02. 吻别.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/02. 吻别.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/03. 一千个伤心的理由.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/03. 一千个伤心的理由.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/04. 楚歌（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/04. 楚歌（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPlay Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::play index 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::addQueueItems Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::addQueueItems Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Preload queue cleared Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/06. 相思风雨中.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/06. 相思风雨中.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/07. 饿狼传说（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/07. 饿狼传说（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/08. 一路上有你.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/08. 一路上有你.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/09. 情网.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/09. 情网.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/10. 如果这都不算爱.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/10. 如果这都不算爱.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/11. 只想一生跟你走（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/11. 只想一生跟你走（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/12. 等你等到我心痛.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/12. 等你等到我心痛.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/13. 想和你去吹吹风.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/13. 想和你去吹吹风.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/14. 旧情绵绵（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/14. 旧情绵绵（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/15. 忘记你我做不到.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/15. 忘记你我做不到.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Adding Item to queue: music-library/USB/系统/HIFI顶级人声测试碟-张学友/16. 分手总是在雨天（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Using cached record of: music-library/USB/系统/HIFI顶级人声测试碟-张学友/16. 分手总是在雨天（粤语）.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::stop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushQueue Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::saveQueue Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::play index undefined Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::updateTrackBlock Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrackBlock Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::startPlaybackTimer Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand stop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand stop took 25 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand stop took 3 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand clear Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand status took 3 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand clear took 2 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand status took 1 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand status took 2 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav" Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: 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 19:53:36 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: No code Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: 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 19:53:36 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService stop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: No code Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 46ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 46ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:53:36 thinkpadhome volumio[10910]: error: updateQueue error: null Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 59ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 59 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand add "USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav" took 59 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 14ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 12ms Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand play Apr 24 19:53:36 thinkpadhome volumio[10910]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 65ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces system playlist update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Ignoring MPD Status Update Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 34ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand play took 33 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 28ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 27ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand status took 3 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand status took 2 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Apr 24 19:53:36 thinkpadhome volumio[10910]: ---------------------------- MPD announces state update: player Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::getState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand status Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand status took 115 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 113 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 109 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 109 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand status took 108 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand status took 106 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseState Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":324,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ?ҵȵ?????Ҳл??","artist":"HI-FI ????????????????","album":"??????ѧ??DXD??","uri":"USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav","trackType":"wav"} Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus stop Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":324,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ?ҵȵ?????Ҳл??","artist":"HI-FI ????????????????","album":"??????ѧ??DXD??","uri":"USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav","trackType":"wav"} Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":324,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ?ҵȵ?????Ҳл??","artist":"HI-FI ????????????????","album":"??????ѧ??DXD??","uri":"USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav","trackType":"wav"} Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 135ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 143ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 142ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 25 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: info: sendMpdCommand playlistinfo took 25 milliseconds Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: ControllerMpd::parseTrackInfo Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":324,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ?ҵȵ?????Ҳл??","artist":"HI-FI ????????????????","album":"??????ѧ??DXD??","uri":"USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav","trackType":"wav"} Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":324,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ?ҵȵ?????Ҳл??","artist":"HI-FI ????????????????","album":"??????ѧ??DXD??","uri":"USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav","trackType":"wav"} Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ControllerMpd::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::servicePushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":324,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"05. ?ҵȵ?????Ҳл??","artist":"HI-FI ????????????????","album":"??????ѧ??DXD??","uri":"USB/系统/HIFI顶级人声测试碟-张学友/05. 我等到花儿也谢了.wav","trackType":"wav"} Apr 24 19:53:36 thinkpadhome volumio[10910]: verbose: CURRENT POSITION 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState stateService play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::syncState currentStatus play Apr 24 19:53:36 thinkpadhome volumio[10910]: info: Received an update from plugin. extracting info from payload Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreStateMachine::pushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CorePlayQueue::getTrack 4 Apr 24 19:53:36 thinkpadhome volumio[10910]: info: CoreCommandRouter::volumioPushState Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 181ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 172ms Apr 24 19:53:36 thinkpadhome volumio[10910]: info: ------------------------------ 172ms Apr 24 19:53:41 thinkpadhome volumio[10910]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 19:53:41 thinkpadhome volumio[10910]: Error: connect ETIMEDOUT 31.13.94.23:80 Apr 24 19:53:41 thinkpadhome volumio[10910]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Apr 24 19:53:41 thinkpadhome volumio[10910]: errno: -110, Apr 24 19:53:41 thinkpadhome volumio[10910]: code: 'ETIMEDOUT', Apr 24 19:53:41 thinkpadhome volumio[10910]: syscall: 'connect', Apr 24 19:53:41 thinkpadhome volumio[10910]: address: '31.13.94.23', Apr 24 19:53:41 thinkpadhome volumio[10910]: port: 80 Apr 24 19:53:41 thinkpadhome volumio[10910]: } Apr 24 19:53:41 thinkpadhome volumio[10910]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 19:53:41 thinkpadhome sudo[11515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-24 19:52 Apr 24 19:53:41 thinkpadhome sudo[11515]: 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"