-- Logs begin at Thu 2025-05-08 13:33:55 CST, end at Fri 2025-05-09 16:37:24 CST. -- May 09 16:36:00 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 16:36:00 volumio-rpi volumio[1304]: info: CURURI: music-library/INTERNAL May 09 16:36:00 volumio-rpi volumio[1304]: info: Preload queue cleared May 09 16:36:01 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 16:36:01 volumio-rpi volumio[1304]: info: CURURI: music-library/INTERNAL/musics May 09 16:36:01 volumio-rpi volumio[1304]: info: Preload queue cleared May 09 16:36:04 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 16:36:04 volumio-rpi volumio[1304]: info: CURURI: music-library/NAS May 09 16:36:04 volumio-rpi volumio[1304]: info: Preload queue cleared May 09 16:36:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 16:36:05 volumio-rpi volumio[1304]: info: CURURI: music-library/NAS/local May 09 16:36:05 volumio-rpi volumio[1304]: info: Preload queue cleared May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 16:36:28 volumio-rpi volumio[1304]: info: Retrieving Cloud Streaming UI May 09 16:36:28 volumio-rpi volumio[1304]: info: Getting Tidal Cloud Configuration May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 16:36:28 volumio-rpi volumio[1304]: info: Getting Qobuz Cloud Configuration May 09 16:36:28 volumio-rpi volumio[1304]: info: Asking plugin for UI Config May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 16:36:28 volumio-rpi volumio[1304]: info: Getting Spotify Cloud Configuration May 09 16:36:28 volumio-rpi volumio[1304]: info: Asking plugin for UI Config May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 16:36:28 volumio-rpi volumio[1304]: info: Saving Spotify Acccount May 09 16:36:28 volumio-rpi volumio[1304]: info: Got Tidal Cloud Configuration May 09 16:36:28 volumio-rpi volumio[1304]: info: Got it May 09 16:36:28 volumio-rpi volumio[1304]: info: Got it May 09 16:36:28 volumio-rpi volumio[1304]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 16:36:28 volumio-rpi volumio[1304]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::volumioGetBrowseSources May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::volumioGetBrowseSources May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::volumioGetBrowseSources May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:36:28 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 09 16:36:29 volumio-rpi volumio[1304]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 09 16:36:29 volumio-rpi volumio[1304]: info: Retrying Login Due to Network Error May 09 16:36:32 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:36:36 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:36:39 volumio-rpi volumio[1304]: info: MyVolumio login type: Token May 09 16:36:40 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:36:44 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:36:48 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:36:52 volumio-rpi ntpd[982]: 202.118.1.130 local addr 192.168.1.251 -> May 09 16:36:52 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:36:56 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:37:00 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:37:00 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 1 May 09 16:37:00 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:00 volumio-rpi volumio[1304]: info: Prefetching next song May 09 16:37:00 volumio-rpi volumio[1304]: info: DOING PREFETCH IN MPD May 09 16:37:00 volumio-rpi volumio[1304]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/musics/20-BEYOND专辑 42首/011.曾是拥有-BEYOND.mp3" May 09 16:37:00 volumio-rpi volumio[1304]: info: May 09 16:37:00 volumio-rpi volumio[1304]: ---------------------------- MPD announces system playlist update May 09 16:37:00 volumio-rpi volumio[1304]: info: Ignoring MPD Status Update May 09 16:37:00 volumio-rpi volumio[1304]: info: sendMpdCommand add "INTERNAL/musics/20-BEYOND专辑 42首/011.曾是拥有-BEYOND.mp3" took 1 milliseconds May 09 16:37:00 volumio-rpi volumio[1304]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 16:37:00 volumio-rpi volumio[1304]: info: ------------------------------ 1ms May 09 16:37:00 volumio-rpi volumio[1304]: info: sendMpdCommand consume 1 took 1 milliseconds May 09 16:37:04 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::startPlaybackTimer May 09 16:37:05 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:05 volumio-rpi volumio[1304]: info: May 09 16:37:05 volumio-rpi volumio[1304]: ---------------------------- MPD announces system playlist update May 09 16:37:05 volumio-rpi volumio[1304]: info: Ignoring MPD Status Update May 09 16:37:05 volumio-rpi volumio[1304]: info: May 09 16:37:05 volumio-rpi volumio[1304]: ---------------------------- MPD announces state update: player May 09 16:37:05 volumio-rpi volumio[1304]: info: ControllerMpd::getState May 09 16:37:05 volumio-rpi volumio[1304]: verbose: ControllerMpd::sendMpdCommand status May 09 16:37:05 volumio-rpi volumio[1304]: info: May 09 16:37:05 volumio-rpi volumio[1304]: ---------------------------- MPD announces state update: player May 09 16:37:05 volumio-rpi volumio[1304]: info: ControllerMpd::getState May 09 16:37:05 volumio-rpi volumio[1304]: verbose: ControllerMpd::sendMpdCommand status May 09 16:37:05 volumio-rpi volumio[1304]: info: ------------------------------ 1ms May 09 16:37:05 volumio-rpi volumio[1304]: info: sendMpdCommand status took 0 milliseconds May 09 16:37:05 volumio-rpi volumio[1304]: verbose: ControllerMpd::parseState May 09 16:37:05 volumio-rpi volumio[1304]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 16:37:05 volumio-rpi volumio[1304]: info: sendMpdCommand status took 1 milliseconds May 09 16:37:05 volumio-rpi volumio[1304]: info: sendMpdCommand playlistinfo took 0 milliseconds May 09 16:37:05 volumio-rpi volumio[1304]: verbose: ControllerMpd::parseState May 09 16:37:05 volumio-rpi volumio[1304]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 16:37:05 volumio-rpi volumio[1304]: verbose: ControllerMpd::parseTrackInfo May 09 16:37:05 volumio-rpi volumio[1304]: info: ControllerMpd::pushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::servicePushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:05 volumio-rpi volumio[1304]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"曾是拥有","artist":"Beyond(深度音像店)","album":"黄家驹原作精选集(HiFi立体环绕音质)","uri":"INTERNAL/musics/20-BEYOND专辑 42首/011.曾是拥有-BEYOND.mp3","trackType":"mp3"} May 09 16:37:05 volumio-rpi volumio[1304]: verbose: CURRENT POSITION 2 May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::syncState stateService play May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::syncState currentStatus play May 09 16:37:05 volumio-rpi volumio[1304]: info: Received an update from plugin. extracting info from payload May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::pushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::volumioPushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::pushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::volumioPushState May 09 16:37:05 volumio-rpi volumio[1304]: info: ------------------------------ 18ms May 09 16:37:05 volumio-rpi volumio[1304]: info: sendMpdCommand playlistinfo took 17 milliseconds May 09 16:37:05 volumio-rpi volumio[1304]: verbose: ControllerMpd::parseTrackInfo May 09 16:37:05 volumio-rpi volumio[1304]: info: ControllerMpd::pushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::servicePushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:05 volumio-rpi volumio[1304]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"曾是拥有","artist":"Beyond(深度音像店)","album":"黄家驹原作精选集(HiFi立体环绕音质)","uri":"INTERNAL/musics/20-BEYOND专辑 42首/011.曾是拥有-BEYOND.mp3","trackType":"mp3"} May 09 16:37:05 volumio-rpi volumio[1304]: verbose: CURRENT POSITION 2 May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::syncState stateService play May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::syncState currentStatus play May 09 16:37:05 volumio-rpi volumio[1304]: info: Received an update from plugin. extracting info from payload May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::pushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::volumioPushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::pushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::volumioPushState May 09 16:37:05 volumio-rpi volumio[1304]: info: ------------------------------ 31ms May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreStateMachine::pushState May 09 16:37:05 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 16:37:05 volumio-rpi volumio[1304]: info: CoreCommandRouter::volumioPushState May 09 16:37:07 volumio-rpi volumio[1304]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 May 09 16:37:07 volumio-rpi volumio[1304]: info: CoreCommandRouter::volumioGetState May 09 16:37:07 volumio-rpi volumio[1304]: info: CorePlayQueue::getTrack 2 May 09 16:37:08 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:37:09 volumio-rpi volumio[1304]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 09 16:37:09 volumio-rpi volumio[1304]: info: Retrying Login Due to Network Error May 09 16:37:12 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:37:16 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:37:19 volumio-rpi volumio[1304]: info: MyVolumio login type: Token May 09 16:37:20 volumio-rpi volumio[1304]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 16:37:24 volumio-rpi volumio[1304]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 16:37:24 volumio-rpi volumio[1304]: Error: connect ETIMEDOUT 192.133.77.189:80 May 09 16:37:24 volumio-rpi volumio[1304]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 09 16:37:24 volumio-rpi volumio[1304]: errno: -110, May 09 16:37:24 volumio-rpi volumio[1304]: code: 'ETIMEDOUT', May 09 16:37:24 volumio-rpi volumio[1304]: syscall: 'connect', May 09 16:37:24 volumio-rpi volumio[1304]: address: '192.133.77.189', May 09 16:37:24 volumio-rpi volumio[1304]: port: 80 May 09 16:37:24 volumio-rpi volumio[1304]: } May 09 16:37:24 volumio-rpi volumio[1304]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 16:37:24 volumio-rpi sudo[6599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-09 16:36 May 09 16:37:24 volumio-rpi sudo[6599]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"