-- Logs begin at Sat 2025-06-14 21:48:31 +10, end at Mon 2025-06-16 16:51:23 +10. -- Jun 16 16:50:02 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Jun 16 16:50:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:50:05 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 16 16:50:05 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 16 16:50:07 volumio volumio[1083]: info: Enabling plugin minidlna Jun 16 16:50:07 volumio volumio[1083]: info: Loading plugin "minidlna"... Jun 16 16:50:07 volumio volumio[1083]: info: Applying required configuration parameters for plugin minidlna Jun 16 16:50:08 volumio volumio[1083]: info: PLUGIN START: minidlna Jun 16 16:50:08 volumio volumio[1083]: info: Loading i18n strings for locale ru Jun 16 16:50:08 volumio volumio[1083]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Jun 16 16:50:08 volumio volumio[1083]: info: minidlna: Found miniDLNA version 1.2.1 Jun 16 16:50:08 volumio volumio[1083]: info: minidlna: Starting minidlna.service Jun 16 16:50:08 volumio sudo[20146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Jun 16 16:50:08 volumio sudo[20146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 16 16:50:08 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Jun 16 16:50:08 volumio sudo[20146]: pam_unix(sudo:session): session closed for user root Jun 16 16:50:08 volumio volumio[1083]: info: minidlna: systemctl start minidlna.service succeeded. Jun 16 16:50:08 volumio volumio[1083]: info: Done. Jun 16 16:50:10 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 16 16:50:16 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Jun 16 16:50:16 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:50:17 volumio volumio[1083]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT Jun 16 16:50:21 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 16 16:50:21 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 16 16:50:28 volumio volumio[1083]: info: [1750056628955] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Jun 16 16:50:29 volumio volumio[1083]: info: [1750056629973] [RadioParadise] received new metadata: {"time":241,"artist":"Euphoria","title":"Blue (Bombay Mix)","album":"Precious Time","year":"2006","cover":"https://img.radioparadise.com/covers/l/B000ERU8CY.jpg","cover_med":"https://img.radioparadise.com/covers/m/B000ERU8CY.jpg","cover_small":"https://img.radioparadise.com/covers/s/B000ERU8CY.jpg"} Jun 16 16:50:29 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:50:29 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 16 16:50:29 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:50:29 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B000ERU8CY.jpg","uri":"http://stream.radioparadise.com/radio2050-flac","name":"Blue (Bombay Mix)","title":"Blue (Bombay Mix)","artist":"Euphoria","album":"Precious Time","streaming":true,"disableUiControls":true,"duration":246,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jun 16 16:50:29 volumio volumio[1083]: verbose: CURRENT POSITION 4 Jun 16 16:50:29 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 16 16:50:29 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 16 16:50:29 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 16 16:50:29 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 16 16:50:29 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:50:29 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 16 16:50:29 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 16 16:50:29 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 16 16:50:29 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:50:29 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 16 16:50:29 volumio volumio[1083]: info: [1750056629975] [RadioParadise] setting new timer with duration of 246000 seconds. Jun 16 16:50:29 volumio volumio[1083]: info: CoreCommandRouter::volumioGetQueue Jun 16 16:50:29 volumio volumio[1083]: info: CoreStateMachine::getQueue Jun 16 16:50:29 volumio volumio[1083]: info: CorePlayQueue::getQueue Jun 16 16:50:30 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:50:30 volumio volumio[1083]: info: CorePlayQueue::getTrack 5 Jun 16 16:50:32 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Jun 16 16:50:32 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:50:33 volumio volumio[1083]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT Jun 16 16:50:35 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 16 16:50:35 volumio volumio[1083]: info: Preload queue cleared Jun 16 16:50:45 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Jun 16 16:50:45 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 16 16:50:46 volumio volumio[1083]: info: Retrieving Cloud Streaming UI Jun 16 16:50:46 volumio volumio[1083]: info: Getting Tidal Cloud Configuration Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 16 16:50:46 volumio volumio[1083]: info: Getting Qobuz Cloud Configuration Jun 16 16:50:46 volumio volumio[1083]: info: Asking plugin for UI Config Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 16 16:50:46 volumio volumio[1083]: info: Getting Spotify Cloud Configuration Jun 16 16:50:46 volumio volumio[1083]: info: Asking plugin for UI Config Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 16 16:50:46 volumio volumio[1083]: info: Saving Spotify Acccount Jun 16 16:50:46 volumio volumio[1083]: info: Got Tidal Cloud Configuration Jun 16 16:50:46 volumio volumio[1083]: info: Got it Jun 16 16:50:46 volumio volumio[1083]: info: Got it Jun 16 16:50:46 volumio volumio[1083]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 16 16:50:46 volumio volumio[1083]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::volumioGetBrowseSources Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::volumioGetBrowseSources Jun 16 16:50:46 volumio volumio[1083]: info: CoreCommandRouter::volumioGetBrowseSources Jun 16 16:50:47 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 16 16:50:47 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 16 16:50:51 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 16 16:50:55 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 16 16:50:59 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 16 16:51:01 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Jun 16 16:51:01 volumio volumio[1083]: info: CorePlayQueue::getTrack 4 Jun 16 16:51:06 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 16 16:51:06 volumio volumio[1083]: info: Preload queue cleared Jun 16 16:51:08 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 16 16:51:08 volumio volumio[1083]: info: Preload queue cleared Jun 16 16:51:18 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 16 16:51:18 volumio volumio[1083]: info: Preload queue cleared Jun 16 16:51:19 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 16 16:51:19 volumio volumio[1083]: info: Preload queue cleared Jun 16 16:51:21 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 16 16:51:21 volumio volumio[1083]: info: Preload queue cleared Jun 16 16:51:23 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 16 16:51:23 volumio volumio[1083]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 16 16:51:23 volumio volumio[1083]: TypeError: Cannot read property 'length' of undefined Jun 16 16:51:23 volumio volumio[1083]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jun 16 16:51:23 volumio volumio[1083]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jun 16 16:51:23 volumio volumio[1083]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jun 16 16:51:23 volumio volumio[1083]: at Parser.emit (events.js:400:28) Jun 16 16:51:23 volumio volumio[1083]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jun 16 16:51:23 volumio volumio[1083]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jun 16 16:51:23 volumio volumio[1083]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jun 16 16:51:23 volumio volumio[1083]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jun 16 16:51:23 volumio volumio[1083]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jun 16 16:51:23 volumio volumio[1083]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jun 16 16:51:23 volumio volumio[1083]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jun 16 16:51:23 volumio volumio[1083]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jun 16 16:51:23 volumio volumio[1083]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jun 16 16:51:23 volumio volumio[1083]: at IncomingMessage.emit (events.js:412:35) Jun 16 16:51:23 volumio volumio[1083]: at endReadableNT (internal/streams/readable.js:1333:12) Jun 16 16:51:23 volumio volumio[1083]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jun 16 16:51:23 volumio volumio[1083]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 16 16:51:23 volumio sudo[20486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-16 16:50 Jun 16 16:51:23 volumio sudo[20486]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"