Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioAddQueueItems Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: CoreStateMachine::addQueueItems Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: CorePlayQueue::addQueueItems Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: Preload queue cleared Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: Adding Item to queue: music-library/NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: Using cached record of: music-library/NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushQueue Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: CorePlayQueue::saveQueue Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: CoreStateMachine::updateTrackBlock Apr 13 23:22:10 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrackBlock Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 2 Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Prefetching next song Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: DOING PREFETCH IN MPD Apr 13 23:22:19 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS2024/Music3/童丽/童 丽-独家爱唱7 DFF/02.红蔷薇.dff" Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Apr 13 23:22:19 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: sendMpdCommand add "NAS/NAS2024/Music3/童丽/童 丽-独家爱唱7 DFF/02.红蔷薇.dff" took 2 milliseconds Apr 13 23:22:19 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Apr 13 23:22:19 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Apr 13 23:22:19 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Apr 13 23:22:19 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Apr 13 23:22:19 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: ------------------------------ 7ms Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: sendMpdCommand consume 1 took 6 milliseconds Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: ------------------------------ 5ms Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: ------------------------------ 2ms Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: ------------------------------ 2ms Apr 13 23:22:19 volumio4-x86 volumio[9687]: info: ------------------------------ 2ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Apr 13 23:22:23 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 6ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 5 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 4ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 4 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 4ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 3 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 3ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 3 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 3ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 3 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28,"duration":222,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"02.红蔷薇.dff","artist":null,"album":null,"uri":"NAS/NAS2024/Music3/童丽/童 丽-独家爱唱7 DFF/02.红蔷薇.dff","trackType":"dff"} Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28,"duration":222,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"02.红蔷薇.dff","artist":null,"album":null,"uri":"NAS/NAS2024/Music3/童丽/童 丽-独家爱唱7 DFF/02.红蔷薇.dff","trackType":"dff"} Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28,"duration":222,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"02.红蔷薇.dff","artist":null,"album":null,"uri":"NAS/NAS2024/Music3/童丽/童 丽-独家爱唱7 DFF/02.红蔷薇.dff","trackType":"dff"} Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28,"duration":222,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"02.红蔷薇.dff","artist":null,"album":null,"uri":"NAS/NAS2024/Music3/童丽/童 丽-独家爱唱7 DFF/02.红蔷薇.dff","trackType":"dff"} Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28,"duration":222,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"02.红蔷薇.dff","artist":null,"album":null,"uri":"NAS/NAS2024/Music3/童丽/童 丽-独家爱唱7 DFF/02.红蔷薇.dff","trackType":"dff"} Apr 13 23:22:23 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 1 Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 90ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 90ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 91ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 91ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: ------------------------------ 92ms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:23 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: CoreStateMachine::startPlaybackTimer Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 2 Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 2 Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:24 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:26 volumio4-x86 volumio[9687]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 13 23:22:26 volumio4-x86 volumio[9687]: info: Retrying Login Due to Network Error Apr 13 23:22:36 volumio4-x86 volumio[9687]: info: MyVolumio login type: Token Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPlay Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::play index 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::stop Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::stPlaybackTimer Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::updateTrackBlock Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrackBlock Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 2 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::serviceStop Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 2 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::serviceStop Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::stop Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=stop service=mpd volatile=false Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand stop took 24 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::play index undefined Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::startPlaybackTimer Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 8 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand stop took 4 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 3 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 2 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 1 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 2 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand clear Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand clear took 2 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf" Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: 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":"02.红蔷薇.dff","artist":null,"album":null,"uri":"NAS/NAS2024/Music3/童丽/童 丽-独家爱唱7 DFF/02.红蔷薇.dff","trackType":"dff"} Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService stop Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus stop Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: No code Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Apr 13 23:22:37 volumio4-x86 volumio[9687]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 35ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 29ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 28ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: error: updateQueue error: null Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 26ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand add "NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf" took 25 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand play Apr 13 23:22:37 volumio4-x86 volumio[9687]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Apr 13 23:22:37 volumio4-x86 volumio[9687]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 32ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 31ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=stop service=mpd volatile=false Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=stop service=mpd volatile=false Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=stop service=mpd volatile=false Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 19ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 20ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 19ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 19ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 18ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand play took 17 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces system playlist update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Ignoring MPD Status Update Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 3ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 2ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 2ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 1ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 9 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 9 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 11 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 12 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 19 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 19 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 18 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 17 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 17 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus stop Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 58ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ------------------------------ 75ms Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Apr 13 23:22:37 volumio4-x86 volumio[9687]: ---------------------------- MPD announces state update: player Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::getState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand status Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 99 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 100 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 100 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 100 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 100 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 101 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 101 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: sendMpdCommand status took 50 milliseconds Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseState Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:37 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:37 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:38 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:38 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ------------------------------ 242ms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ------------------------------ 237ms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ------------------------------ 237ms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ------------------------------ 236ms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ------------------------------ 236ms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ------------------------------ 235ms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ------------------------------ 235ms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: sendMpdCommand playlistinfo took 467 milliseconds Apr 13 23:22:38 volumio4-x86 volumio[9687]: verbose: ControllerMpd::parseTrackInfo Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ControllerMpd::pushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreCommandRouter::servicePushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:38 volumio4-x86 volumio[9687]: verbose: STATE SERVICE {"status":"play","position":0,"seek":427,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"1 Year After 1 Year","artist":"Tsai Chin","album":"Tsai Chin Lao Ge","uri":"NAS/NAS2024/Music3/蔡 琴-专辑/老歌/Album/09 - Tsai Chin - 1 Year After 1 Year.dsf","trackType":"dsf"} Apr 13 23:22:38 volumio4-x86 volumio[9687]: verbose: CURRENT POSITION 4 Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState stateService play Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreStateMachine::syncState currentStatus play Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Received an update from plugin. extracting info from payload Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreStateMachine::pushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioPushState Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: ------------------------------ 538ms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- → Wakeup triggered Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: info: Display-configuration --- wakeupScreen: DPMS - screen on Apr 13 23:22:38 volumio4-x86 volumio[9687]: (node:9687) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 close listeners added to [TLSSocket]. Use emitter.setMaxListeners() to increase limit Apr 13 23:22:39 volumio4-x86 volumio[9687]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: unknown Engine version: 4 Transport: websocket Total Clients: 9 Apr 13 23:22:39 volumio4-x86 volumio[9687]: info: peppy_screensaver: Start PeppyMeter Apr 13 23:22:45 volumio4-x86 volumio[9687]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: unknown Engine version: 4 Transport: websocket Total Clients: 9 Apr 13 23:22:45 volumio4-x86 volumio[9687]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: unknown Engine version: 4 Transport: websocket Total Clients: 9 Apr 13 23:22:45 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioGetState Apr 13 23:22:45 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:53 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 23:22:53 volumio4-x86 volumio[9687]: info: Received Get System Info Apr 13 23:22:53 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 23:22:53 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 23:22:53 volumio4-x86 volumio[9687]: info: Discovery: Getting this device information Apr 13 23:22:53 volumio4-x86 volumio[9687]: info: CoreCommandRouter::volumioGetState Apr 13 23:22:53 volumio4-x86 volumio[9687]: info: CorePlayQueue::getTrack 4 Apr 13 23:22:53 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 13 23:22:57 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 13 23:23:06 volumio4-x86 volumio[9687]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 13 23:23:06 volumio4-x86 volumio[9687]: info: Retrying Login Due to Network Error Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 23:23:07 volumio4-x86 sudo[12790]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 23:23:07 volumio4-x86 sudo[12790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 23:23:07 volumio4-x86 sudo[12790]: pam_unix(sudo:session): session closed for user root Apr 13 23:23:07 volumio4-x86 sudo[12792]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 23:23:07 volumio4-x86 sudo[12792]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 23:23:07 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 13 23:23:08 volumio4-x86 volumio[9687]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 23:23:08 volumio4-x86 volumio[9687]: info: MPD Permissions set Apr 13 23:23:08 volumio4-x86 systemd[1]: Stopping mpd.service - Music Player Daemon... Apr 13 23:23:08 volumio4-x86 systemd[1]: mpd.service: Deactivated successfully. Apr 13 23:23:08 volumio4-x86 systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 13 23:23:08 volumio4-x86 systemd[1]: mpd.service: Consumed 50.524s CPU time. Apr 13 23:23:08 volumio4-x86 systemd[1]: mpd.socket: Deactivated successfully. Apr 13 23:23:08 volumio4-x86 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 13 23:23:08 volumio4-x86 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 13 23:23:08 volumio4-x86 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 13 23:23:08 volumio4-x86 systemd[1]: Starting mpd.service - Music Player Daemon... Apr 13 23:23:08 volumio4-x86 sudo[12806]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 13 23:23:08 volumio4-x86 sudo[12806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 13 23:23:08 volumio4-x86 sudo[12806]: pam_unix(sudo:session): session closed for user root Apr 13 23:23:08 volumio4-x86 mpd[12808]: 2026-04-13T23:23:08 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 13 23:23:09 volumio4-x86 systemd[1]: Started mpd.service - Music Player Daemon. Apr 13 23:23:09 volumio4-x86 sudo[12792]: pam_unix(sudo:session): session closed for user root Apr 13 23:23:09 volumio4-x86 volumio[9687]: error: updateQueue error: null Apr 13 23:23:11 volumio4-x86 volumio[9687]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 23:23:11 volumio4-x86 volumio[9687]: Error: connect ETIMEDOUT 185.60.216.169:80 Apr 13 23:23:11 volumio4-x86 volumio[9687]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Apr 13 23:23:11 volumio4-x86 volumio[9687]: errno: -110, Apr 13 23:23:11 volumio4-x86 volumio[9687]: code: 'ETIMEDOUT', Apr 13 23:23:11 volumio4-x86 volumio[9687]: syscall: 'connect', Apr 13 23:23:11 volumio4-x86 volumio[9687]: address: '185.60.216.169', Apr 13 23:23:11 volumio4-x86 volumio[9687]: port: 80 Apr 13 23:23:11 volumio4-x86 volumio[9687]: } Apr 13 23:23:11 volumio4-x86 volumio[9687]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 23:23:11 volumio4-x86 sudo[12831]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-13 23:22' Apr 13 23:23:11 volumio4-x86 sudo[12831]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"