-- Logs begin at Sun 2025-10-19 04:47:50 UTC, end at Fri 2025-10-24 12:35:04 UTC. -- Oct 24 12:34:15 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Oct 24 12:34:15 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:15 volumio volumio[987]: info: CorePlayQueue::getTrack 692 Oct 24 12:34:15 volumio sudo[3699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:15 volumio sudo[3699]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:15 volumio sudo[3699]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:15 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 24 12:34:15 volumio volumio[987]: info: Listing playlists Oct 24 12:34:15 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Oct 24 12:34:15 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 24 12:34:15 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Oct 24 12:34:15 volumio volumio[987]: info: CoreStateMachine::getQueue Oct 24 12:34:15 volumio volumio[987]: info: CorePlayQueue::getQueue Oct 24 12:34:15 volumio sudo[3706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:15 volumio sudo[3706]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:15 volumio sudo[3706]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioAddQueueItems Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::addQueueItems Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::addQueueItems Oct 24 12:34:29 volumio volumio[987]: info: Adding Item to queue: music-library/USB/volumio/上海歌姬 Oct 24 12:34:29 volumio volumio[987]: info: Exploding uri music-library/USB/volumio/上海歌姬 in service mpd Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/上海歌姬[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E4%B8%B2%EF%BC%88%E5%A4%9C%E4%B8%8A%E6%B5%B7%20%E5%A4%9C%E6%9D%A5%E9%A6%99%20%E5%87%A4%E5%87%B0%E9%A3%9E%EF%BC%89%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/串(夜上海 夜来香 凤凰飞)[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E5%8D%A1%E9%97%A8%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/卡门[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E5%A4%A9%E6%B6%AF%E6%AD%8C%E5%A5%B3%E2%80%94%E2%80%94%E9%9F%B3%E4%B9%90%E6%95%85%E4%BA%8B%E7%89%88%EF%BC%88%E5%9B%BD%E8%AF%AD%E7%89%88%EF%BC%89%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/天涯歌女——音乐故事版(国语版)[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E5%A4%A9%E6%B6%AF%E6%AD%8C%E5%A5%B3%EF%BC%88%E6%B2%AA%E8%AF%AD%E7%89%88%EF%BC%89%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/天涯歌女(沪语版)[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E5%BE%97%E4%B8%8D%E5%88%B0%E7%9A%84%E7%88%B1%E6%83%85%EF%BC%88%E6%B2%AA%E8%AF%AD%E7%89%88%EF%BC%89%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/得不到的爱情(沪语版)[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E6%83%85%E4%BA%BA%E7%9A%84%E7%9C%BC%E6%B3%AA%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/情人的眼泪[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E6%88%91%E8%A6%81%E4%BD%A0%E7%9A%84%E7%88%B1%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/我要你的爱[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E6%98%8E%E6%9C%88%E5%8D%83%E9%87%8C%E5%AF%84%E7%9B%B8%E6%80%9D%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/明月千里寄相思[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ALBUMART /albumart?cacheid=369&web=%E6%9E%97%E5%AE%9D/%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2F%E4%B8%8A%E6%B5%B7%E6%AD%8C%E5%A7%AC%2F%E7%8B%82%E6%81%8B%5B%E6%97%A0%E6%8D%9F%5D-%E6%9E%97%E5%AE%9D.flac&metadata=false Oct 24 12:34:29 volumio volumio[987]: info: URI /mnt/USB/volumio/上海歌姬/狂恋[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::saveQueue Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPlay Oct 24 12:34:29 volumio volumio[987]: UNSET VOLATILE Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::play index 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::stop Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 24 12:34:29 volumio volumio[987]: UNSET VOLATILE Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::stPlaybackTimer Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 692 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::serviceStop Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 692 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::serviceStop Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::stop Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand stop Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio sudo[3718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces state update: player Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::getState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand status Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::play index undefined Oct 24 12:34:29 volumio sudo[3718]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::clearAddPlayTracks USB/volumio/上海歌姬/上海歌姬[无损]-林宝.flac Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand stop Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio sudo[3718]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces state update: player Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::getState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand status Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand clear Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces system playlist update Oct 24 12:34:29 volumio volumio[987]: info: Ignoring MPD Status Update Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseTrackInfo Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand add "USB/volumio/上海歌姬/上海歌姬[无损]-林宝.flac" Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseTrackInfo Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::servicePushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"(12) [Margie Gibson] Be Careful, It's My Heart - Say It Isn't So.wav","artist":null,"album":"喇叭花精选名盘","uri":"USB/volumio/Margie Gibson(玛姬吉伯森) Say It With Music(以乐代言)/(12) [Margie Gibson] Be Careful, It's My Heart - Say It Isn't So.wav","trackType":"wav"} Oct 24 12:34:29 volumio volumio[987]: info: CURRENT POSITION 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState stateService stop Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus stop Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio sudo[3727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio volumio[987]: info: No code Oct 24 12:34:29 volumio sudo[3727]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio sudo[3727]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio sudo[3731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::pushError Oct 24 12:34:29 volumio volumio[987]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Oct 24 12:34:29 volumio volumio[987]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:295:72) Oct 24 12:34:29 volumio volumio[987]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 24 12:34:29 volumio volumio[987]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Oct 24 12:34:29 volumio volumio[987]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 77ms Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 71ms Oct 24 12:34:29 volumio sudo[3739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces system playlist update Oct 24 12:34:29 volumio volumio[987]: info: Ignoring MPD Status Update Oct 24 12:34:29 volumio sudo[3731]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces system playlist update Oct 24 12:34:29 volumio volumio[987]: info: Ignoring MPD Status Update Oct 24 12:34:29 volumio sudo[3739]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 69ms Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 7ms Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand play Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces system playlist update Oct 24 12:34:29 volumio volumio[987]: info: Ignoring MPD Status Update Oct 24 12:34:29 volumio sudo[3731]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio sudo[3739]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 11ms Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 8ms Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces state update: player Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::getState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand status Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces state update: player Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::getState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand status Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces state update: player Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::getState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand status Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseTrackInfo Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::servicePushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"上海歌姬","artist":"林宝","album":"上海歌姬","uri":"USB/volumio/上海歌姬/上海歌姬[无损]-林宝.flac","trackType":"flac"} Oct 24 12:34:29 volumio volumio[987]: info: CURRENT POSITION 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState stateService play Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus stop Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 26ms Oct 24 12:34:29 volumio volumio[987]: info: Oct 24 12:34:29 volumio volumio[987]: ---------------------------- MPD announces state update: player Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::getState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand status Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseTrackInfo Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseState Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::servicePushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio sudo[3754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio sudo[3754]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio sudo[3754]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio volumio[987]: info: STATE SERVICE {"status":"play","position":0,"seek":69,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"上海歌姬","artist":"林宝","album":"上海歌姬","uri":"USB/volumio/上海歌姬/上海歌姬[无损]-林宝.flac","trackType":"flac"} Oct 24 12:34:29 volumio volumio[987]: info: CURRENT POSITION 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState stateService play Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus play Oct 24 12:34:29 volumio volumio[987]: info: Received an update from plugin. extracting info from payload Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio sudo[3761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio sudo[3761]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio volumio[987]: info: sending command... Oct 24 12:34:29 volumio sudo[3761]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 78ms Oct 24 12:34:29 volumio sudo[3768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio sudo[3768]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio sudo[3768]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: parsing response... Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseTrackInfo Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::parseTrackInfo Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::servicePushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"上海歌姬","artist":"林宝","album":"上海歌姬","uri":"USB/volumio/上海歌姬/上海歌姬[无损]-林宝.flac","trackType":"flac"} Oct 24 12:34:29 volumio volumio[987]: info: CURRENT POSITION 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState stateService play Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus play Oct 24 12:34:29 volumio volumio[987]: info: Received an update from plugin. extracting info from payload Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio sudo[3781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio volumio[987]: info: ControllerMpd::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::servicePushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"上海歌姬","artist":"林宝","album":"上海歌姬","uri":"USB/volumio/上海歌姬/上海歌姬[无损]-林宝.flac","trackType":"flac"} Oct 24 12:34:29 volumio volumio[987]: info: CURRENT POSITION 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState stateService play Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus play Oct 24 12:34:29 volumio volumio[987]: info: Received an update from plugin. extracting info from payload Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio sudo[3781]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio sudo[3785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio sudo[3781]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio sudo[3785]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::pushState Oct 24 12:34:29 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:29 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Oct 24 12:34:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 12:34:29 volumio sudo[3785]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio sudo[3793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio sudo[3793]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:29 volumio sudo[3793]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 183ms Oct 24 12:34:29 volumio volumio[987]: info: ------------------------------ 161ms Oct 24 12:34:29 volumio sudo[3803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 12:34:29 volumio sudo[3803]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 12:34:30 volumio sudo[3803]: pam_unix(sudo:session): session closed for user root Oct 24 12:34:30 volumio startx[741]: {'album': '\xe5\x96\x87\xe5\x8f\xad\xe8\x8a\xb1\xe7\xb2\xbe\xe9\x80\x89\xe5\x90\x8d\xe7\x9b\x98', 'pos': '0', 'last-modified': '2020-03-25T06:23:16Z', 'file': 'USB/volumio/Margie Gibson(\xe7\x8e\x9b\xe5\xa7\xac\xe5\x90\x89\xe4\xbc\xaf\xe6\xa3\xae) Say It With Music(\xe4\xbb\xa5\xe4\xb9\x90\xe4\xbb\xa3\xe8\xa8\x80)/(08) [Margie Gibson] You Keep Coming Back Like a Song.wav', 'time': '214', 'duration': '214.226', 'id': '25'} Oct 24 12:34:30 volumio startx[741]: {'songid': '25', 'playlistlength': '1', 'playlist': '51', 'repeat': '0', 'consume': '1', 'mixrampdb': '0.000000', 'random': '0', 'state': 'play', 'elapsed': '0.743', 'volume': '100', 'single': '0', 'time': '1:214', 'duration': '214.226', 'song': '0', 'audio': '44100:16:2', 'bitrate': '0'} Oct 24 12:34:30 volumio startx[741]: Create Threading to get Cover!! Oct 24 12:34:30 volumio startx[741]: Getting.....so abort! Oct 24 12:34:30 volumio startx[741]: All pass! the cover updated Oct 24 12:34:30 volumio startx[741]: {'album': '\xe5\x96\x87\xe5\x8f\xad\xe8\x8a\xb1\xe7\xb2\xbe\xe9\x80\x89\xe5\x90\x8d\xe7\x9b\x98', 'pos': '0', 'last-modified': '2020-03-25T06:23:53Z', 'file': "USB/volumio/Margie Gibson(\xe7\x8e\x9b\xe5\xa7\xac\xe5\x90\x89\xe4\xbc\xaf\xe6\xa3\xae) Say It With Music(\xe4\xbb\xa5\xe4\xb9\x90\xe4\xbb\xa3\xe8\xa8\x80)/(09) [Margie Gibson] Alexander's Ragtime Band.wav", 'time': '134', 'duration': '134.453', 'id': '26'} Oct 24 12:34:30 volumio startx[741]: {'songid': '26', 'playlistlength': '1', 'playlist': '53', 'repeat': '0', 'consume': '1', 'mixrampdb': '0.000000', 'random': '0', 'state': 'play', 'elapsed': '0.673', 'volume': '100', 'single': '0', 'time': '1:134', 'duration': '134.453', 'song': '0', 'audio': '44100:16:2', 'bitrate': '0'} Oct 24 12:34:30 volumio startx[741]: Create Threading to get Cover!! Oct 24 12:34:30 volumio startx[741]: All pass! the cover updated Oct 24 12:34:30 volumio startx[741]: {'album': '\xe5\x96\x87\xe5\x8f\xad\xe8\x8a\xb1\xe7\xb2\xbe\xe9\x80\x89\xe5\x90\x8d\xe7\x9b\x98', 'pos': '0', 'last-modified': '2020-03-25T06:22:56Z', 'file': 'USB/volumio/Margie Gibson(\xe7\x8e\x9b\xe5\xa7\xac\xe5\x90\x89\xe4\xbc\xaf\xe6\xa3\xae) Say It With Music(\xe4\xbb\xa5\xe4\xb9\x90\xe4\xbb\xa3\xe8\xa8\x80)/(10) [Margie Gibson] Say It With Music - How Deep is the Ocean.wav', 'time': '280', 'duration': '279.626', 'id': '27'} Oct 24 12:34:30 volumio startx[741]: {'songid': '27', 'playlistlength': '1', 'playlist': '55', 'repeat': '0', 'consume': '1', 'mixrampdb': '0.000000', 'random': '0', 'state': 'play', 'elapsed': '0.348', 'volume': '100', 'single': '0', 'time': '0:280', 'duration': '279.626', 'song': '0', 'audio': '44100:16:2', 'bitrate': '0'} Oct 24 12:34:30 volumio startx[741]: Create Threading to get Cover!! Oct 24 12:34:30 volumio startx[741]: All pass! the cover updated Oct 24 12:34:30 volumio startx[741]: {'album': '\xe5\x96\x87\xe5\x8f\xad\xe8\x8a\xb1\xe7\xb2\xbe\xe9\x80\x89\xe5\x90\x8d\xe7\x9b\x98', 'pos': '0', 'last-modified': '2020-03-25T06:22:56Z', 'file': "USB/volumio/Margie Gibson(\xe7\x8e\x9b\xe5\xa7\xac\xe5\x90\x89\xe4\xbc\xaf\xe6\xa3\xae) Say It With Music(\xe4\xbb\xa5\xe4\xb9\x90\xe4\xbb\xa3\xe8\xa8\x80)/(11) [Margie Gibson] Love and the Weather - It's a Lovely Day Tomorrow - Blue Skies - It's a Lovel....wav", 'time': '378', 'duration': '378.266', 'id': '28'} Oct 24 12:34:30 volumio startx[741]: {'songid': '28', 'playlistlength': '1', 'playlist': '57', 'repeat': '0', 'consume': '1', 'mixrampdb': '0.000000', 'random': '0', 'state': 'play', 'elapsed': '0.859', 'volume': '100', 'single': '0', 'time': '1:378', 'duration': '378.266', 'song': '0', 'audio': '44100:16:2', 'bitrate': '0'} Oct 24 12:34:30 volumio startx[741]: Create Threading to get Cover!! Oct 24 12:34:30 volumio startx[741]: Getting.....so abort! Oct 24 12:34:30 volumio startx[741]: Getting.....so abort! Oct 24 12:34:30 volumio startx[741]: All pass! the cover updated Oct 24 12:34:30 volumio startx[741]: {'album': '\xe5\x96\x87\xe5\x8f\xad\xe8\x8a\xb1\xe7\xb2\xbe\xe9\x80\x89\xe5\x90\x8d\xe7\x9b\x98', 'pos': '0', 'last-modified': '2020-03-25T06:22:44Z', 'file': "USB/volumio/Margie Gibson(\xe7\x8e\x9b\xe5\xa7\xac\xe5\x90\x89\xe4\xbc\xaf\xe6\xa3\xae) Say It With Music(\xe4\xbb\xa5\xe4\xb9\x90\xe4\xbb\xa3\xe8\xa8\x80)/(12) [Margie Gibson] Be Careful, It's My Heart - Say It Isn't So.wav", 'time': '203', 'duration': '202.986', 'id': '29'} Oct 24 12:34:30 volumio startx[741]: {'songid': '29', 'playlistlength': '1', 'playlist': '59', 'repeat': '0', 'consume': '1', 'mixrampdb': '0.000000', 'random': '0', 'state': 'play', 'elapsed': '0.882', 'volume': '100', 'single': '0', 'time': '1:203', 'duration': '202.986', 'song': '0', 'audio': '44100:16:2', 'bitrate': '0'} Oct 24 12:34:30 volumio startx[741]: Create Threading to get Cover!! Oct 24 12:34:30 volumio startx[741]: All pass! the cover updated Oct 24 12:34:30 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Oct 24 12:34:30 volumio volumio[987]: info: CoreStateMachine::getState Oct 24 12:34:30 volumio volumio[987]: info: CorePlayQueue::getTrack 697 Oct 24 12:35:04 volumio volumio[987]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 12:35:04 volumio volumio[987]: { Error: connect ETIMEDOUT 52.58.1.161:443 Oct 24 12:35:04 volumio volumio[987]: at Object._errnoException (util.js:1022:11) Oct 24 12:35:04 volumio volumio[987]: at _exceptionWithHostPort (util.js:1044:20) Oct 24 12:35:04 volumio volumio[987]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 24 12:35:04 volumio volumio[987]: code: 'ETIMEDOUT', Oct 24 12:35:04 volumio volumio[987]: errno: 'ETIMEDOUT', Oct 24 12:35:04 volumio volumio[987]: syscall: 'connect', Oct 24 12:35:04 volumio volumio[987]: address: '52.58.1.161', Oct 24 12:35:04 volumio volumio[987]: port: 443 } Oct 24 12:35:04 volumio volumio[987]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 12:35:04 volumio sudo[3827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-24 12:34 Oct 24 12:35:04 volumio sudo[3827]: 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="80e3a7415791a01dac7cd7cc2cc0a3d3fc65ba9d" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="e32e25d68d93383fe73e2a451c032b2661c71694" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jan 20 19:41:22 CET 2020" VOLUMIO_VERSION="2.699" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5faefe8928fcf34b6263aec4aa82825a"