-- Logs begin at Wed 2025-09-17 08:50:56 CST, end at Wed 2025-09-17 09:04:31 CST. -- Sep 17 09:03:00 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 17 09:03:00 volumio-x86-784 volumio[4802]: info: CURURI: playlists Sep 17 09:03:00 volumio-x86-784 volumio[4802]: info: Listing playlists Sep 17 09:03:00 volumio-x86-784 volumio[4802]: info: Preload queue cleared Sep 17 09:03:00 volumio-x86-784 volumio[4802]: info: MyVolumio login type: Token Sep 17 09:03:06 volumio-x86-784 ntpd[1167]: 185.209.85.222 local addr 10.0.0.20 -> Sep 17 09:03:07 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioGetState Sep 17 09:03:07 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 0 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPlay Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::play index 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::stop Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::play index undefined Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::startPlaybackTimer Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand stop took 1 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand clear Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand clear took 2 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac" Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: error: updateQueue error: null Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 9ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand add "INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac" took 7 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 6ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 5ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 6ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand play took 5 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 10ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 9ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 10 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:10 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 46 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 45 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 37 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 31 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"付出太多","artist":"付豪","album":"付出太多","uri":"INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac","trackType":"flac"} Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus stop Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 62ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 18 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 16 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"付出太多","artist":"付豪","album":"付出太多","uri":"INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac","trackType":"flac"} Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"827 Kbps","isStreaming":false,"title":"付出太多","artist":"付豪","album":"付出太多","uri":"INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac","trackType":"flac"} Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":742,"duration":256,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1374 Kbps","isStreaming":false,"title":"付出太多","artist":"付豪","album":"付出太多","uri":"INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac","trackType":"flac"} Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 141ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 126ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 81 milliseconds Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":742,"duration":256,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1374 Kbps","isStreaming":false,"title":"付出太多","artist":"付豪","album":"付出太多","uri":"INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac","trackType":"flac"} Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":742,"duration":256,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1374 Kbps","isStreaming":false,"title":"付出太多","artist":"付豪","album":"付出太多","uri":"INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac","trackType":"flac"} Sep 17 09:03:10 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 201ms Sep 17 09:03:10 volumio-x86-784 volumio[4802]: info: ------------------------------ 196ms Sep 17 09:03:19 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioGetState Sep 17 09:03:19 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:19 volumio-x86-784 sudo[5353]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Sep 17 09:03:19 volumio-x86-784 sudo[5353]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 09:03:22 volumio-x86-784 volumio[4802]: 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: 7 Sep 17 09:03:22 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioGetState Sep 17 09:03:22 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:25 volumio-x86-784 volumio[4802]: 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: 8 Sep 17 09:03:25 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioGetState Sep 17 09:03:25 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:30 volumio-x86-784 volumio[4802]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 17 09:03:30 volumio-x86-784 volumio[4802]: info: Retrying Login Due to Network Error Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: MyVolumio login type: Token Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPlay Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreStateMachine::play index 36 Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreStateMachine::stop Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreStateMachine::stPlaybackTimer Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreStateMachine::updateTrackBlock Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrackBlock Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreStateMachine::serviceStop Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 3 Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::serviceStop Sep 17 09:03:40 volumio-x86-784 volumio[4802]: info: ControllerMpd::stop Sep 17 09:03:40 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand stop took 68 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::play index undefined Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::startPlaybackTimer Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/musics/单曲2025/9月/影子-无人与我渡红尘.flac Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 23 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand stop took 19 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 7 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 4 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand clear Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 12 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand clear took 13 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 12 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 14 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/musics/单曲2025/9月/影子-无人与我渡红尘.flac" Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: 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":"付出太多","uri":"INTERNAL/musics/单曲2025/9月/付豪-付出太多.flac","trackType":"flac"} Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService stop Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus stop Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: No code Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 17 09:03:41 volumio-x86-784 volumio[4802]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 125ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 118ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 106ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: error: updateQueue error: null Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 110ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand add "INTERNAL/musics/单曲2025/9月/影子-无人与我渡红尘.flac" took 101 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 20ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces system playlist update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Ignoring MPD Status Update Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 70ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 62ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand play took 58 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 59ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 50ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 27 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 24 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 20 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 15 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Sep 17 09:03:41 volumio-x86-784 volumio[4802]: ---------------------------- MPD announces state update: player Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::getState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand status Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 53 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 50 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 48 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 46 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 39 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand status took 34 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1140 Kbps","isStreaming":false,"title":"无人与我渡红尘","artist":"影子","album":"无人与我渡红尘","uri":"INTERNAL/musics/单曲2025/9月/影子-无人与我渡红尘.flac","trackType":"flac"} Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus stop Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1140 Kbps","isStreaming":false,"title":"无人与我渡红尘","artist":"影子","album":"无人与我渡红尘","uri":"INTERNAL/musics/单曲2025/9月/影子-无人与我渡红尘.flac","trackType":"flac"} Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1140 Kbps","isStreaming":false,"title":"无人与我渡红尘","artist":"影子","album":"无人与我渡红尘","uri":"INTERNAL/musics/单曲2025/9月/影子-无人与我渡红尘.flac","trackType":"flac"} Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1140 Kbps","isStreaming":false,"title":"无人与我渡红尘","artist":"影子","album":"无人与我渡红尘","uri":"INTERNAL/musics/单曲2025/9月/影子-无人与我渡红尘.flac","trackType":"flac"} Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 158ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 254ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 239ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 237ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 154 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: sendMpdCommand playlistinfo took 157 milliseconds Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: ControllerMpd::parseTrackInfo Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1140 Kbps","isStreaming":false,"title":"无人与我渡红尘","artist":"影子","album":"无人与我渡红尘","uri":"INTERNAL/musics/单曲2025/9月/影子-无人与我渡红尘.flac","trackType":"flac"} Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ControllerMpd::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::servicePushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1140 Kbps","isStreaming":false,"title":"无人与我渡红尘","artist":"影子","album":"无人与我渡红尘","uri":"INTERNAL/musics/单曲2025/9月/影子-无人与我渡红尘.flac","trackType":"flac"} Sep 17 09:03:41 volumio-x86-784 volumio[4802]: verbose: CURRENT POSITION 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState stateService play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::syncState currentStatus play Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: Received an update from plugin. extracting info from payload Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreStateMachine::pushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioPushState Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 366ms Sep 17 09:03:41 volumio-x86-784 volumio[4802]: info: ------------------------------ 365ms Sep 17 09:03:44 volumio-x86-784 volumio[4802]: 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: 8 Sep 17 09:03:44 volumio-x86-784 volumio[4802]: info: CoreCommandRouter::volumioGetState Sep 17 09:03:44 volumio-x86-784 volumio[4802]: info: CorePlayQueue::getTrack 36 Sep 17 09:04:09 volumio-x86-784 ntpd[1167]: 84.16.67.12 local addr 10.0.0.20 -> Sep 17 09:04:10 volumio-x86-784 volumio[4802]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 17 09:04:10 volumio-x86-784 volumio[4802]: info: Retrying Login Due to Network Error Sep 17 09:04:20 volumio-x86-784 volumio[4802]: info: MyVolumio login type: Token Sep 17 09:04:31 volumio-x86-784 volumio[4802]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 09:04:31 volumio-x86-784 volumio[4802]: Error: connect ETIMEDOUT 75.126.33.156:443 Sep 17 09:04:31 volumio-x86-784 volumio[4802]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 17 09:04:31 volumio-x86-784 volumio[4802]: errno: -110, Sep 17 09:04:31 volumio-x86-784 volumio[4802]: code: 'ETIMEDOUT', Sep 17 09:04:31 volumio-x86-784 volumio[4802]: syscall: 'connect', Sep 17 09:04:31 volumio-x86-784 volumio[4802]: address: '75.126.33.156', Sep 17 09:04:31 volumio-x86-784 volumio[4802]: port: 443 Sep 17 09:04:31 volumio-x86-784 volumio[4802]: } Sep 17 09:04:31 volumio-x86-784 volumio[4802]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 09:04:31 volumio-x86-784 sudo[5612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-17 09:03 Sep 17 09:04:31 volumio-x86-784 sudo[5612]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"