-- Logs begin at Tue 2025-05-13 11:39:44 CST, end at Tue 2025-05-13 11:52:35 CST. -- May 13 11:51:00 volumio-x86 volumio[1052]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 May 13 11:51:00 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioGetState May 13 11:51:00 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 16 May 13 11:51:02 volumio-x86 volumio[1052]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 13 11:51:02 volumio-x86 volumio[1052]: info: Retrying Login Due to Network Error May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPlay May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::play index 52 May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::stop May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::stPlaybackTimer May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::updateTrackBlock May 13 11:51:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrackBlock May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 16 May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::serviceStop May 13 11:51:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 16 May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::serviceStop May 13 11:51:11 volumio-x86 volumio[1052]: info: ControllerMpd::stop May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 24 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::play index undefined May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:51:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::startPlaybackTimer May 13 11:51:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::clearAddPlayTracks USB/王杰/王杰 - 街灯.flac May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:51:11 volumio-x86 volumio[1052]: info: May 13 11:51:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:51:11 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 2 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand clear May 13 11:51:11 volumio-x86 volumio[1052]: info: May 13 11:51:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:51:11 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand status took 4 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand clear took 3 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand add "USB/王杰/王杰 - 街灯.flac" May 13 11:51:11 volumio-x86 volumio[1052]: error: updateQueue error: null May 13 11:51:11 volumio-x86 volumio[1052]: info: May 13 11:51:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:51:11 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:51:11 volumio-x86 volumio[1052]: info: ------------------------------ 5ms May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 3 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand add "USB/王杰/王杰 - 街灯.flac" took 3 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand play May 13 11:51:11 volumio-x86 volumio[1052]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 13 11:51:11 volumio-x86 volumio[1052]: info: ------------------------------ 12ms May 13 11:51:11 volumio-x86 volumio[1052]: info: ------------------------------ 8ms May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand play took 5 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: info: May 13 11:51:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:51:11 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:51:11 volumio-x86 volumio[1052]: info: May 13 11:51:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand status took 10 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand status took 5 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 4 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:51:11 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:51:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:11 volumio-x86 volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"王杰 - 街灯.flac","artist":null,"album":null,"uri":"USB/王杰/王杰 - 街灯.flac","trackType":"flac"} May 13 11:51:11 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 52 May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService play May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus stop May 13 11:51:11 volumio-x86 volumio[1052]: info: ------------------------------ 22ms May 13 11:51:11 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 5 milliseconds May 13 11:51:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:51:11 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:51:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:11 volumio-x86 volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":614,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"361 Kbps","isStreaming":false,"title":"王杰 - 街灯.flac","artist":null,"album":null,"uri":"USB/王杰/王杰 - 街灯.flac","trackType":"flac"} May 13 11:51:11 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 52 May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService play May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus play May 13 11:51:11 volumio-x86 volumio[1052]: info: Received an update from plugin. extracting info from payload May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:11 volumio-x86 volumio[1052]: info: ------------------------------ 77ms May 13 11:51:12 volumio-x86 volumio[1052]: info: MyVolumio login type: Token May 13 11:51:12 volumio-x86 volumio[1052]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 May 13 11:51:12 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioGetState May 13 11:51:12 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:16 volumio-x86 volumio[1052]: info: VolumeController::SetAlsaVolume64 May 13 11:51:16 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:16 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:16 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:51:16 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:17 volumio-x86 volumio[1052]: info: VolumeController::SetAlsaVolume85 May 13 11:51:17 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:17 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:17 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:51:17 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:19 volumio-x86 ntpd[1041]: 45.76.221.157 local addr 192.168.254.195 -> May 13 11:51:24 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 13 11:51:24 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 13 11:51:24 volumio-x86 volumio[1052]: info: Discovery: Getting this device information May 13 11:51:24 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioGetState May 13 11:51:24 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:24 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 13 11:51:25 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioMoveQueue May 13 11:51:25 volumio-x86 volumio[1052]: info: CoreStateMachine::moveQueueItem 46 46 May 13 11:51:25 volumio-x86 volumio[1052]: info: CorePlayQueue::moveQueueItem 46 --> 46 May 13 11:51:25 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushQueue May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPlay May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::play index 38 May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::stop May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::stPlaybackTimer May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::updateTrackBlock May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrackBlock May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::serviceStop May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 52 May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::serviceStop May 13 11:51:34 volumio-x86 volumio[1052]: info: ControllerMpd::stop May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:51:34 volumio-x86 volumio[1052]: info: May 13 11:51:34 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:51:34 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 47 milliseconds May 13 11:51:34 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::play index undefined May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::startPlaybackTimer May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::clearAddPlayTracks USB/王杰/王杰 - 忘记你不如忘记自己.flac May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:51:34 volumio-x86 volumio[1052]: info: sendMpdCommand status took 4 milliseconds May 13 11:51:34 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 2 milliseconds May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand clear May 13 11:51:34 volumio-x86 volumio[1052]: info: May 13 11:51:34 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:51:34 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:51:34 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 6 milliseconds May 13 11:51:34 volumio-x86 volumio[1052]: info: sendMpdCommand clear took 6 milliseconds May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand add "USB/王杰/王杰 - 忘记你不如忘记自己.flac" May 13 11:51:34 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:34 volumio-x86 volumio[1052]: 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":"王杰 - 街灯.flac","artist":null,"album":null,"uri":"USB/王杰/王杰 - 街灯.flac","trackType":"flac"} May 13 11:51:34 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 38 May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService stop May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus stop May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:34 volumio-x86 volumio[1052]: info: No code May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:34 volumio-x86 volumio[1052]: info: ------------------------------ 77ms May 13 11:51:34 volumio-x86 volumio[1052]: error: updateQueue error: null May 13 11:51:34 volumio-x86 volumio[1052]: info: May 13 11:51:34 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:51:34 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:51:34 volumio-x86 volumio[1052]: info: ------------------------------ 69ms May 13 11:51:34 volumio-x86 volumio[1052]: info: sendMpdCommand add "USB/王杰/王杰 - 忘记你不如忘记自己.flac" took 67 milliseconds May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand play May 13 11:51:34 volumio-x86 volumio[1052]: info: May 13 11:51:34 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:51:34 volumio-x86 volumio[1052]: info: ------------------------------ 21ms May 13 11:51:34 volumio-x86 volumio[1052]: info: sendMpdCommand play took 21 milliseconds May 13 11:51:34 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:51:34 volumio-x86 volumio[1052]: info: sendMpdCommand status took 3 milliseconds May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:51:34 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 10 milliseconds May 13 11:51:34 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:51:34 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:51:34 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:34 volumio-x86 volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"王杰 - 忘记你不如忘记自己.flac","artist":null,"album":null,"uri":"USB/王杰/王杰 - 忘记你不如忘记自己.flac","trackType":"flac"} May 13 11:51:34 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 38 May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService play May 13 11:51:34 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus stop May 13 11:51:34 volumio-x86 volumio[1052]: info: ------------------------------ 20ms May 13 11:51:38 volumio-x86 volumio[1052]: info: VolumeController::SetAlsaVolume93 May 13 11:51:38 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:38 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:38 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:51:38 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:38 volumio-x86 volumio[1052]: info: VolumeController::SetAlsaVolume94 May 13 11:51:38 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:51:38 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:38 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:51:38 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:51:42 volumio-x86 volumio[1052]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 13 11:51:42 volumio-x86 volumio[1052]: info: Retrying Login Due to Network Error May 13 11:51:52 volumio-x86 volumio[1052]: info: MyVolumio login type: Token May 13 11:51:54 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 13 11:51:54 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 13 11:51:54 volumio-x86 volumio[1052]: info: Discovery: Getting this device information May 13 11:51:54 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioGetState May 13 11:51:54 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:51:54 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPlay May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::play index 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::stop May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::stPlaybackTimer May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::updateTrackBlock May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrackBlock May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::serviceStop May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 38 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::serviceStop May 13 11:52:11 volumio-x86 volumio[1052]: info: ControllerMpd::stop May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:52:11 volumio-x86 volumio[1052]: info: May 13 11:52:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 23 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::play index undefined May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::startPlaybackTimer May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::clearAddPlayTracks USB/王杰/王杰 - 忘了你,忘了我.flac May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand status took 4 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 2 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand clear May 13 11:52:11 volumio-x86 volumio[1052]: info: May 13 11:52:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:52:11 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 4 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand clear took 4 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand add "USB/王杰/王杰 - 忘了你,忘了我.flac" May 13 11:52:11 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: 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":"王杰 - 忘记你不如忘记自己.flac","artist":null,"album":null,"uri":"USB/王杰/王杰 - 忘记你不如忘记自己.flac","trackType":"flac"} May 13 11:52:11 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService stop May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus stop May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:11 volumio-x86 volumio[1052]: info: No code May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:11 volumio-x86 volumio[1052]: info: ------------------------------ 74ms May 13 11:52:11 volumio-x86 volumio[1052]: error: updateQueue error: null May 13 11:52:11 volumio-x86 volumio[1052]: info: May 13 11:52:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:52:11 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:52:11 volumio-x86 volumio[1052]: info: ------------------------------ 73ms May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand add "USB/王杰/王杰 - 忘了你,忘了我.flac" took 71 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand play May 13 11:52:11 volumio-x86 volumio[1052]: info: May 13 11:52:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:52:11 volumio-x86 volumio[1052]: info: ------------------------------ 46ms May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand play took 43 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:52:11 volumio-x86 volumio[1052]: info: May 13 11:52:11 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:52:11 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand status took 13 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand status took 65 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 52 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:52:11 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":614,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"698 Kbps","isStreaming":false,"title":"1、忘了你忘了我","artist":"王杰","album":"忘了你忘了我","uri":"USB/王杰/王杰 - 忘了你,忘了我.flac","trackType":"flac"} May 13 11:52:11 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService play May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus stop May 13 11:52:11 volumio-x86 volumio[1052]: info: ------------------------------ 92ms May 13 11:52:11 volumio-x86 volumio[1052]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E6%9D%B0/%E5%BF%98%E4%BA%86%E4%BD%A0%E5%BF%98%E4%BA%86%E6%88%91/bd01ae57-eca0-4dfe-8c15-888223feaa49.jpg' May 13 11:52:11 volumio-x86 volumio[1052]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E6%9D%B0/%E5%BF%98%E4%BA%86%E4%BD%A0%E5%BF%98%E4%BA%86%E6%88%91/bd01ae57-eca0-4dfe-8c15-888223feaa49.jpg' May 13 11:52:11 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 9 milliseconds May 13 11:52:11 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:52:11 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":660,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"645 Kbps","isStreaming":false,"title":"1、忘了你忘了我","artist":"王杰","album":"忘了你忘了我","uri":"USB/王杰/王杰 - 忘了你,忘了我.flac","trackType":"flac"} May 13 11:52:11 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService play May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus play May 13 11:52:11 volumio-x86 volumio[1052]: info: Received an update from plugin. extracting info from payload May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:11 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:11 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:11 volumio-x86 volumio[1052]: info: ------------------------------ 137ms May 13 11:52:12 volumio-x86 kernel: python3[5301]: segfault at b8 ip 00000000005cea5c sp 00007f29e9ff8a80 error 4 in python3.7[421000+234000] likely on CPU 1 (core 1, socket 0) May 13 11:52:12 volumio-x86 kernel: Code: f0 48 8b 77 e8 83 e0 01 48 83 c8 fc 48 89 47 f8 48 89 33 48 8b 7f e8 48 89 5f 08 48 c7 45 e8 00 00 00 00 4c 8b 25 14 92 2d 00 <41> 8b 8c 24 b8 00 00 00 83 f9 31 0f 8f 7b 01 00 00 48 8b 75 18 83 May 13 11:52:12 volumio-x86 sudo[4872]: pam_unix(sudo:session): session closed for user root May 13 11:52:12 volumio-x86 screensaver.sh[657]: /home/volumio/peppy_screensaver/screensaver.sh: line 28: 4872 Segmentation fault sudo python3 ./screensaver/volumio_peppymeter.py May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPlay May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::play index 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::stop May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::stPlaybackTimer May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::updateTrackBlock May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrackBlock May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::serviceStop May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 36 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::serviceStop May 13 11:52:13 volumio-x86 volumio[1052]: info: ControllerMpd::stop May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:52:13 volumio-x86 volumio[1052]: info: May 13 11:52:13 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 32 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::play index undefined May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::startPlaybackTimer May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::clearAddPlayTracks USB/王杰/王杰 - 忘了你忘了我.flac May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand status took 9 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 8 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand clear May 13 11:52:13 volumio-x86 volumio[1052]: info: May 13 11:52:13 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:52:13 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 6 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand clear took 6 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand add "USB/王杰/王杰 - 忘了你忘了我.flac" May 13 11:52:13 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: 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":"1、忘了你忘了我","artist":"王杰","album":"忘了你忘了我","uri":"USB/王杰/王杰 - 忘了你,忘了我.flac","trackType":"flac"} May 13 11:52:13 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService stop May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus stop May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:13 volumio-x86 volumio[1052]: info: No code May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:13 volumio-x86 volumio[1052]: info: ------------------------------ 78ms May 13 11:52:13 volumio-x86 volumio[1052]: error: updateQueue error: null May 13 11:52:13 volumio-x86 volumio[1052]: info: May 13 11:52:13 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:52:13 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:52:13 volumio-x86 volumio[1052]: info: ------------------------------ 66ms May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand add "USB/王杰/王杰 - 忘了你忘了我.flac" took 64 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand play May 13 11:52:13 volumio-x86 volumio[1052]: info: May 13 11:52:13 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:52:13 volumio-x86 volumio[1052]: info: ------------------------------ 17ms May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand play took 16 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:52:13 volumio-x86 volumio[1052]: info: May 13 11:52:13 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:52:13 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand status took 3 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand status took 28 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 28 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:52:13 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"忘了你忘了我","artist":"王杰","album":"孤星.英雄泪 王杰时代精选(Disc 2)","uri":"USB/王杰/王杰 - 忘了你忘了我.flac","trackType":"flac"} May 13 11:52:13 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService play May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus stop May 13 11:52:13 volumio-x86 volumio[1052]: info: ------------------------------ 57ms May 13 11:52:13 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 22 milliseconds May 13 11:52:13 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:52:13 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"忘了你忘了我","artist":"王杰","album":"孤星.英雄泪 王杰时代精选(Disc 2)","uri":"USB/王杰/王杰 - 忘了你忘了我.flac","trackType":"flac"} May 13 11:52:13 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService play May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus play May 13 11:52:13 volumio-x86 volumio[1052]: info: Received an update from plugin. extracting info from payload May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:13 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:13 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:13 volumio-x86 volumio[1052]: info: ------------------------------ 135ms May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPlay May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::play index 22 May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::stop May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::stPlaybackTimer May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::updateTrackBlock May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrackBlock May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::serviceStop May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 37 May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::serviceStop May 13 11:52:21 volumio-x86 volumio[1052]: info: ControllerMpd::stop May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:52:21 volumio-x86 volumio[1052]: info: May 13 11:52:21 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:52:21 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 19 milliseconds May 13 11:52:21 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::play index undefined May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 22 May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::startPlaybackTimer May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 22 May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::clearAddPlayTracks USB/王杰/王杰 - 冰冷长街.flac May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop May 13 11:52:21 volumio-x86 volumio[1052]: info: sendMpdCommand status took 6 milliseconds May 13 11:52:21 volumio-x86 volumio[1052]: info: sendMpdCommand stop took 3 milliseconds May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand clear May 13 11:52:21 volumio-x86 volumio[1052]: info: May 13 11:52:21 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:52:21 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:52:21 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 10 milliseconds May 13 11:52:21 volumio-x86 volumio[1052]: info: sendMpdCommand clear took 11 milliseconds May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand add "USB/王杰/王杰 - 冰冷长街.flac" May 13 11:52:21 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 22 May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 22 May 13 11:52:21 volumio-x86 volumio[1052]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"忘了你忘了我","artist":"王杰","album":"孤星.英雄泪 王杰时代精选(Disc 2)","uri":"USB/王杰/王杰 - 忘了你忘了我.flac","trackType":"flac"} May 13 11:52:21 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 22 May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService stop May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus stop May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 22 May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:21 volumio-x86 volumio[1052]: info: No code May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::pushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 22 May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioPushState May 13 11:52:21 volumio-x86 volumio[1052]: info: ------------------------------ 72ms May 13 11:52:21 volumio-x86 volumio[1052]: error: updateQueue error: null May 13 11:52:21 volumio-x86 volumio[1052]: info: May 13 11:52:21 volumio-x86 volumio[1052]: ---------------------------- MPD announces system playlist update May 13 11:52:21 volumio-x86 volumio[1052]: info: Ignoring MPD Status Update May 13 11:52:21 volumio-x86 volumio[1052]: info: ------------------------------ 61ms May 13 11:52:21 volumio-x86 volumio[1052]: info: sendMpdCommand add "USB/王杰/王杰 - 冰冷长街.flac" took 52 milliseconds May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand play May 13 11:52:21 volumio-x86 volumio[1052]: info: May 13 11:52:21 volumio-x86 volumio[1052]: ---------------------------- MPD announces state update: player May 13 11:52:21 volumio-x86 volumio[1052]: info: ------------------------------ 46ms May 13 11:52:21 volumio-x86 volumio[1052]: info: sendMpdCommand play took 43 milliseconds May 13 11:52:21 volumio-x86 volumio[1052]: info: ControllerMpd::getState May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand status May 13 11:52:21 volumio-x86 volumio[1052]: info: sendMpdCommand status took 10 milliseconds May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseState May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 11:52:21 volumio-x86 volumio[1052]: info: sendMpdCommand playlistinfo took 2 milliseconds May 13 11:52:21 volumio-x86 volumio[1052]: verbose: ControllerMpd::parseTrackInfo May 13 11:52:21 volumio-x86 volumio[1052]: info: ControllerMpd::pushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreCommandRouter::servicePushState May 13 11:52:21 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 22 May 13 11:52:21 volumio-x86 volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":614,"duration":285,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"729 Kbps","isStreaming":false,"title":"王杰 - 冰冷长街.flac","artist":null,"album":null,"uri":"USB/王杰/王杰 - 冰冷长街.flac","trackType":"flac"} May 13 11:52:21 volumio-x86 volumio[1052]: verbose: CURRENT POSITION 22 May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState stateService play May 13 11:52:21 volumio-x86 volumio[1052]: info: CoreStateMachine::syncState currentStatus stop May 13 11:52:21 volumio-x86 volumio[1052]: info: ------------------------------ 28ms May 13 11:52:22 volumio-x86 volumio[1052]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 13 11:52:22 volumio-x86 volumio[1052]: info: Retrying Login Due to Network Error May 13 11:52:24 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 13 11:52:24 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 13 11:52:24 volumio-x86 volumio[1052]: info: Discovery: Getting this device information May 13 11:52:24 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioGetState May 13 11:52:24 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 22 May 13 11:52:24 volumio-x86 volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 13 11:52:32 volumio-x86 volumio[1052]: info: MyVolumio login type: Token May 13 11:52:33 volumio-x86 volumio[1052]: info: CoreCommandRouter::volumioGetState May 13 11:52:33 volumio-x86 volumio[1052]: info: CorePlayQueue::getTrack 22 May 13 11:52:33 volumio-x86 sudo[5399]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py May 13 11:52:33 volumio-x86 sudo[5399]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 11:52:35 volumio-x86 volumio[1052]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 11:52:35 volumio-x86 volumio[1052]: Error: connect ETIMEDOUT 39.109.122.128:443 May 13 11:52:35 volumio-x86 volumio[1052]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 13 11:52:35 volumio-x86 volumio[1052]: errno: -110, May 13 11:52:35 volumio-x86 volumio[1052]: code: 'ETIMEDOUT', May 13 11:52:35 volumio-x86 volumio[1052]: syscall: 'connect', May 13 11:52:35 volumio-x86 volumio[1052]: address: '39.109.122.128', May 13 11:52:35 volumio-x86 volumio[1052]: port: 443 May 13 11:52:35 volumio-x86 volumio[1052]: } May 13 11:52:35 volumio-x86 volumio[1052]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 11:52:35 volumio-x86 sudo[5430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 11:51 May 13 11:52:35 volumio-x86 sudo[5430]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"