-- Logs begin at Fri 2021-07-02 10:45:33 UTC, end at Thu 2025-09-11 07:24:22 UTC. -- Sep 11 07:23:01 volumio kernel: Voltage normalised (0x00000000) Sep 11 07:23:05 volumio kernel: Under-voltage detected! (0x00050005) Sep 11 07:23:37 volumio volumio[1135]: info: CorePlayQueue::getTrack 10 Sep 11 07:23:37 volumio volumio[1135]: info: CorePlayQueue::getTrack 183 Sep 11 07:23:37 volumio volumio[1135]: info: Prefetching next song Sep 11 07:23:37 volumio volumio[1135]: info: DOING PREFETCH IN MPD Sep 11 07:23:37 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand add "NAS/N5101/音乐/倩女幽魂 - 张国荣.mp3" Sep 11 07:23:37 volumio volumio[1135]: info: Sep 11 07:23:37 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 11 07:23:37 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 11 07:23:37 volumio volumio[1135]: info: sendMpdCommand add "NAS/N5101/音乐/倩女幽魂 - 张国荣.mp3" took 5 milliseconds Sep 11 07:23:37 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 11 07:23:37 volumio volumio[1135]: info: Sep 11 07:23:37 volumio volumio[1135]: ---------------------------- MPD announces state update: options Sep 11 07:23:37 volumio volumio[1135]: info: ------------------------------ 9ms Sep 11 07:23:37 volumio volumio[1135]: info: sendMpdCommand consume 1 took 5 milliseconds Sep 11 07:23:37 volumio volumio[1135]: info: ControllerMpd::getState Sep 11 07:23:37 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 11 07:23:37 volumio volumio[1135]: info: sendMpdCommand status took 2 milliseconds Sep 11 07:23:37 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 11 07:23:37 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 07:23:37 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 11 07:23:37 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 11 07:23:37 volumio volumio[1135]: info: ControllerMpd::pushState Sep 11 07:23:37 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 11 07:23:37 volumio volumio[1135]: info: CoreStateMachine::startPlaybackTimer Sep 11 07:23:37 volumio volumio[1135]: info: CorePlayQueue::getTrack 183 Sep 11 07:23:37 volumio volumio[1135]: info: CorePlayQueue::getTrack 183 Sep 11 07:23:37 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":210465,"duration":215,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"在他乡","artist":"水木年华","album":"3","uri":"NAS/N5101/音乐/在他乡 - 水木年华.mp3","trackType":"mp3"} Sep 11 07:23:37 volumio volumio[1135]: verbose: CURRENT POSITION 183 Sep 11 07:23:37 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 11 07:23:37 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus play Sep 11 07:23:37 volumio volumio[1135]: info: Received an update from plugin. extracting info from payload Sep 11 07:23:37 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:37 volumio volumio[1135]: info: CorePlayQueue::getTrack 183 Sep 11 07:23:37 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:37 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:37 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:37 volumio volumio[1135]: info: CorePlayQueue::getTrack 183 Sep 11 07:23:37 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:37 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:37 volumio volumio[1135]: info: ------------------------------ 49ms Sep 11 07:23:39 volumio sudo[3262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 11 07:23:39 volumio sudo[3262]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 11 07:23:39 volumio sudo[3264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 11 07:23:39 volumio sudo[3262]: pam_unix(sudo:session): session closed for user root Sep 11 07:23:39 volumio sudo[3264]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 11 07:23:39 volumio sudo[3264]: pam_unix(sudo:session): session closed for user root Sep 11 07:23:40 volumio sudo[3281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 11 07:23:40 volumio sudo[3281]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 11 07:23:40 volumio sudo[3283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 11 07:23:40 volumio sudo[3281]: pam_unix(sudo:session): session closed for user root Sep 11 07:23:40 volumio sudo[3283]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 11 07:23:40 volumio sudo[3283]: pam_unix(sudo:session): session closed for user root Sep 11 07:23:40 volumio volumio[1135]: info: CoreCommandRouter::volumioGetState Sep 11 07:23:40 volumio volumio[1135]: info: CorePlayQueue::getTrack 183 Sep 11 07:23:40 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 11 07:23:40 volumio volumio[1135]: info: CoreCommandRouter::volumioGetVisibleSources Sep 11 07:23:40 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 11 07:23:40 volumio volumio[1135]: info: Listing playlists Sep 11 07:23:40 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 11 07:23:40 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 11 07:23:40 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 11 07:23:40 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 11 07:23:41 volumio volumio[1135]: info: CorePlayQueue::getTrack 183 Sep 11 07:23:41 volumio volumio[1135]: info: CorePlayQueue::getTrack 548 Sep 11 07:23:41 volumio volumio[1135]: info: Prefetching next song Sep 11 07:23:41 volumio volumio[1135]: info: DOING PREFETCH IN MPD Sep 11 07:23:41 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand add "NAS/N5101/音乐/晚风 (走心版) - 云南三怪.mp3" Sep 11 07:23:41 volumio volumio[1135]: info: Sep 11 07:23:41 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 11 07:23:41 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 11 07:23:41 volumio volumio[1135]: info: sendMpdCommand add "NAS/N5101/音乐/晚风 (走心版) - 云南三怪.mp3" took 2 milliseconds Sep 11 07:23:41 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 11 07:23:41 volumio volumio[1135]: info: ------------------------------ 10ms Sep 11 07:23:41 volumio volumio[1135]: info: sendMpdCommand consume 1 took 10 milliseconds Sep 11 07:23:42 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 11 07:23:42 volumio volumio[1135]: info: Sep 11 07:23:42 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 11 07:23:42 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 11 07:23:42 volumio volumio[1135]: info: Sep 11 07:23:42 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 11 07:23:42 volumio volumio[1135]: info: ControllerMpd::getState Sep 11 07:23:42 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 11 07:23:42 volumio volumio[1135]: info: ------------------------------ 4ms Sep 11 07:23:42 volumio volumio[1135]: info: sendMpdCommand status took 3 milliseconds Sep 11 07:23:42 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 11 07:23:42 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 07:23:42 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 11 07:23:42 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 11 07:23:42 volumio volumio[1135]: info: ControllerMpd::pushState Sep 11 07:23:42 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 11 07:23:42 volumio volumio[1135]: info: CoreStateMachine::startPlaybackTimer Sep 11 07:23:42 volumio volumio[1135]: info: CorePlayQueue::getTrack 548 Sep 11 07:23:42 volumio volumio[1135]: info: CorePlayQueue::getTrack 548 Sep 11 07:23:42 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":81,"duration":219,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"倩女幽魂","artist":"张国荣","album":"倩女幽魂 电影原声带","uri":"NAS/N5101/音乐/倩女幽魂 - 张国荣.mp3","trackType":"mp3"} Sep 11 07:23:42 volumio volumio[1135]: verbose: CURRENT POSITION 548 Sep 11 07:23:42 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 11 07:23:42 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus play Sep 11 07:23:42 volumio volumio[1135]: info: Received an update from plugin. extracting info from payload Sep 11 07:23:42 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:42 volumio volumio[1135]: info: CorePlayQueue::getTrack 548 Sep 11 07:23:42 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:42 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:42 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:42 volumio volumio[1135]: info: CorePlayQueue::getTrack 548 Sep 11 07:23:42 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:42 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:42 volumio volumio[1135]: info: ------------------------------ 28ms Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::volumioNext Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::next Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::stop Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 07:23:44 volumio volumio[1135]: UNSET VOLATILE Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::stPlaybackTimer Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::updateTrackBlock Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrackBlock Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrack 548 Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::serviceStop Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrack 548 Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::serviceStop Sep 11 07:23:44 volumio volumio[1135]: info: ControllerMpd::stop Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand stop Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand stop took 95 milliseconds Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::play index undefined Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrack 507 Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::startPlaybackTimer Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrack 507 Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::clearAddPlayTracks NAS/N5101/音乐/接过父亲的烟和当家的权 - 烟嗓船长.mp3 Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand stop Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::updateTrackBlock Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrackBlock Sep 11 07:23:44 volumio volumio[1135]: info: Sep 11 07:23:44 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 11 07:23:44 volumio volumio[1135]: info: ControllerMpd::getState Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand stop took 24 milliseconds Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand clear Sep 11 07:23:44 volumio volumio[1135]: info: Sep 11 07:23:44 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 11 07:23:44 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand status took 10 milliseconds Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand clear took 9 milliseconds Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand add "NAS/N5101/音乐/接过父亲的烟和当家的权 - 烟嗓船长.mp3" Sep 11 07:23:44 volumio volumio[1135]: error: updateQueue error: null Sep 11 07:23:44 volumio volumio[1135]: info: Sep 11 07:23:44 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 11 07:23:44 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 11 07:23:44 volumio volumio[1135]: info: ------------------------------ 13ms Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand add "NAS/N5101/音乐/接过父亲的烟和当家的权 - 烟嗓船长.mp3" took 9 milliseconds Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand play Sep 11 07:23:44 volumio volumio[1135]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 11 07:23:44 volumio volumio[1135]: info: ------------------------------ 32ms Sep 11 07:23:44 volumio volumio[1135]: info: ------------------------------ 21ms Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand play took 15 milliseconds Sep 11 07:23:44 volumio volumio[1135]: info: Sep 11 07:23:44 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 11 07:23:44 volumio volumio[1135]: info: ControllerMpd::getState Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 11 07:23:44 volumio volumio[1135]: info: Sep 11 07:23:44 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 11 07:23:44 volumio volumio[1135]: info: ControllerMpd::getState Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand status took 8 milliseconds Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand status took 6 milliseconds Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 11 07:23:44 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 11 07:23:44 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 11 07:23:44 volumio volumio[1135]: info: ControllerMpd::pushState Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrack 507 Sep 11 07:23:44 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":348,"duration":190,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"接过父亲的烟和当家的权","artist":"烟嗓船长","album":"接过父亲的烟和当家的权","uri":"NAS/N5101/音乐/接过父亲的烟和当家的权 - 烟嗓船长.mp3","trackType":"mp3"} Sep 11 07:23:44 volumio volumio[1135]: verbose: CURRENT POSITION 507 Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus stop Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrack 507 Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:44 volumio volumio[1135]: info: ControllerMpd::pushState Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrack 507 Sep 11 07:23:44 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":371,"duration":190,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"接过父亲的烟和当家的权","artist":"烟嗓船长","album":"接过父亲的烟和当家的权","uri":"NAS/N5101/音乐/接过父亲的烟和当家的权 - 烟嗓船长.mp3","trackType":"mp3"} Sep 11 07:23:44 volumio volumio[1135]: verbose: CURRENT POSITION 507 Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus play Sep 11 07:23:44 volumio volumio[1135]: info: Received an update from plugin. extracting info from payload Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrack 507 Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:44 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:44 volumio volumio[1135]: info: CorePlayQueue::getTrack 507 Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:44 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:44 volumio volumio[1135]: info: ------------------------------ 79ms Sep 11 07:23:44 volumio volumio[1135]: info: ------------------------------ 79ms Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::volumioNext Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::next Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::stop Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 07:23:48 volumio volumio[1135]: UNSET VOLATILE Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::stPlaybackTimer Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::updateTrackBlock Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrackBlock Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrack 507 Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::serviceStop Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrack 507 Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::serviceStop Sep 11 07:23:48 volumio volumio[1135]: info: ControllerMpd::stop Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand stop Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand stop took 58 milliseconds Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::play index undefined Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrack 241 Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::startPlaybackTimer Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrack 241 Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::clearAddPlayTracks NAS/N5101/音乐/半生雪 - 七叔（叶泽浩）.mp3 Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand stop Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::updateTrackBlock Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrackBlock Sep 11 07:23:48 volumio volumio[1135]: info: Sep 11 07:23:48 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 11 07:23:48 volumio volumio[1135]: info: ControllerMpd::getState Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand stop took 11 milliseconds Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand clear Sep 11 07:23:48 volumio volumio[1135]: info: Sep 11 07:23:48 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 11 07:23:48 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand status took 25 milliseconds Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand clear took 6 milliseconds Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand add "NAS/N5101/音乐/半生雪 - 七叔（叶泽浩）.mp3" Sep 11 07:23:48 volumio volumio[1135]: error: updateQueue error: null Sep 11 07:23:48 volumio volumio[1135]: info: Sep 11 07:23:48 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 11 07:23:48 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 11 07:23:48 volumio volumio[1135]: info: ------------------------------ 8ms Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand add "NAS/N5101/音乐/半生雪 - 七叔（叶泽浩）.mp3" took 5 milliseconds Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand play Sep 11 07:23:48 volumio volumio[1135]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 11 07:23:48 volumio volumio[1135]: info: ------------------------------ 39ms Sep 11 07:23:48 volumio volumio[1135]: info: ------------------------------ 9ms Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand play took 5 milliseconds Sep 11 07:23:48 volumio volumio[1135]: info: Sep 11 07:23:48 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 11 07:23:48 volumio volumio[1135]: info: ControllerMpd::getState Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 11 07:23:48 volumio volumio[1135]: info: Sep 11 07:23:48 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 11 07:23:48 volumio volumio[1135]: info: ControllerMpd::getState Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand status took 4 milliseconds Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand status took 6 milliseconds Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 11 07:23:48 volumio volumio[1135]: info: ControllerMpd::pushState Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrack 241 Sep 11 07:23:48 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":116,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"半生雪","artist":"七叔（叶泽浩）","album":"半生雪","uri":"NAS/N5101/音乐/半生雪 - 七叔（叶泽浩）.mp3","trackType":"mp3"} Sep 11 07:23:48 volumio volumio[1135]: verbose: CURRENT POSITION 241 Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus stop Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrack 241 Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:48 volumio volumio[1135]: info: ------------------------------ 34ms Sep 11 07:23:48 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 22 milliseconds Sep 11 07:23:48 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 11 07:23:48 volumio volumio[1135]: info: ControllerMpd::pushState Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrack 241 Sep 11 07:23:48 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":429,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"半生雪","artist":"七叔（叶泽浩）","album":"半生雪","uri":"NAS/N5101/音乐/半生雪 - 七叔（叶泽浩）.mp3","trackType":"mp3"} Sep 11 07:23:48 volumio volumio[1135]: verbose: CURRENT POSITION 241 Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus play Sep 11 07:23:48 volumio volumio[1135]: info: Received an update from plugin. extracting info from payload Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrack 241 Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:48 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:23:48 volumio volumio[1135]: info: CorePlayQueue::getTrack 241 Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:23:48 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:23:48 volumio volumio[1135]: info: ------------------------------ 83ms Sep 11 07:23:58 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 11 07:23:58 volumio volumio[1135]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 11 07:23:58 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 11 07:23:58 volumio volumio[1135]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Sep 11 07:23:58 volumio volumio[1135]: info: Received Get System Version Sep 11 07:23:58 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 11 07:24:08 volumio volumio[1135]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E4%B8%83%E5%8F%94%EF%BC%88%E5%8F%B6%E6%B3%BD%E6%B5%A9%EF%BC%89/%E5%8D%8A%E7%94%9F%E9%9B%AA/534138e3-d8f3-4b5f-866a-e16a25f67231.jpg' Sep 11 07:24:12 volumio volumio[1135]: info: VolumeController::SetAlsaVolume72 Sep 11 07:24:12 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 11 07:24:12 volumio volumio[1135]: info: CorePlayQueue::getTrack 241 Sep 11 07:24:12 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 11 07:24:12 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 07:24:15 volumio avahi-daemon[775]: Invalid response packet from host 192.168.4.66. Sep 11 07:24:15 volumio avahi-daemon[775]: Invalid response packet from host 192.168.4.66. Sep 11 07:24:21 volumio volumio[1135]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 11 07:24:21 volumio volumio[1135]: { Error: connect ETIMEDOUT 185.60.219.41:443 Sep 11 07:24:21 volumio volumio[1135]: at Object._errnoException (util.js:1022:11) Sep 11 07:24:21 volumio volumio[1135]: at _exceptionWithHostPort (util.js:1044:20) Sep 11 07:24:21 volumio volumio[1135]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Sep 11 07:24:21 volumio volumio[1135]: code: 'ETIMEDOUT', Sep 11 07:24:21 volumio volumio[1135]: errno: 'ETIMEDOUT', Sep 11 07:24:21 volumio volumio[1135]: syscall: 'connect', Sep 11 07:24:21 volumio volumio[1135]: address: '185.60.219.41', Sep 11 07:24:21 volumio volumio[1135]: port: 443 } Sep 11 07:24:21 volumio volumio[1135]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 11 07:24:22 volumio sudo[3334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-11 07:23 Sep 11 07:24:22 volumio sudo[3334]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"