-- Logs begin at Sat 2024-05-04 09:15:54 CEST, end at Sat 2024-05-04 09:42:06 CEST. -- May 04 09:41:05 audionuc ntpd[1433]: 80.50.102.114 local addr 192.168.1.32 -> May 04 09:41:06 audionuc volumio[840]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:41:06 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 04 09:41:06 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 04 09:41:06 audionuc sudo[8485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 04 09:41:06 audionuc sudo[8485]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:41:06 audionuc sudo[8485]: pam_unix(sudo:session): session closed for user root May 04 09:41:06 audionuc sudo[8492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 04 09:41:06 audionuc sudo[8492]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:41:06 audionuc sudo[8492]: pam_unix(sudo:session): session closed for user root May 04 09:41:06 audionuc sudo[8501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 04 09:41:06 audionuc sudo[8501]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:41:06 audionuc sudo[8501]: pam_unix(sudo:session): session closed for user root May 04 09:41:06 audionuc sudo[8506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 04 09:41:06 audionuc sudo[8506]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:41:06 audionuc sudo[8506]: pam_unix(sudo:session): session closed for user root May 04 09:41:06 audionuc sudo[8512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 04 09:41:06 audionuc sudo[8512]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:41:06 audionuc sudo[8512]: pam_unix(sudo:session): session closed for user root May 04 09:41:06 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 04 09:41:06 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 04 09:41:06 audionuc sudo[8515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 04 09:41:06 audionuc sudo[8515]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:41:06 audionuc sudo[8515]: pam_unix(sudo:session): session closed for user root May 04 09:41:06 audionuc sudo[8518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 04 09:41:06 audionuc sudo[8518]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:41:06 audionuc sudo[8518]: pam_unix(sudo:session): session closed for user root May 04 09:41:06 audionuc volumio[840]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 04 09:41:06 audionuc volumio[840]: wlan0 Interface doesn't support scanning : Operation not supported May 04 09:41:06 audionuc volumio[840]: info: Cannot use regular scanning, forcing with ap-force May 04 09:41:06 audionuc sudo[8521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 04 09:41:06 audionuc sudo[8521]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:41:06 audionuc sudo[8521]: pam_unix(sudo:session): session closed for user root May 04 09:41:06 audionuc volumio[840]: command failed: Operation not supported (-95) May 04 09:41:06 audionuc volumio[840]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 04 09:41:06 audionuc volumio[840]: command failed: Operation not supported (-95) May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:41:23 audionuc volumio[840]: No protocol specified May 04 09:41:23 audionuc volumio[840]: xcb_connection_has_error() returned true May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 04 09:41:23 audionuc volumio[840]: No protocol specified May 04 09:41:23 audionuc volumio[840]: xcb_connection_has_error() returned true May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 04 09:41:23 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:41:27 audionuc volumio[840]: info: Retrieving Cloud Streaming UI May 04 09:41:27 audionuc volumio[840]: info: Getting Tidal Cloud Configuration May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:41:27 audionuc volumio[840]: info: Getting Qobuz Cloud Configuration May 04 09:41:27 audionuc volumio[840]: info: Asking plugin for UI Config May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:41:27 audionuc volumio[840]: info: Getting Spotify Cloud Configuration May 04 09:41:27 audionuc volumio[840]: info: Asking plugin for UI Config May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:41:27 audionuc volumio[840]: info: Saving Spotify Acccount May 04 09:41:27 audionuc volumio[840]: info: Got it May 04 09:41:27 audionuc volumio[840]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 04 09:41:27 audionuc volumio[840]: info: Got Tidal Cloud Configuration May 04 09:41:27 audionuc volumio[840]: info: Got it May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::volumioGetBrowseSources May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::volumioGetBrowseSources May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::volumioGetBrowseSources May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 09:41:27 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 04 09:41:31 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 09:41:35 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 09:41:36 audionuc volumio[840]: info: [1714808496837] [80s80s] Pushing the next song state Queen & David Bowie - Under Pressure and getting next track. May 04 09:41:36 audionuc volumio[840]: info: CorePlayQueue::getTrack 0 May 04 09:41:36 audionuc volumio[840]: info: CoreCommandRouter::servicePushState May 04 09:41:36 audionuc volumio[840]: info: CorePlayQueue::getTrack 0 May 04 09:41:36 audionuc volumio[840]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"/albumart?sourceicon=music_service/80s80s/images/80s80s-cover.png","name":"Queen & David Bowie - Under Pressure","title":"Under Pressure","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"207","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 04 09:41:36 audionuc volumio[840]: verbose: CURRENT POSITION 0 May 04 09:41:36 audionuc volumio[840]: info: CoreStateMachine::syncState stateService play May 04 09:41:36 audionuc volumio[840]: info: CoreStateMachine::syncState currentStatus play May 04 09:41:36 audionuc volumio[840]: info: Received an update from plugin. extracting info from payload May 04 09:41:36 audionuc volumio[840]: info: CoreStateMachine::pushState May 04 09:41:36 audionuc volumio[840]: info: CorePlayQueue::getTrack 0 May 04 09:41:36 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 09:41:36 audionuc volumio[840]: info: CoreCommandRouter::volumioPushState May 04 09:41:36 audionuc volumio[840]: info: MRS: Pushing multiroomSync output update for this device May 04 09:41:36 audionuc volumio[840]: info: MRS: Pushing multiroomSync output May 04 09:41:36 audionuc volumio[840]: info: CoreStateMachine::pushState May 04 09:41:36 audionuc volumio[840]: info: CorePlayQueue::getTrack 0 May 04 09:41:36 audionuc volumio[840]: info: CoreCommandRouter::volumioPushState May 04 09:41:36 audionuc volumio[840]: info: MRS: Pushing multiroomSync output update for this device May 04 09:41:36 audionuc volumio[840]: info: MRS: Pushing multiroomSync output May 04 09:41:36 audionuc volumio[840]: info: [1714808496842] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=1 May 04 09:41:36 audionuc volumio[840]: info: CorePlayQueue::getTrack 0 May 04 09:41:36 audionuc volumio[840]: info: CorePlayQueue::getTrack 1 May 04 09:41:37 audionuc volumio[840]: info: [1714808497048] [80s80s] received new event containing 1 songs. May 04 09:41:37 audionuc volumio[840]: info: [1714808497048] [80s80s] PlayNextTrack API delay: 30 May 04 09:41:37 audionuc volumio[840]: info: [1714808497050] [80s80s] Setting timer to: 207000 milliseconds. May 04 09:41:39 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 09:41:41 audionuc volumio[840]: info: Disabling MyMusic plugin smart_inputs May 04 09:41:41 audionuc volumio[840]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service smart_inputs May 04 09:41:41 audionuc volumio[840]: info: Removeing all smart Inputs May 04 09:41:41 audionuc volumio[840]: info: Disabling plugin smart_inputs May 04 09:41:43 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 09:41:43 audionuc volumio[840]: info: Enabling MyMusic plugin smart_inputs May 04 09:41:43 audionuc volumio[840]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service smart_inputs May 04 09:41:43 audionuc volumio[840]: info: Enabling plugin smart_inputs May 04 09:41:43 audionuc volumio[840]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs May 04 09:41:43 audionuc volumio[840]: info: Adding inputs REST Endpoints May 04 09:41:43 audionuc volumio[840]: info: Updating scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs May 04 09:41:43 audionuc volumio[840]: info: Scanning Audio Inputs May 04 09:41:43 audionuc volumio[840]: No protocol specified May 04 09:41:43 audionuc volumio[840]: xcb_connection_has_error() returned true May 04 09:41:43 audionuc volumio[840]: info: Checking against Known Cards name May 04 09:41:43 audionuc volumio[840]: info: Checking against Known Cards name May 04 09:41:43 audionuc volumio[840]: info: Adding Server instance for streaming May 04 09:41:43 audionuc volumio[840]: info: Done. May 04 09:41:54 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 04 09:41:54 audionuc volumio[840]: info: Preload queue cleared May 04 09:42:00 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 04 09:42:00 audionuc volumio[840]: info: Preload queue cleared May 04 09:42:03 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 04 09:42:03 audionuc volumio[840]: info: Preload queue cleared May 04 09:42:06 audionuc volumio[840]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 04 09:42:06 audionuc volumio[840]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 09:42:06 audionuc volumio[840]: TypeError: Cannot read property 'length' of undefined May 04 09:42:06 audionuc volumio[840]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 04 09:42:06 audionuc volumio[840]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 04 09:42:06 audionuc volumio[840]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 04 09:42:06 audionuc volumio[840]: at Parser.emit (events.js:400:28) May 04 09:42:06 audionuc volumio[840]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 04 09:42:06 audionuc volumio[840]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 04 09:42:06 audionuc volumio[840]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 04 09:42:06 audionuc volumio[840]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 04 09:42:06 audionuc volumio[840]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 04 09:42:06 audionuc volumio[840]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 04 09:42:06 audionuc volumio[840]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 04 09:42:06 audionuc volumio[840]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 04 09:42:06 audionuc volumio[840]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 04 09:42:06 audionuc volumio[840]: at IncomingMessage.emit (events.js:412:35) May 04 09:42:06 audionuc volumio[840]: at endReadableNT (internal/streams/readable.js:1333:12) May 04 09:42:06 audionuc volumio[840]: at processTicksAndRejections (internal/process/task_queues.js:82:21) May 04 09:42:06 audionuc volumio[840]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 09:42:06 audionuc sudo[8608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-04 09:41 May 04 09:42:06 audionuc sudo[8608]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"