-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Wed 2026-02-18 21:28:56 CST. -- Feb 18 21:27:01 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:01 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:05 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:05 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:09 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:09 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:13 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:13 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:21 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:21 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:25 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:25 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:30 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:30 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:31 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:31 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:34 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:34 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:38 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:38 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:42 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:42 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:46 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:46 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:50 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:50 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:54 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:54 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:27:58 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:27:58 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:28:02 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:28:02 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 2 Feb 18 21:28:02 volumio-test2 volumio[1246]: info: Prefetching next song Feb 18 21:28:02 volumio-test2 volumio[1246]: info: DOING PREFETCH IN MPD Feb 18 21:28:02 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Oblivion 2013/03 Tech 49.mp3" Feb 18 21:28:02 volumio-test2 volumio[1246]: info: sendMpdCommand add "NAS/NAS/Oblivion 2013/03 Tech 49.mp3" took 1 milliseconds Feb 18 21:28:02 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 18 21:28:02 volumio-test2 volumio[1246]: info: Feb 18 21:28:02 volumio-test2 volumio[1246]: ---------------------------- MPD announces system playlist update Feb 18 21:28:02 volumio-test2 volumio[1246]: info: Ignoring MPD Status Update Feb 18 21:28:02 volumio-test2 volumio[1246]: info: sendMpdCommand consume 1 took 2 milliseconds Feb 18 21:28:02 volumio-test2 volumio[1246]: info: ------------------------------ 2ms Feb 18 21:28:03 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:03 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:28:03 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:03 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:28:06 volumio-test2 sshd[2300]: pam_unix(sshd:session): session closed for user volumio Feb 18 21:28:06 volumio-test2 systemd[1]: session-c1.scope: Succeeded. Feb 18 21:28:06 volumio-test2 systemd-logind[561]: Session c1 logged out. Waiting for processes to exit. Feb 18 21:28:06 volumio-test2 systemd-logind[561]: Removed session c1. Feb 18 21:28:07 volumio-test2 volumio[1246]: info: Feb 18 21:28:07 volumio-test2 volumio[1246]: ---------------------------- MPD announces system playlist update Feb 18 21:28:07 volumio-test2 volumio[1246]: info: Ignoring MPD Status Update Feb 18 21:28:07 volumio-test2 volumio[1246]: info: Feb 18 21:28:07 volumio-test2 volumio[1246]: ---------------------------- MPD announces state update: player Feb 18 21:28:07 volumio-test2 volumio[1246]: info: ControllerMpd::getState Feb 18 21:28:07 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand status Feb 18 21:28:07 volumio-test2 volumio[1246]: info: ------------------------------ 2ms Feb 18 21:28:07 volumio-test2 volumio[1246]: info: sendMpdCommand status took 1 milliseconds Feb 18 21:28:07 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseState Feb 18 21:28:07 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 21:28:07 volumio-test2 volumio[1246]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 18 21:28:07 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseTrackInfo Feb 18 21:28:07 volumio-test2 volumio[1246]: info: ControllerMpd::pushState Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreCommandRouter::servicePushState Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:28:07 volumio-test2 volumio[1246]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":359,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Oblivion 2013- 03 Tech 49","artist":"M83","album":"Oblivion 2013","uri":"NAS/NAS/Oblivion 2013/03 Tech 49.mp3","trackType":"mp3"} Feb 18 21:28:07 volumio-test2 volumio[1246]: verbose: CURRENT POSITION 1 Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreStateMachine::syncState stateService play Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreStateMachine::syncState currentStatus play Feb 18 21:28:07 volumio-test2 volumio[1246]: info: Received an update from plugin. extracting info from payload Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreStateMachine::pushState Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioPushState Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreStateMachine::pushState Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioPushState Feb 18 21:28:07 volumio-test2 volumio[1246]: info: ------------------------------ 36ms Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 1 Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreStateMachine::startPlaybackTimer Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 2 Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreStateMachine::pushState Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 2 Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 21:28:07 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioPushState Feb 18 21:28:11 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:11 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 2 Feb 18 21:28:13 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:13 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 2 Feb 18 21:28:15 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:15 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 2 Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioPlay Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::play index 19 Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::stop Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::stPlaybackTimer Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::updateTrackBlock Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrackBlock Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::pushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 2 Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioPushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::serviceStop Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 2 Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::serviceStop Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ControllerMpd::stop Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand stop took 23 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::play index undefined Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::startPlaybackTimer Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Oblivion (Original Motion Picture Soundtrack) in one/Oblivion complete OST.mp3 Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 21:28:17 volumio-test2 volumio[1246]: info: Feb 18 21:28:17 volumio-test2 volumio[1246]: ---------------------------- MPD announces state update: player Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ControllerMpd::getState Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand status Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand stop took 3 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand status took 1 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand clear Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseState Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 21:28:17 volumio-test2 volumio[1246]: info: Feb 18 21:28:17 volumio-test2 volumio[1246]: ---------------------------- MPD announces system playlist update Feb 18 21:28:17 volumio-test2 volumio[1246]: info: Ignoring MPD Status Update Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand clear took 1 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Oblivion (Original Motion Picture Soundtrack) in one/Oblivion complete OST.mp3" Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseTrackInfo Feb 18 21:28:17 volumio-test2 volumio[1246]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ------------------------------ 6ms Feb 18 21:28:17 volumio-test2 volumio[1246]: error: updateQueue error: null Feb 18 21:28:17 volumio-test2 volumio[1246]: info: Feb 18 21:28:17 volumio-test2 volumio[1246]: ---------------------------- MPD announces system playlist update Feb 18 21:28:17 volumio-test2 volumio[1246]: info: Ignoring MPD Status Update Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ------------------------------ 4ms Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand add "NAS/NAS/Oblivion (Original Motion Picture Soundtrack) in one/Oblivion complete OST.mp3" took 3 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand play Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ------------------------------ 3ms Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand play took 1 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: info: Feb 18 21:28:17 volumio-test2 volumio[1246]: ---------------------------- MPD announces state update: player Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ControllerMpd::getState Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand status Feb 18 21:28:17 volumio-test2 volumio[1246]: info: Feb 18 21:28:17 volumio-test2 volumio[1246]: ---------------------------- MPD announces state update: player Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand status took 5 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ControllerMpd::getState Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand status Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseState Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand status took 2 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseState Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseTrackInfo Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ControllerMpd::pushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::servicePushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":6834,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Oblivion complete OST","artist":"M83","album":"Oblivion 遺落戰境","uri":"NAS/NAS/Oblivion (Original Motion Picture Soundtrack) in one/Oblivion complete OST.mp3","trackType":"mp3"} Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: CURRENT POSITION 19 Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::syncState stateService play Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::syncState currentStatus stop Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ------------------------------ 23ms Feb 18 21:28:17 volumio-test2 volumio[1246]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseTrackInfo Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ControllerMpd::pushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::servicePushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":6834,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Oblivion complete OST","artist":"M83","album":"Oblivion 遺落戰境","uri":"NAS/NAS/Oblivion (Original Motion Picture Soundtrack) in one/Oblivion complete OST.mp3","trackType":"mp3"} Feb 18 21:28:17 volumio-test2 volumio[1246]: verbose: CURRENT POSITION 19 Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::syncState stateService play Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::syncState currentStatus play Feb 18 21:28:17 volumio-test2 volumio[1246]: info: Received an update from plugin. extracting info from payload Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::pushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioPushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreStateMachine::pushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:17 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioPushState Feb 18 21:28:17 volumio-test2 volumio[1246]: info: ------------------------------ 56ms Feb 18 21:28:19 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:19 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:23 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:23 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:27 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:27 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:32 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:32 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:36 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:36 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:39 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:39 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:40 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:40 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:44 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:44 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:48 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:48 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:51 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:51 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:52 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioGetState Feb 18 21:28:52 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioPause Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreStateMachine::pause Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreStateMachine::stPlaybackTimer Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreStateMachine::servicePause Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreCommandRouter::servicePause Feb 18 21:28:56 volumio-test2 volumio[1246]: info: ControllerMpd::pause Feb 18 21:28:56 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand pause Feb 18 21:28:56 volumio-test2 volumio[1246]: info: sendMpdCommand pause took 1 milliseconds Feb 18 21:28:56 volumio-test2 volumio[1246]: info: Feb 18 21:28:56 volumio-test2 volumio[1246]: ---------------------------- MPD announces state update: player Feb 18 21:28:56 volumio-test2 volumio[1246]: info: ControllerMpd::getState Feb 18 21:28:56 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand status Feb 18 21:28:56 volumio-test2 volumio[1246]: info: sendMpdCommand status took 0 milliseconds Feb 18 21:28:56 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseState Feb 18 21:28:56 volumio-test2 volumio[1246]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 21:28:56 volumio-test2 volumio[1246]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 18 21:28:56 volumio-test2 volumio[1246]: verbose: ControllerMpd::parseTrackInfo Feb 18 21:28:56 volumio-test2 volumio[1246]: info: ControllerMpd::pushState Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreCommandRouter::servicePushState Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:56 volumio-test2 volumio[1246]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":39196,"duration":6834,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Oblivion complete OST","artist":"M83","album":"Oblivion 遺落戰境","uri":"NAS/NAS/Oblivion (Original Motion Picture Soundtrack) in one/Oblivion complete OST.mp3","trackType":"mp3"} Feb 18 21:28:56 volumio-test2 volumio[1246]: verbose: CURRENT POSITION 19 Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreStateMachine::syncState stateService pause Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreStateMachine::syncState currentStatus pause Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreStateMachine::pushState Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CorePlayQueue::getTrack 19 Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreCommandRouter::volumioPushState Feb 18 21:28:56 volumio-test2 volumio[1246]: info: CoreStateMachine::stPlaybackTimer Feb 18 21:28:56 volumio-test2 volumio[1246]: info: ------------------------------ 24ms Feb 18 21:28:56 volumio-test2 volumio[1246]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 21:28:56 volumio-test2 volumio[1246]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Feb 18 21:28:56 volumio-test2 volumio[1246]: at Object.readdirSync (fs.js:1048:3) Feb 18 21:28:56 volumio-test2 volumio[1246]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Feb 18 21:28:56 volumio-test2 volumio[1246]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Feb 18 21:28:56 volumio-test2 volumio[1246]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Feb 18 21:28:56 volumio-test2 volumio[1246]: errno: -20, Feb 18 21:28:56 volumio-test2 volumio[1246]: syscall: 'scandir', Feb 18 21:28:56 volumio-test2 volumio[1246]: code: 'ENOTDIR', Feb 18 21:28:56 volumio-test2 volumio[1246]: path: '/tmp/peppyrunning' Feb 18 21:28:56 volumio-test2 volumio[1246]: } Feb 18 21:28:56 volumio-test2 volumio[1246]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 21:28:56 volumio-test2 sudo[5091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-18 21:27 Feb 18 21:28:56 volumio-test2 sudo[5091]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:55:15 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="2f3686ade78abf3b92c180a0c5b20c6b"