-- Logs begin at Tue 2025-04-29 00:12:56 CST, end at Thu 2025-05-01 18:18:01 CST. -- May 01 18:17:02 volumio-best volumio[1345]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 01 18:17:02 volumio-best volumio[1345]: info: Retrying Login Due to Network Error May 01 18:17:10 volumio-best volumio[1345]: info: Clearing queue after UPNP request May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::ClearQueue May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::stop May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 18:17:11 volumio-best volumio[1345]: info: CorePlayQueue::clearPlayQueue May 01 18:17:11 volumio-best volumio[1345]: info: CorePlayQueue::saveQueue May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::volumioPushState May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::volumioPushQueue May 01 18:17:11 volumio-best volumio[1345]: info: May 01 18:17:11 volumio-best volumio[1345]: ---------------------------- MPD announces system playlist update May 01 18:17:11 volumio-best volumio[1345]: info: Ignoring MPD Status Update May 01 18:17:11 volumio-best volumio[1345]: error: updateQueue error: null May 01 18:17:11 volumio-best volumio[1345]: info: ------------------------------ 6ms May 01 18:17:11 volumio-best volumio[1345]: info: Starting UPNP Playback May 01 18:17:11 volumio-best volumio[1345]: info: Preparing playback through UPNP May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::volumioGetState May 01 18:17:11 volumio-best volumio[1345]: info: CorePlayQueue::getTrack 0 May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::setConsumeUpdateService mpd May 01 18:17:11 volumio-best volumio[1345]: info: May 01 18:17:11 volumio-best volumio[1345]: ---------------------------- MPD announces system playlist update May 01 18:17:11 volumio-best volumio[1345]: info: Ignoring MPD Status Update May 01 18:17:11 volumio-best volumio[1345]: info: May 01 18:17:11 volumio-best volumio[1345]: ---------------------------- MPD announces system playlist update May 01 18:17:11 volumio-best volumio[1345]: info: Ignoring MPD Status Update May 01 18:17:11 volumio-best volumio[1345]: info: ------------------------------ 2ms May 01 18:17:11 volumio-best volumio[1345]: info: ------------------------------ 2ms May 01 18:17:11 volumio-best volumio[1345]: info: May 01 18:17:11 volumio-best volumio[1345]: ---------------------------- MPD announces system playlist update May 01 18:17:11 volumio-best volumio[1345]: info: Ignoring MPD Status Update May 01 18:17:11 volumio-best volumio[1345]: info: ------------------------------ 1ms May 01 18:17:11 volumio-best volumio[1345]: info: May 01 18:17:11 volumio-best volumio[1345]: ---------------------------- MPD announces system playlist update May 01 18:17:11 volumio-best volumio[1345]: info: Ignoring MPD Status Update May 01 18:17:11 volumio-best volumio[1345]: info: ------------------------------ 1ms May 01 18:17:11 volumio-best volumio[1345]: info: May 01 18:17:11 volumio-best volumio[1345]: ---------------------------- MPD announces system playlist update May 01 18:17:11 volumio-best volumio[1345]: info: Ignoring MPD Status Update May 01 18:17:11 volumio-best volumio[1345]: info: ------------------------------ 4ms May 01 18:17:11 volumio-best volumio[1345]: info: May 01 18:17:11 volumio-best volumio[1345]: ---------------------------- MPD announces system playlist update May 01 18:17:11 volumio-best volumio[1345]: info: Ignoring MPD Status Update May 01 18:17:11 volumio-best volumio[1345]: info: ------------------------------ 0ms May 01 18:17:11 volumio-best volumio[1345]: info: May 01 18:17:11 volumio-best volumio[1345]: ---------------------------- MPD announces state update: player May 01 18:17:11 volumio-best volumio[1345]: info: ControllerMpd::getState May 01 18:17:11 volumio-best volumio[1345]: verbose: ControllerMpd::sendMpdCommand status May 01 18:17:11 volumio-best volumio[1345]: info: May 01 18:17:11 volumio-best volumio[1345]: ---------------------------- MPD announces state update: player May 01 18:17:11 volumio-best volumio[1345]: info: sendMpdCommand status took 20 milliseconds May 01 18:17:11 volumio-best volumio[1345]: info: ControllerMpd::getState May 01 18:17:11 volumio-best volumio[1345]: verbose: ControllerMpd::sendMpdCommand status May 01 18:17:11 volumio-best volumio[1345]: verbose: ControllerMpd::parseState May 01 18:17:11 volumio-best volumio[1345]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:17:11 volumio-best volumio[1345]: info: sendMpdCommand status took 2 milliseconds May 01 18:17:11 volumio-best volumio[1345]: info: sendMpdCommand playlistinfo took 1 milliseconds May 01 18:17:11 volumio-best volumio[1345]: verbose: ControllerMpd::parseState May 01 18:17:11 volumio-best volumio[1345]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:17:11 volumio-best volumio[1345]: verbose: ControllerMpd::parseTrackInfo May 01 18:17:11 volumio-best kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000010] -121 May 01 18:17:11 volumio-best kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 May 01 18:17:11 volumio-best volumio[1345]: info: ControllerMpd::pushState May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::servicePushState May 01 18:17:11 volumio-best volumio[1345]: verbose: In UPNP mode May 01 18:17:11 volumio-best volumio[1345]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"燕归巢","artist":"许嵩","album":"青年晚报","uri":"http://m702.music.126.net/20250501184210/4ee2ba1dd0b7cb6fb0ccc26017ea5f30/jd-musicrep-ts/f5a3/8c8b/769f/d6bd2c1ee0e047e539bae1c801356023.mp3?vuutv=RVhSdcdOXbVYXOAYLB4ozTi2Qs1C553GXEAMoJ0DiL26Js+jvQH0iOKEfxRLdYIOFagm2QYYsihwm6epXG+sbZTqMF9HdeaOBvMS+A4ydDU=","trackType":""} May 01 18:17:11 volumio-best volumio[1345]: verbose: CURRENT POSITION 0 May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::syncState stateService play May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::syncState currentStatus stop May 01 18:17:11 volumio-best volumio[1345]: info: ------------------------------ 30ms May 01 18:17:11 volumio-best volumio[1345]: info: sendMpdCommand playlistinfo took 6 milliseconds May 01 18:17:11 volumio-best volumio[1345]: verbose: ControllerMpd::parseTrackInfo May 01 18:17:11 volumio-best volumio[1345]: info: ControllerMpd::pushState May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::servicePushState May 01 18:17:11 volumio-best volumio[1345]: verbose: In UPNP mode May 01 18:17:11 volumio-best volumio[1345]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"燕归巢","artist":"许嵩","album":"青年晚报","uri":"http://m702.music.126.net/20250501184210/4ee2ba1dd0b7cb6fb0ccc26017ea5f30/jd-musicrep-ts/f5a3/8c8b/769f/d6bd2c1ee0e047e539bae1c801356023.mp3?vuutv=RVhSdcdOXbVYXOAYLB4ozTi2Qs1C553GXEAMoJ0DiL26Js+jvQH0iOKEfxRLdYIOFagm2QYYsihwm6epXG+sbZTqMF9HdeaOBvMS+A4ydDU=","trackType":""} May 01 18:17:11 volumio-best volumio[1345]: verbose: CURRENT POSITION 0 May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::syncState stateService play May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::syncState currentStatus play May 01 18:17:11 volumio-best volumio[1345]: info: Received an update from plugin. extracting info from payload May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::pushState May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::volumioPushState May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::pushState May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::volumioPushState May 01 18:17:11 volumio-best volumio[1345]: info: ------------------------------ 36ms May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::volumioGetQueue May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::getQueue May 01 18:17:11 volumio-best volumio[1345]: info: CorePlayQueue::getQueue May 01 18:17:11 volumio-best volumio[1345]: info: CoreCommandRouter::volumioGetQueue May 01 18:17:11 volumio-best volumio[1345]: info: CoreStateMachine::getQueue May 01 18:17:11 volumio-best volumio[1345]: info: CorePlayQueue::getQueue May 01 18:17:12 volumio-best volumio[1345]: info: MyVolumio login type: Token May 01 18:17:12 volumio-best volumio[1345]: info: touch_display: Setting screensaver timeout to 0 seconds. May 01 18:17:12 volumio-best volumio[1345]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%AE%B8%E5%B5%A9/%E9%9D%92%E5%B9%B4%E6%99%9A%E6%8A%A5/5e5e7e92-9379-499e-aec8-8b7e0a68353e.jpg' May 01 18:17:41 volumio-best volumio[1345]: info: May 01 18:17:41 volumio-best volumio[1345]: ---------------------------- MPD announces state update: player May 01 18:17:41 volumio-best kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 May 01 18:17:41 volumio-best volumio[1345]: info: ControllerMpd::getState May 01 18:17:41 volumio-best volumio[1345]: verbose: ControllerMpd::sendMpdCommand status May 01 18:17:41 volumio-best volumio[1345]: info: sendMpdCommand status took 1 milliseconds May 01 18:17:41 volumio-best volumio[1345]: verbose: ControllerMpd::parseState May 01 18:17:41 volumio-best volumio[1345]: info: ControllerMpd::pushState May 01 18:17:41 volumio-best volumio[1345]: info: CoreCommandRouter::servicePushState May 01 18:17:41 volumio-best volumio[1345]: info: CoreStateMachine::pushState May 01 18:17:41 volumio-best volumio[1345]: info: CoreCommandRouter::volumioPushState May 01 18:17:42 volumio-best volumio[1345]: info: CorePlayQueue::getTrack 0 May 01 18:17:42 volumio-best volumio[1345]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 18:17:42 volumio-best volumio[1345]: verbose: CURRENT POSITION 0 May 01 18:17:42 volumio-best volumio[1345]: info: CoreStateMachine::syncState stateService stop May 01 18:17:42 volumio-best volumio[1345]: info: CoreStateMachine::syncState currentStatus play May 01 18:17:42 volumio-best volumio[1345]: info: CoreCommandRouter::volumioPushState May 01 18:17:42 volumio-best volumio[1345]: info: CoreStateMachine::stPlaybackTimer May 01 18:17:42 volumio-best volumio[1345]: info: ------------------------------ 39ms May 01 18:17:42 volumio-best volumio[1345]: info: CoreCommandRouter::volumioGetQueue May 01 18:17:42 volumio-best volumio[1345]: info: CoreStateMachine::getQueue May 01 18:17:42 volumio-best volumio[1345]: info: CorePlayQueue::getQueue May 01 18:17:42 volumio-best volumio[1345]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 01 18:17:42 volumio-best volumio[1345]: info: Retrying Login Due to Network Error May 01 18:17:42 volumio-best volumio[1345]: info: touch_display: Setting screensaver timeout to 60 seconds. May 01 18:17:52 volumio-best volumio[1345]: info: MyVolumio login type: Token May 01 18:18:00 volumio-best volumio[1345]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 18:18:00 volumio-best volumio[1345]: Error: connect ETIMEDOUT 108.160.172.208:443 May 01 18:18:00 volumio-best volumio[1345]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 01 18:18:00 volumio-best volumio[1345]: errno: -110, May 01 18:18:00 volumio-best volumio[1345]: code: 'ETIMEDOUT', May 01 18:18:00 volumio-best volumio[1345]: syscall: 'connect', May 01 18:18:00 volumio-best volumio[1345]: address: '108.160.172.208', May 01 18:18:00 volumio-best volumio[1345]: port: 443 May 01 18:18:00 volumio-best volumio[1345]: } May 01 18:18:00 volumio-best volumio[1345]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 18:18:01 volumio-best sudo[5100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-01 18:17 May 01 18:18:01 volumio-best sudo[5100]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"