-- Logs begin at Fri 2025-10-24 08:10:20 +03, end at Fri 2025-10-24 09:28:19 +03. -- Oct 24 09:27:59 volumio volumio[1026]: verbose: New Socket.io Connection to 192.168.1.81:3000 from 192.168.1.72 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Oct 24 09:28:00 volumio volumio[1026]: verbose: New Socket.io Connection to 192.168.1.81 from 192.168.1.72 UA: Mozilla/5.0 (Linux; Android 15; CPH2645 Build/UKQ1.231108.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/140.0.7339.209 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 24 09:28:00 volumio volumio[1026]: info: CoreCommandRouter::volumioGetState Oct 24 09:28:00 volumio volumio[1026]: info: CorePlayQueue::getTrack 0 Oct 24 09:28:00 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 24 09:28:00 volumio volumio[1026]: error: Could not retrieve plugin audio_interface multiroom Oct 24 09:28:00 volumio volumio[1026]: info: Listing playlists Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::volumioPause Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::pause Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::stPlaybackTimer Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::servicePause Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getTrack 0 Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::servicePause Oct 24 09:28:03 volumio volumio[1026]: info: [1761287283661] ControllerUPNPBrowser::pause Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::sendMpdCommand pause Oct 24 09:28:03 volumio volumio[1026]: info: sendMpdCommand pause took 1 milliseconds Oct 24 09:28:03 volumio volumio[1026]: info: Oct 24 09:28:03 volumio volumio[1026]: ---------------------------- MPD announces state update: player Oct 24 09:28:03 volumio volumio[1026]: info: ControllerMpd::getState Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Oct 24 09:28:03 volumio volumio[1026]: info: Oct 24 09:28:03 volumio volumio[1026]: ---------------------------- MPD announces state update: player Oct 24 09:28:03 volumio volumio[1026]: info: ControllerMpd::getState Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Oct 24 09:28:03 volumio volumio[1026]: info: Oct 24 09:28:03 volumio volumio[1026]: ---------------------------- MPD announces state update: player Oct 24 09:28:03 volumio volumio[1026]: info: ControllerMpd::getState Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Oct 24 09:28:03 volumio volumio[1026]: info: sendMpdCommand status took 2 milliseconds Oct 24 09:28:03 volumio volumio[1026]: info: sendMpdCommand status took 2 milliseconds Oct 24 09:28:03 volumio volumio[1026]: info: sendMpdCommand status took 1 milliseconds Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::parseState Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::parseState Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::parseState Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 09:28:03 volumio volumio[1026]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 24 09:28:03 volumio volumio[1026]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 24 09:28:03 volumio volumio[1026]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::parseTrackInfo Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::parseTrackInfo Oct 24 09:28:03 volumio volumio[1026]: verbose: ControllerMpd::parseTrackInfo Oct 24 09:28:03 volumio volumio[1026]: info: ControllerMpd::pushState Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::servicePushState Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getTrack 0 Oct 24 09:28:03 volumio volumio[1026]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3128151,"duration":3546,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"459 Kbps","isStreaming":false,"title":"Electro Magnetic In E","artist":"Eivind Aarset","album":"Connected","uri":"http://192.168.1.54:9050/disk/NON-DLNA-OP01-FLAGS01700000/O0$1$8I1606155.flac","trackType":"flac"} Oct 24 09:28:03 volumio volumio[1026]: verbose: CURRENT POSITION 0 Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::syncState stateService pause Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::syncState currentStatus pause Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::pushState Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getTrack 0 Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::volumioPushState Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::stPlaybackTimer Oct 24 09:28:03 volumio volumio[1026]: info: ControllerMpd::pushState Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::servicePushState Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getTrack 0 Oct 24 09:28:03 volumio volumio[1026]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3128151,"duration":3546,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"459 Kbps","isStreaming":false,"title":"Electro Magnetic In E","artist":"Eivind Aarset","album":"Connected","uri":"http://192.168.1.54:9050/disk/NON-DLNA-OP01-FLAGS01700000/O0$1$8I1606155.flac","trackType":"flac"} Oct 24 09:28:03 volumio volumio[1026]: verbose: CURRENT POSITION 0 Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::syncState stateService pause Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::syncState currentStatus pause Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::pushState Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getTrack 0 Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::volumioPushState Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::stPlaybackTimer Oct 24 09:28:03 volumio volumio[1026]: info: ControllerMpd::pushState Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::servicePushState Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getTrack 0 Oct 24 09:28:03 volumio volumio[1026]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3128151,"duration":3546,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"459 Kbps","isStreaming":false,"title":"Electro Magnetic In E","artist":"Eivind Aarset","album":"Connected","uri":"http://192.168.1.54:9050/disk/NON-DLNA-OP01-FLAGS01700000/O0$1$8I1606155.flac","trackType":"flac"} Oct 24 09:28:03 volumio volumio[1026]: verbose: CURRENT POSITION 0 Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::syncState stateService pause Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::syncState currentStatus pause Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::pushState Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getTrack 0 Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::volumioPushState Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::stPlaybackTimer Oct 24 09:28:03 volumio volumio[1026]: info: ------------------------------ 30ms Oct 24 09:28:03 volumio volumio[1026]: info: ------------------------------ 30ms Oct 24 09:28:03 volumio volumio[1026]: info: ------------------------------ 30ms Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::volumioGetQueue Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::getQueue Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getQueue Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::volumioGetQueue Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::getQueue Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getQueue Oct 24 09:28:03 volumio volumio[1026]: info: CoreCommandRouter::volumioGetQueue Oct 24 09:28:03 volumio volumio[1026]: info: CoreStateMachine::getQueue Oct 24 09:28:03 volumio volumio[1026]: info: CorePlayQueue::getQueue Oct 24 09:28:04 volumio volumio[1026]: info: CoreCommandRouter::volumioGetVisibleSources Oct 24 09:28:04 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 24 09:28:04 volumio volumio[1026]: info: CoreCommandRouter::volumioGetQueue Oct 24 09:28:04 volumio volumio[1026]: info: CoreStateMachine::getQueue Oct 24 09:28:04 volumio volumio[1026]: info: CorePlayQueue::getQueue Oct 24 09:28:06 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 24 09:28:06 volumio volumio[1026]: info: Preload queue cleared Oct 24 09:28:13 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 24 09:28:13 volumio volumio[1026]: info: CURURI: music-library Oct 24 09:28:13 volumio volumio[1026]: error: Failed LSINFO: null Oct 24 09:28:13 volumio volumio[1026]: info: Preload queue cleared Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 09:28:15 volumio volumio[1026]: error: Could not retrieve plugin music_service streaming_services Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::volumioGetBrowseSources Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::volumioGetBrowseSources Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::volumioGetBrowseSources Oct 24 09:28:15 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 09:28:16 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 24 09:28:18 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 24 09:28:18 volumio volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 24 09:28:19 volumio volumio[1026]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 09:28:19 volumio volumio[1026]: Error: getaddrinfo -3007 Oct 24 09:28:19 volumio volumio[1026]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Oct 24 09:28:19 volumio volumio[1026]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Oct 24 09:28:19 volumio volumio[1026]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Oct 24 09:28:19 volumio volumio[1026]: code: -3007, Oct 24 09:28:19 volumio volumio[1026]: errno: -3007, Oct 24 09:28:19 volumio volumio[1026]: syscall: 'getaddrinfo' Oct 24 09:28:19 volumio volumio[1026]: } Oct 24 09:28:19 volumio volumio[1026]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 09:28:19 volumio sudo[19632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-24 09:27 Oct 24 09:28:19 volumio sudo[19632]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Nov 25 05:13:21 AM UTC 2024" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="vim3" VOLUMIO_DEVICENAME="Khadas VIM3" VOLUMIO_HASH="074917d1ca9e9870e4f3627f241e04c9"