-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Sun 2025-05-25 01:09:33 +07. -- May 25 01:08:01 volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:08:01 volumio volumio[941]: info: Preload queue cleared May 25 01:08:03 volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:08:04 volumio volumio[941]: info: Preload queue cleared May 25 01:08:07 volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:08:07 volumio volumio[941]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:08:07 volumio volumio[941]: TypeError: Cannot read property 'length' of undefined May 25 01:08:07 volumio volumio[941]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 25 01:08:07 volumio volumio[941]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 25 01:08:07 volumio volumio[941]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 25 01:08:07 volumio volumio[941]: at Parser.emit (events.js:315:20) May 25 01:08:07 volumio volumio[941]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 25 01:08:07 volumio volumio[941]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 25 01:08:07 volumio volumio[941]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 25 01:08:07 volumio volumio[941]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 25 01:08:07 volumio volumio[941]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 25 01:08:07 volumio volumio[941]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 25 01:08:07 volumio volumio[941]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 25 01:08:07 volumio volumio[941]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 25 01:08:07 volumio volumio[941]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 25 01:08:07 volumio volumio[941]: at IncomingMessage.emit (events.js:327:22) May 25 01:08:07 volumio volumio[941]: at endReadableNT (internal/streams/readable.js:1327:12) May 25 01:08:07 volumio volumio[941]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 25 01:08:07 volumio volumio[941]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:08:08 volumio sudo[11976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 01:07 May 25 01:08:08 volumio sudo[11976]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:08 volumio sudo[11976]: pam_unix(sudo:session): session closed for user root May 25 01:08:09 volumio volumio-remote-updater[496]: [2025-05-25 01:08:09] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 25 01:08:09 volumio volumio-remote-updater[496]: [2025-05-25 01:08:09] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 25 01:08:09 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 25 01:08:09 volumio kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=1) May 25 01:08:09 volumio kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=1) May 25 01:08:09 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. May 25 01:08:09 volumio systemd[1]: Started dynamicswap service. May 25 01:08:09 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:08:09 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 25 01:08:09 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. May 25 01:08:09 volumio systemd[1]: Stopped Volumio Backend Module. May 25 01:08:09 volumio systemd[1]: Started Volumio Backend Module. May 25 01:08:09 volumio systemd[1]: Started dynamicswap service. May 25 01:08:09 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:08:11 volumio volumio[11991]: info: ------------------------------------------- May 25 01:08:11 volumio volumio[11991]: info: ----- Volumio3 ---- May 25 01:08:11 volumio volumio[11991]: info: ------------------------------------------- May 25 01:08:11 volumio volumio[11991]: info: ----- System startup ---- May 25 01:08:11 volumio volumio[11991]: info: ------------------------------------------- May 25 01:08:11 volumio volumio[11991]: info: MYVOLUMIO Environment detected May 25 01:08:11 volumio volumio[11991]: info: Plugin folders cleanup May 25 01:08:11 volumio volumio[11991]: info: Scanning into folder /volumio/app/plugins/ May 25 01:08:11 volumio volumio[11991]: info: Scanning category audio_interface May 25 01:08:11 volumio volumio[11991]: info: Scanning category miscellanea May 25 01:08:11 volumio volumio[11991]: info: Scanning category music_service May 25 01:08:11 volumio volumio[11991]: info: Scanning category plugins.json May 25 01:08:11 volumio volumio[11991]: info: Scanning category system_controller May 25 01:08:11 volumio volumio[11991]: info: Scanning category user_interface May 25 01:08:11 volumio volumio[11991]: info: Scanning into folder /data/plugins/ May 25 01:08:11 volumio volumio[11991]: info: Scanning category audio_interface May 25 01:08:11 volumio volumio[11991]: info: Scanning category user_interface May 25 01:08:11 volumio volumio[11991]: info: Plugin folders cleanup completed May 25 01:08:11 volumio volumio[11991]: info: ------------------------------------------- May 25 01:08:11 volumio volumio[11991]: info: ----- Core plugins startup ---- May 25 01:08:11 volumio volumio[11991]: info: ------------------------------------------- May 25 01:08:11 volumio volumio[11991]: info: Loading plugins from folder /volumio/app/plugins/ May 25 01:08:11 volumio volumio[11991]: info: Adding plugin upnp to MyMusic Plugins May 25 01:08:11 volumio volumio[11991]: info: Adding plugin airplay_emulation to MyMusic Plugins May 25 01:08:11 volumio volumio[11991]: info: Adding plugin upnp_browser to MyMusic Plugins May 25 01:08:11 volumio volumio[11991]: info: Loading plugins from folder /data/plugins/ May 25 01:08:11 volumio volumio[11991]: info: Loading plugin "system"... May 25 01:08:11 volumio volumio[11991]: info: Loading plugin "appearance"... May 25 01:08:12 volumio volumio[11991]: info: Loading plugin "network"... May 25 01:08:12 volumio volumio[11991]: info: Refreshing Cached IP Addresses May 25 01:08:12 volumio sudo[12018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 01:08:12 volumio sudo[12018]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:12 volumio sudo[12020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 01:08:12 volumio sudo[12020]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:12 volumio sudo[12018]: pam_unix(sudo:session): session closed for user root May 25 01:08:12 volumio volumio[11991]: info: Loading plugin "services"... May 25 01:08:12 volumio sudo[12020]: pam_unix(sudo:session): session closed for user root May 25 01:08:12 volumio volumio[11991]: info: Loading plugin "alsa_controller"... May 25 01:08:12 volumio sudo[12023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 25 01:08:12 volumio sudo[12023]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:12 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 01:08:12 volumio volumio[11991]: info: Loading plugin "wizard"... May 25 01:08:12 volumio volumio[11991]: info: Loading plugin "networkfs"... May 25 01:08:12 volumio volumio[11991]: info: Starting Udev Watcher for removable devices May 25 01:08:12 volumio volumio[11991]: info: Ignoring mount for partition: boot May 25 01:08:12 volumio volumio[11991]: info: Ignoring mount for partition: volumio May 25 01:08:12 volumio volumio[11991]: info: Ignoring mount for partition: volumio_data May 25 01:08:12 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:12 volumio volumio[11991]: info: Loading plugin "volumio_command_line_client"... May 25 01:08:12 volumio volumio[11991]: info: Loading plugin "upnp"... May 25 01:08:12 volumio volumio[11991]: info: [1748110092990] Starting Upmpd Daemon May 25 01:08:12 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:12 volumio volumio[11991]: info: Loading plugin "my_music"... May 25 01:08:12 volumio volumio[11991]: info: Loading plugin "mpd"... May 25 01:08:13 volumio volumio[11991]: info: Loading plugin "upnp_browser"... May 25 01:08:13 volumio volumio[11991]: info: Loading plugin "alarm-clock"... May 25 01:08:13 volumio volumio[11991]: info: Loading plugin "airplay_emulation"... May 25 01:08:13 volumio volumio[11991]: info: Starting Shairport Sync May 25 01:08:13 volumio volumio[11991]: info: Loading plugin "last_100"... May 25 01:08:13 volumio volumio[11991]: info: Loading plugin "webradio"... May 25 01:08:13 volumio volumio[11991]: info: Loading plugin "i2s_dacs"... May 25 01:08:13 volumio volumio[11991]: info: I2S DAC not set, start Auto-detection May 25 01:08:13 volumio volumio[11991]: info: Loading plugin "volumiodiscovery"... May 25 01:08:13 volumio volumio[11991]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:08:13 volumio node[11991]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:08:13 volumio volumio[11991]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:13 volumio node[11991]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:13 volumio volumio[11991]: *** WARNING *** For more information see May 25 01:08:13 volumio node[11991]: *** WARNING *** For more information see May 25 01:08:13 volumio volumio[11991]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:08:13 volumio node[11991]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:08:13 volumio volumio[11991]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:13 volumio node[11991]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:13 volumio volumio[11991]: *** WARNING *** For more information see May 25 01:08:13 volumio node[11991]: *** WARNING *** For more information see May 25 01:08:13 volumio volumio[11991]: info: Applying required configuration parameters for plugin volumiodiscovery May 25 01:08:13 volumio volumio[11991]: info: Discovery: Started advertising with name: Volumio May 25 01:08:13 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:13 volumio volumio[11991]: info: Loading plugin "now_playing"... May 25 01:08:14 volumio volumio-remote-updater[496]: [2025-05-25 01:08:14] [connect] Successful connection May 25 01:08:15 volumio volumio[11991]: info: Loading plugin "outputs"... May 25 01:08:15 volumio volumio[11991]: info: Loading plugin "albumart"... May 25 01:08:15 volumio volumio[11991]: info: Plugin example_plugin is not enabled May 25 01:08:15 volumio volumio[11991]: info: Loading plugin "inputs"... May 25 01:08:15 volumio volumio[11991]: info: Loading plugin "updater_comm"... May 25 01:08:15 volumio volumio[11991]: info: Plugin mpdemulation is not enabled May 25 01:08:15 volumio volumio[11991]: info: Loading plugin "rest_api"... May 25 01:08:15 volumio volumio[11991]: info: Loading plugin "websocket"... May 25 01:08:15 volumio volumio[11991]: info: Loading plugin "fusiondsp"... May 25 01:08:15 volumio volumio[11991]: Forking 3 albumart workers May 25 01:08:15 volumio volumio[11991]: info: Applying required configuration parameters for plugin fusiondsp May 25 01:08:15 volumio volumio[11991]: info: Loading plugin "peppyspectrum"... May 25 01:08:16 volumio volumio[11991]: Starting albumart workers May 25 01:08:16 volumio volumio[11991]: info: Loading plugin "touch_display"... May 25 01:08:16 volumio volumio[11991]: Starting albumart workers May 25 01:08:16 volumio volumio[11991]: Starting albumart workers May 25 01:08:16 volumio volumio[11991]: info: Applying required configuration parameters for plugin touch_display May 25 01:08:16 volumio sudo[12023]: pam_unix(sudo:session): session closed for user root May 25 01:08:16 volumio volumio[11991]: info: Loading i18n strings for locale en May 25 01:08:16 volumio volumio[11991]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. May 25 01:08:16 volumio volumio[11991]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. May 25 01:08:16 volumio volumio[11991]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. May 25 01:08:16 volumio volumio[11991]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. May 25 01:08:16 volumio volumio[11991]: Updating browse sources language May 25 01:08:16 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::initPlayerControls May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:08:17 volumio volumio[11991]: Express server listening on port 3000 May 25 01:08:17 volumio volumio[11991]: [Metrics] WebUI: 6s 344.07ms May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::resetVolumioState May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::getcurrentVolume May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 1 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 2 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 3 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 4 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 5 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 6 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 7 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 8 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 9 May 25 01:08:17 volumio volumio-remote-updater[496]: [2025-05-25 01:08:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748110094 101 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 10 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 11 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 12 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 13 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 14 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 15 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 16 May 25 01:08:17 volumio volumio[11991]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 17 May 25 01:08:17 volumio volumio[11991]: info: Reloading queue from file May 25 01:08:17 volumio volumio[11991]: info: VolumeController:: Volume=86 Mute =false May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::pushState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioPushState May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::updateTrackBlock May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrackBlock May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::setRepeat null single undefined May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::pushState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioPushState May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::setRandom null May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::pushState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioPushState May 25 01:08:17 volumio volumio[11991]: info: Setting Device type: Raspberry PI May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: Received Get System Info May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:17 volumio volumio[11991]: info: Discovery: Getting this device information May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetQueue May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::getQueue May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getQueue May 25 01:08:17 volumio volumio[11991]: info: Listing playlists May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:08:17 volumio volumio[11991]: info: Received Get System Info May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:17 volumio volumio[11991]: info: Discovery: Getting this device information May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: Discovery: adding 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:08:17 volumio volumio[11991]: info: Discovery: Found device Volumio May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: VolumeController:: Volume=86 Mute =false May 25 01:08:17 volumio volumio[11991]: info: CoreStateMachine::pushState May 25 01:08:17 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:17 volumio volumio[11991]: info: CoreCommandRouter::volumioPushState May 25 01:08:18 volumio volumio[11991]: info: Discovery: this is already registered, 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:08:18 volumio volumio[11991]: info: Discovery: Found device Volumio May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:18 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:18 volumio volumio[11991]: info: FusionDsp - Choose a preset May 25 01:08:18 volumio volumio[11991]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:18 volumio volumio[11991]: info: FusionDsp - Choose a preset May 25 01:08:18 volumio volumio[11991]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:18 volumio volumio[11991]: info: FusionDsp - Choose a preset May 25 01:08:18 volumio volumio[11991]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:18 volumio volumio[11991]: info: FusionDsp - Choose a preset May 25 01:08:18 volumio volumio[11991]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:18 volumio volumio[11991]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 18 May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:18 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:08:18 volumio volumio[11991]: info: Received Get System Info May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:18 volumio volumio[11991]: info: Discovery: Getting this device information May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:18 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:18 volumio volumio[11991]: info: CoreCommandRouter::volumioGetState May 25 01:08:18 volumio volumio[11991]: info: CorePlayQueue::getTrack 0 May 25 01:08:18 volumio volumio[11991]: info: Listing playlists May 25 01:08:19 volumio volumio[11991]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:19 volumio volumio[11991]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:19 volumio volumio[11991]: info: FusionDsp - Choose a preset May 25 01:08:19 volumio volumio[11991]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:19 volumio volumio[11991]: info: FusionDsp - Choose a preset May 25 01:08:19 volumio volumio[11991]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:20 volumio volumio[11991]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:08:20 volumio volumio[11991]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:08:20 volumio volumio[11991]: TypeError: Cannot read property 'length' of undefined May 25 01:08:20 volumio volumio[11991]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 25 01:08:20 volumio volumio[11991]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 25 01:08:20 volumio volumio[11991]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 25 01:08:20 volumio volumio[11991]: at Parser.emit (events.js:315:20) May 25 01:08:20 volumio volumio[11991]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 25 01:08:20 volumio volumio[11991]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 25 01:08:20 volumio volumio[11991]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 25 01:08:20 volumio volumio[11991]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 25 01:08:20 volumio volumio[11991]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 25 01:08:20 volumio volumio[11991]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 25 01:08:20 volumio volumio[11991]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 25 01:08:20 volumio volumio[11991]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 25 01:08:20 volumio volumio[11991]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 25 01:08:20 volumio volumio[11991]: at IncomingMessage.emit (events.js:327:22) May 25 01:08:20 volumio volumio[11991]: at endReadableNT (internal/streams/readable.js:1327:12) May 25 01:08:20 volumio volumio[11991]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 25 01:08:20 volumio volumio[11991]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:08:21 volumio sudo[12108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 01:07 May 25 01:08:21 volumio sudo[12108]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:21 volumio sudo[12108]: pam_unix(sudo:session): session closed for user root May 25 01:08:21 volumio volumio-remote-updater[496]: [2025-05-25 01:08:21] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 25 01:08:21 volumio volumio-remote-updater[496]: [2025-05-25 01:08:21] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 25 01:08:21 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 25 01:08:21 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. May 25 01:08:21 volumio systemd[1]: Started dynamicswap service. May 25 01:08:21 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:08:21 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 25 01:08:21 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. May 25 01:08:21 volumio systemd[1]: Stopped Volumio Backend Module. May 25 01:08:21 volumio systemd[1]: Started Volumio Backend Module. May 25 01:08:21 volumio systemd[1]: Started dynamicswap service. May 25 01:08:21 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:08:22 volumio volumio[12119]: info: ------------------------------------------- May 25 01:08:22 volumio volumio[12119]: info: ----- Volumio3 ---- May 25 01:08:22 volumio volumio[12119]: info: ------------------------------------------- May 25 01:08:22 volumio volumio[12119]: info: ----- System startup ---- May 25 01:08:22 volumio volumio[12119]: info: ------------------------------------------- May 25 01:08:22 volumio volumio[12119]: info: MYVOLUMIO Environment detected May 25 01:08:22 volumio volumio[12119]: info: Plugin folders cleanup May 25 01:08:22 volumio volumio[12119]: info: Scanning into folder /volumio/app/plugins/ May 25 01:08:22 volumio volumio[12119]: info: Scanning category audio_interface May 25 01:08:22 volumio volumio[12119]: info: Scanning category miscellanea May 25 01:08:22 volumio volumio[12119]: info: Scanning category music_service May 25 01:08:22 volumio volumio[12119]: info: Scanning category plugins.json May 25 01:08:22 volumio volumio[12119]: info: Scanning category system_controller May 25 01:08:22 volumio volumio[12119]: info: Scanning category user_interface May 25 01:08:22 volumio volumio[12119]: info: Scanning into folder /data/plugins/ May 25 01:08:22 volumio volumio[12119]: info: Scanning category audio_interface May 25 01:08:22 volumio volumio[12119]: info: Scanning category user_interface May 25 01:08:22 volumio volumio[12119]: info: Plugin folders cleanup completed May 25 01:08:22 volumio volumio[12119]: info: ------------------------------------------- May 25 01:08:22 volumio volumio[12119]: info: ----- Core plugins startup ---- May 25 01:08:22 volumio volumio[12119]: info: ------------------------------------------- May 25 01:08:22 volumio volumio[12119]: info: Loading plugins from folder /volumio/app/plugins/ May 25 01:08:22 volumio volumio[12119]: info: Adding plugin upnp to MyMusic Plugins May 25 01:08:23 volumio volumio[12119]: info: Adding plugin airplay_emulation to MyMusic Plugins May 25 01:08:23 volumio volumio[12119]: info: Adding plugin upnp_browser to MyMusic Plugins May 25 01:08:23 volumio volumio[12119]: info: Loading plugins from folder /data/plugins/ May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "system"... May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "appearance"... May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "network"... May 25 01:08:23 volumio volumio[12119]: info: Refreshing Cached IP Addresses May 25 01:08:23 volumio sudo[12146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 01:08:23 volumio sudo[12146]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:23 volumio sudo[12146]: pam_unix(sudo:session): session closed for user root May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "services"... May 25 01:08:23 volumio sudo[12148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 01:08:23 volumio sudo[12148]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "alsa_controller"... May 25 01:08:23 volumio sudo[12148]: pam_unix(sudo:session): session closed for user root May 25 01:08:23 volumio sudo[12151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 25 01:08:23 volumio sudo[12151]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:23 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "wizard"... May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "networkfs"... May 25 01:08:23 volumio volumio[12119]: info: Starting Udev Watcher for removable devices May 25 01:08:23 volumio volumio[12119]: info: Ignoring mount for partition: boot May 25 01:08:23 volumio volumio[12119]: info: Ignoring mount for partition: volumio May 25 01:08:23 volumio volumio[12119]: info: Ignoring mount for partition: volumio_data May 25 01:08:23 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "volumio_command_line_client"... May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "upnp"... May 25 01:08:23 volumio volumio[12119]: info: [1748110103951] Starting Upmpd Daemon May 25 01:08:23 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "my_music"... May 25 01:08:23 volumio volumio[12119]: info: Loading plugin "mpd"... May 25 01:08:24 volumio volumio[12119]: info: Loading plugin "upnp_browser"... May 25 01:08:24 volumio volumio[12119]: info: Loading plugin "alarm-clock"... May 25 01:08:24 volumio volumio[12119]: info: Loading plugin "airplay_emulation"... May 25 01:08:24 volumio volumio[12119]: info: Starting Shairport Sync May 25 01:08:24 volumio volumio[12119]: info: Loading plugin "last_100"... May 25 01:08:24 volumio volumio[12119]: info: Loading plugin "webradio"... May 25 01:08:24 volumio volumio[12119]: info: Loading plugin "i2s_dacs"... May 25 01:08:24 volumio volumio[12119]: info: I2S DAC not set, start Auto-detection May 25 01:08:24 volumio volumio[12119]: info: Loading plugin "volumiodiscovery"... May 25 01:08:24 volumio volumio[12119]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:08:24 volumio volumio[12119]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:24 volumio node[12119]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:08:24 volumio volumio[12119]: *** WARNING *** For more information see May 25 01:08:24 volumio volumio[12119]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:08:24 volumio volumio[12119]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:24 volumio volumio[12119]: *** WARNING *** For more information see May 25 01:08:24 volumio node[12119]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:24 volumio node[12119]: *** WARNING *** For more information see May 25 01:08:24 volumio node[12119]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:08:24 volumio node[12119]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:24 volumio node[12119]: *** WARNING *** For more information see May 25 01:08:24 volumio volumio[12119]: info: Applying required configuration parameters for plugin volumiodiscovery May 25 01:08:24 volumio volumio[12119]: info: Discovery: Started advertising with name: Volumio May 25 01:08:24 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:24 volumio volumio[12119]: info: Loading plugin "now_playing"... May 25 01:08:25 volumio volumio[12119]: info: Loading plugin "outputs"... May 25 01:08:25 volumio volumio[12119]: info: Loading plugin "albumart"... May 25 01:08:25 volumio volumio[12119]: info: Plugin example_plugin is not enabled May 25 01:08:25 volumio volumio[12119]: info: Loading plugin "inputs"... May 25 01:08:25 volumio volumio[12119]: info: Loading plugin "updater_comm"... May 25 01:08:25 volumio volumio[12119]: info: Plugin mpdemulation is not enabled May 25 01:08:25 volumio volumio[12119]: info: Loading plugin "rest_api"... May 25 01:08:25 volumio volumio[12119]: info: Loading plugin "websocket"... May 25 01:08:25 volumio volumio[12119]: info: Loading plugin "fusiondsp"... May 25 01:08:25 volumio volumio[12119]: Forking 3 albumart workers May 25 01:08:25 volumio volumio[12119]: info: Applying required configuration parameters for plugin fusiondsp May 25 01:08:25 volumio volumio[12119]: info: Loading plugin "peppyspectrum"... May 25 01:08:26 volumio volumio-remote-updater[496]: [2025-05-25 01:08:26] [connect] Successful connection May 25 01:08:26 volumio volumio[12119]: info: Loading plugin "touch_display"... May 25 01:08:26 volumio volumio[12119]: Starting albumart workers May 25 01:08:26 volumio volumio[12119]: Starting albumart workers May 25 01:08:26 volumio volumio[12119]: info: Applying required configuration parameters for plugin touch_display May 25 01:08:26 volumio volumio[12119]: Starting albumart workers May 25 01:08:26 volumio volumio[12119]: info: Loading i18n strings for locale en May 25 01:08:26 volumio volumio[12119]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. May 25 01:08:26 volumio volumio[12119]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. May 25 01:08:26 volumio volumio[12119]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. May 25 01:08:26 volumio volumio[12119]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. May 25 01:08:26 volumio volumio[12119]: Updating browse sources language May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::initPlayerControls May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:08:26 volumio volumio[12119]: Express server listening on port 3000 May 25 01:08:26 volumio volumio[12119]: [Metrics] WebUI: 4s 851.89ms May 25 01:08:26 volumio volumio[12119]: info: CoreStateMachine::resetVolumioState May 25 01:08:26 volumio volumio[12119]: info: CoreStateMachine::getcurrentVolume May 25 01:08:26 volumio volumio[12119]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 1 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 2 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 3 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 4 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 5 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 6 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 7 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 8 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 9 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 10 May 25 01:08:27 volumio volumio-remote-updater[496]: [2025-05-25 01:08:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748110106 101 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 11 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 12 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 13 May 25 01:08:27 volumio volumio[12119]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 14 May 25 01:08:27 volumio volumio[12119]: info: Reloading queue from file May 25 01:08:27 volumio volumio[12119]: info: CoreStateMachine::setRepeat null single undefined May 25 01:08:27 volumio volumio[12119]: info: CoreStateMachine::pushState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioPushState May 25 01:08:27 volumio volumio[12119]: info: CoreStateMachine::setRandom null May 25 01:08:27 volumio volumio[12119]: info: CoreStateMachine::pushState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioPushState May 25 01:08:27 volumio volumio[12119]: info: Setting Device type: Raspberry PI May 25 01:08:27 volumio volumio[12119]: info: VolumeController:: Volume=86 Mute =false May 25 01:08:27 volumio volumio[12119]: info: CoreStateMachine::pushState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioPushState May 25 01:08:27 volumio volumio[12119]: info: CoreStateMachine::updateTrackBlock May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrackBlock May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: Received Get System Info May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:27 volumio volumio[12119]: info: Discovery: Getting this device information May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetQueue May 25 01:08:27 volumio volumio[12119]: info: CoreStateMachine::getQueue May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getQueue May 25 01:08:27 volumio volumio[12119]: info: Listing playlists May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:08:27 volumio volumio[12119]: info: Received Get System Info May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:27 volumio volumio[12119]: info: Discovery: Getting this device information May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: Discovery: adding 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:08:27 volumio volumio[12119]: info: Discovery: Found device Volumio May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: VolumeController:: Volume=86 Mute =false May 25 01:08:27 volumio volumio[12119]: info: CoreStateMachine::pushState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioPushState May 25 01:08:27 volumio volumio[12119]: info: Discovery: this is already registered, 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:08:27 volumio volumio[12119]: info: Discovery: Found device Volumio May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:27 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:27 volumio sudo[12151]: pam_unix(sudo:session): session closed for user root May 25 01:08:27 volumio volumio[12119]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:27 volumio volumio[12119]: info: FusionDsp - Choose a preset May 25 01:08:28 volumio volumio[12119]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:28 volumio volumio[12119]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:28 volumio volumio[12119]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:28 volumio volumio[12119]: info: FusionDsp - Choose a preset May 25 01:08:28 volumio volumio[12119]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:28 volumio volumio[12119]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:28 volumio volumio[12119]: info: FusionDsp - Choose a preset May 25 01:08:28 volumio volumio[12119]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:28 volumio volumio[12119]: info: FusionDsp - Choose a preset May 25 01:08:28 volumio volumio[12119]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:29 volumio volumio[12119]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 15 May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:29 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:08:29 volumio volumio[12119]: info: Received Get System Info May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:29 volumio volumio[12119]: info: Discovery: Getting this device information May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:29 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::volumioGetState May 25 01:08:29 volumio volumio[12119]: info: CorePlayQueue::getTrack 0 May 25 01:08:29 volumio volumio[12119]: info: Listing playlists May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:29 volumio volumio[12119]: info: FusionDsp - Choose a preset May 25 01:08:29 volumio volumio[12119]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:29 volumio volumio[12119]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:29 volumio volumio[12119]: info: FusionDsp - Choose a preset May 25 01:08:29 volumio volumio[12119]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:29 volumio volumio[12119]: info: FusionDsp - Choose a preset May 25 01:08:29 volumio volumio[12119]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:31 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:08:31 volumio volumio[12119]: info: Preload queue cleared May 25 01:08:33 volumio volumio[12119]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:08:33 volumio volumio[12119]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:08:33 volumio volumio[12119]: TypeError: Cannot read property 'length' of undefined May 25 01:08:33 volumio volumio[12119]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 25 01:08:33 volumio volumio[12119]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 25 01:08:33 volumio volumio[12119]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 25 01:08:33 volumio volumio[12119]: at Parser.emit (events.js:315:20) May 25 01:08:33 volumio volumio[12119]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 25 01:08:33 volumio volumio[12119]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 25 01:08:33 volumio volumio[12119]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 25 01:08:33 volumio volumio[12119]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 25 01:08:33 volumio volumio[12119]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 25 01:08:33 volumio volumio[12119]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 25 01:08:33 volumio volumio[12119]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 25 01:08:33 volumio volumio[12119]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 25 01:08:33 volumio volumio[12119]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 25 01:08:33 volumio volumio[12119]: at IncomingMessage.emit (events.js:327:22) May 25 01:08:33 volumio volumio[12119]: at endReadableNT (internal/streams/readable.js:1327:12) May 25 01:08:33 volumio volumio[12119]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 25 01:08:33 volumio volumio[12119]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:08:34 volumio sudo[12235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 01:07 May 25 01:08:34 volumio sudo[12235]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:34 volumio sudo[12235]: pam_unix(sudo:session): session closed for user root May 25 01:08:34 volumio volumio-remote-updater[496]: [2025-05-25 01:08:34] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 25 01:08:34 volumio volumio-remote-updater[496]: [2025-05-25 01:08:34] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 25 01:08:34 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 25 01:08:34 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. May 25 01:08:34 volumio systemd[1]: Started dynamicswap service. May 25 01:08:34 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:08:34 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 25 01:08:34 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. May 25 01:08:34 volumio systemd[1]: Stopped Volumio Backend Module. May 25 01:08:34 volumio systemd[1]: Started Volumio Backend Module. May 25 01:08:34 volumio systemd[1]: Started dynamicswap service. May 25 01:08:34 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:08:35 volumio volumio[12245]: info: ------------------------------------------- May 25 01:08:35 volumio volumio[12245]: info: ----- Volumio3 ---- May 25 01:08:35 volumio volumio[12245]: info: ------------------------------------------- May 25 01:08:35 volumio volumio[12245]: info: ----- System startup ---- May 25 01:08:35 volumio volumio[12245]: info: ------------------------------------------- May 25 01:08:36 volumio volumio[12245]: info: MYVOLUMIO Environment detected May 25 01:08:36 volumio volumio[12245]: info: Plugin folders cleanup May 25 01:08:36 volumio volumio[12245]: info: Scanning into folder /volumio/app/plugins/ May 25 01:08:36 volumio volumio[12245]: info: Scanning category audio_interface May 25 01:08:36 volumio volumio[12245]: info: Scanning category miscellanea May 25 01:08:36 volumio volumio[12245]: info: Scanning category music_service May 25 01:08:36 volumio volumio[12245]: info: Scanning category plugins.json May 25 01:08:36 volumio volumio[12245]: info: Scanning category system_controller May 25 01:08:36 volumio volumio[12245]: info: Scanning category user_interface May 25 01:08:36 volumio volumio[12245]: info: Scanning into folder /data/plugins/ May 25 01:08:36 volumio volumio[12245]: info: Scanning category audio_interface May 25 01:08:36 volumio volumio[12245]: info: Scanning category user_interface May 25 01:08:36 volumio volumio[12245]: info: Plugin folders cleanup completed May 25 01:08:36 volumio volumio[12245]: info: ------------------------------------------- May 25 01:08:36 volumio volumio[12245]: info: ----- Core plugins startup ---- May 25 01:08:36 volumio volumio[12245]: info: ------------------------------------------- May 25 01:08:36 volumio volumio[12245]: info: Loading plugins from folder /volumio/app/plugins/ May 25 01:08:36 volumio volumio[12245]: info: Adding plugin upnp to MyMusic Plugins May 25 01:08:36 volumio volumio[12245]: info: Adding plugin airplay_emulation to MyMusic Plugins May 25 01:08:36 volumio volumio[12245]: info: Adding plugin upnp_browser to MyMusic Plugins May 25 01:08:36 volumio volumio[12245]: info: Loading plugins from folder /data/plugins/ May 25 01:08:36 volumio volumio[12245]: info: Loading plugin "system"... May 25 01:08:36 volumio volumio[12245]: info: Loading plugin "appearance"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "network"... May 25 01:08:37 volumio volumio[12245]: info: Refreshing Cached IP Addresses May 25 01:08:37 volumio sudo[12272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 01:08:37 volumio sudo[12272]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:37 volumio sudo[12272]: pam_unix(sudo:session): session closed for user root May 25 01:08:37 volumio sudo[12274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 01:08:37 volumio sudo[12274]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "services"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "alsa_controller"... May 25 01:08:37 volumio sudo[12274]: pam_unix(sudo:session): session closed for user root May 25 01:08:37 volumio sudo[12277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 25 01:08:37 volumio sudo[12277]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:37 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "wizard"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "networkfs"... May 25 01:08:37 volumio volumio[12245]: info: Starting Udev Watcher for removable devices May 25 01:08:37 volumio volumio[12245]: info: Ignoring mount for partition: boot May 25 01:08:37 volumio volumio[12245]: info: Ignoring mount for partition: volumio May 25 01:08:37 volumio volumio[12245]: info: Ignoring mount for partition: volumio_data May 25 01:08:37 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "volumio_command_line_client"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "upnp"... May 25 01:08:37 volumio volumio[12245]: info: [1748110117287] Starting Upmpd Daemon May 25 01:08:37 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "my_music"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "mpd"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "upnp_browser"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "alarm-clock"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "airplay_emulation"... May 25 01:08:37 volumio volumio[12245]: info: Starting Shairport Sync May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "last_100"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "webradio"... May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "i2s_dacs"... May 25 01:08:37 volumio volumio[12245]: info: I2S DAC not set, start Auto-detection May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "volumiodiscovery"... May 25 01:08:37 volumio volumio[12245]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:08:37 volumio volumio[12245]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:37 volumio volumio[12245]: *** WARNING *** For more information see May 25 01:08:37 volumio node[12245]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:08:37 volumio volumio[12245]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:08:37 volumio volumio[12245]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:37 volumio volumio[12245]: *** WARNING *** For more information see May 25 01:08:37 volumio node[12245]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:37 volumio node[12245]: *** WARNING *** For more information see May 25 01:08:37 volumio node[12245]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:08:37 volumio node[12245]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:37 volumio node[12245]: *** WARNING *** For more information see May 25 01:08:37 volumio volumio[12245]: info: Applying required configuration parameters for plugin volumiodiscovery May 25 01:08:37 volumio volumio[12245]: info: Discovery: Started advertising with name: Volumio May 25 01:08:37 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:37 volumio volumio[12245]: info: Loading plugin "now_playing"... May 25 01:08:38 volumio ntpd[651]: Soliciting pool server 103.184.124.254 May 25 01:08:38 volumio volumio[12245]: info: Loading plugin "outputs"... May 25 01:08:38 volumio volumio[12245]: info: Loading plugin "albumart"... May 25 01:08:38 volumio volumio[12245]: info: Plugin example_plugin is not enabled May 25 01:08:38 volumio volumio[12245]: info: Loading plugin "inputs"... May 25 01:08:38 volumio volumio[12245]: info: Loading plugin "updater_comm"... May 25 01:08:39 volumio volumio[12245]: info: Plugin mpdemulation is not enabled May 25 01:08:39 volumio volumio[12245]: info: Loading plugin "rest_api"... May 25 01:08:39 volumio volumio[12245]: info: Loading plugin "websocket"... May 25 01:08:39 volumio volumio[12245]: info: Loading plugin "fusiondsp"... May 25 01:08:39 volumio volumio[12245]: Forking 3 albumart workers May 25 01:08:39 volumio volumio[12245]: info: Applying required configuration parameters for plugin fusiondsp May 25 01:08:39 volumio volumio-remote-updater[496]: [2025-05-25 01:08:39] [connect] Successful connection May 25 01:08:39 volumio volumio[12245]: info: Loading plugin "peppyspectrum"... May 25 01:08:39 volumio volumio[12245]: info: Loading plugin "touch_display"... May 25 01:08:39 volumio volumio[12245]: Starting albumart workers May 25 01:08:39 volumio volumio[12245]: info: Applying required configuration parameters for plugin touch_display May 25 01:08:39 volumio volumio[12245]: Starting albumart workers May 25 01:08:40 volumio volumio[12245]: Starting albumart workers May 25 01:08:40 volumio volumio[12245]: info: Loading i18n strings for locale en May 25 01:08:40 volumio volumio[12245]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. May 25 01:08:40 volumio volumio[12245]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. May 25 01:08:40 volumio volumio[12245]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. May 25 01:08:40 volumio volumio[12245]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. May 25 01:08:40 volumio volumio[12245]: Updating browse sources language May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::initPlayerControls May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:08:40 volumio volumio[12245]: Express server listening on port 3000 May 25 01:08:40 volumio volumio[12245]: [Metrics] WebUI: 4s 837.07ms May 25 01:08:40 volumio volumio[12245]: info: CoreStateMachine::resetVolumioState May 25 01:08:40 volumio volumio[12245]: info: CoreStateMachine::getcurrentVolume May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 1 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 2 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 3 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 4 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 5 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 6 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 7 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 8 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 9 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 10 May 25 01:08:40 volumio volumio-remote-updater[496]: [2025-05-25 01:08:40] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748110119 101 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 11 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 12 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 13 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 14 May 25 01:08:40 volumio volumio[12245]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 15 May 25 01:08:40 volumio volumio[12245]: info: Reloading queue from file May 25 01:08:40 volumio volumio[12245]: info: CoreStateMachine::setRepeat null single undefined May 25 01:08:40 volumio volumio[12245]: info: CoreStateMachine::pushState May 25 01:08:40 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::volumioPushState May 25 01:08:40 volumio volumio[12245]: info: CoreStateMachine::setRandom null May 25 01:08:40 volumio volumio[12245]: info: CoreStateMachine::pushState May 25 01:08:40 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::volumioPushState May 25 01:08:40 volumio volumio[12245]: info: Setting Device type: Raspberry PI May 25 01:08:40 volumio volumio[12245]: info: VolumeController:: Volume=86 Mute =false May 25 01:08:40 volumio volumio[12245]: info: CoreStateMachine::pushState May 25 01:08:40 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::volumioPushState May 25 01:08:40 volumio volumio[12245]: info: CoreStateMachine::updateTrackBlock May 25 01:08:40 volumio volumio[12245]: info: CorePlayQueue::getTrackBlock May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:08:40 volumio volumio[12245]: info: Discovery: adding 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:08:40 volumio volumio[12245]: info: Discovery: Found device Volumio May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:40 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:40 volumio volumio[12245]: info: Discovery: this is already registered, 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:08:40 volumio volumio[12245]: info: Discovery: Found device Volumio May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:40 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:40 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:40 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:41 volumio volumio[12245]: info: VolumeController:: Volume=86 Mute =false May 25 01:08:41 volumio volumio[12245]: info: CoreStateMachine::pushState May 25 01:08:41 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::volumioPushState May 25 01:08:41 volumio volumio[12245]: info: Received Get System Info May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:41 volumio volumio[12245]: info: Discovery: Getting this device information May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:41 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:41 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:41 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:41 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::volumioGetQueue May 25 01:08:41 volumio volumio[12245]: info: CoreStateMachine::getQueue May 25 01:08:41 volumio volumio[12245]: info: CorePlayQueue::getQueue May 25 01:08:41 volumio volumio[12245]: info: Listing playlists May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:08:41 volumio volumio[12245]: info: Received Get System Info May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:41 volumio volumio[12245]: info: Discovery: Getting this device information May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:41 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:41 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:41 volumio sudo[12277]: pam_unix(sudo:session): session closed for user root May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:41 volumio volumio[12245]: info: FusionDsp - Choose a preset May 25 01:08:41 volumio volumio[12245]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:41 volumio volumio[12245]: info: FusionDsp - Choose a preset May 25 01:08:41 volumio volumio[12245]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:41 volumio volumio[12245]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:41 volumio volumio[12245]: info: FusionDsp - Choose a preset May 25 01:08:41 volumio volumio[12245]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:41 volumio volumio[12245]: info: FusionDsp - Choose a preset May 25 01:08:41 volumio volumio[12245]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:41 volumio volumio[12245]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 16 May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:42 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:08:42 volumio volumio[12245]: info: Received Get System Info May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:42 volumio volumio[12245]: info: Discovery: Getting this device information May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:42 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::volumioGetState May 25 01:08:42 volumio volumio[12245]: info: CorePlayQueue::getTrack 0 May 25 01:08:42 volumio volumio[12245]: info: Listing playlists May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:42 volumio volumio[12245]: info: FusionDsp - Choose a preset May 25 01:08:42 volumio volumio[12245]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:42 volumio volumio[12245]: info: FusionDsp - Choose a preset May 25 01:08:42 volumio volumio[12245]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:42 volumio volumio[12245]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:42 volumio volumio[12245]: info: FusionDsp - Choose a preset May 25 01:08:42 volumio volumio[12245]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:42 volumio volumio[12245]: info: FusionDsp - Choose a preset May 25 01:08:42 volumio volumio[12245]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:45 volumio volumio[12245]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:08:45 volumio volumio[12245]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:08:45 volumio volumio[12245]: TypeError: Cannot read property 'length' of undefined May 25 01:08:45 volumio volumio[12245]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 25 01:08:45 volumio volumio[12245]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 25 01:08:45 volumio volumio[12245]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 25 01:08:45 volumio volumio[12245]: at Parser.emit (events.js:315:20) May 25 01:08:45 volumio volumio[12245]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 25 01:08:45 volumio volumio[12245]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 25 01:08:45 volumio volumio[12245]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 25 01:08:45 volumio volumio[12245]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 25 01:08:45 volumio volumio[12245]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 25 01:08:45 volumio volumio[12245]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 25 01:08:45 volumio volumio[12245]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 25 01:08:45 volumio volumio[12245]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 25 01:08:45 volumio volumio[12245]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 25 01:08:45 volumio volumio[12245]: at IncomingMessage.emit (events.js:327:22) May 25 01:08:45 volumio volumio[12245]: at endReadableNT (internal/streams/readable.js:1327:12) May 25 01:08:45 volumio volumio[12245]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 25 01:08:45 volumio volumio[12245]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:08:45 volumio sudo[12362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 01:07 May 25 01:08:45 volumio sudo[12362]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:45 volumio sudo[12362]: pam_unix(sudo:session): session closed for user root May 25 01:08:46 volumio volumio-remote-updater[496]: [2025-05-25 01:08:46] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 25 01:08:46 volumio volumio-remote-updater[496]: [2025-05-25 01:08:46] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 25 01:08:46 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 25 01:08:46 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. May 25 01:08:46 volumio systemd[1]: Started dynamicswap service. May 25 01:08:46 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:08:46 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 25 01:08:46 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. May 25 01:08:46 volumio systemd[1]: Stopped Volumio Backend Module. May 25 01:08:46 volumio systemd[1]: Started Volumio Backend Module. May 25 01:08:46 volumio systemd[1]: Started dynamicswap service. May 25 01:08:46 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:08:47 volumio volumio[12373]: info: ------------------------------------------- May 25 01:08:47 volumio volumio[12373]: info: ----- Volumio3 ---- May 25 01:08:47 volumio volumio[12373]: info: ------------------------------------------- May 25 01:08:47 volumio volumio[12373]: info: ----- System startup ---- May 25 01:08:47 volumio volumio[12373]: info: ------------------------------------------- May 25 01:08:48 volumio volumio[12373]: info: MYVOLUMIO Environment detected May 25 01:08:48 volumio volumio[12373]: info: Plugin folders cleanup May 25 01:08:48 volumio volumio[12373]: info: Scanning into folder /volumio/app/plugins/ May 25 01:08:48 volumio volumio[12373]: info: Scanning category audio_interface May 25 01:08:48 volumio volumio[12373]: info: Scanning category miscellanea May 25 01:08:48 volumio volumio[12373]: info: Scanning category music_service May 25 01:08:48 volumio volumio[12373]: info: Scanning category plugins.json May 25 01:08:48 volumio volumio[12373]: info: Scanning category system_controller May 25 01:08:48 volumio volumio[12373]: info: Scanning category user_interface May 25 01:08:48 volumio volumio[12373]: info: Scanning into folder /data/plugins/ May 25 01:08:48 volumio volumio[12373]: info: Scanning category audio_interface May 25 01:08:48 volumio volumio[12373]: info: Scanning category user_interface May 25 01:08:48 volumio volumio[12373]: info: Plugin folders cleanup completed May 25 01:08:48 volumio volumio[12373]: info: ------------------------------------------- May 25 01:08:48 volumio volumio[12373]: info: ----- Core plugins startup ---- May 25 01:08:48 volumio volumio[12373]: info: ------------------------------------------- May 25 01:08:48 volumio volumio[12373]: info: Loading plugins from folder /volumio/app/plugins/ May 25 01:08:48 volumio volumio[12373]: info: Adding plugin upnp to MyMusic Plugins May 25 01:08:48 volumio volumio[12373]: info: Adding plugin airplay_emulation to MyMusic Plugins May 25 01:08:48 volumio volumio[12373]: info: Adding plugin upnp_browser to MyMusic Plugins May 25 01:08:48 volumio volumio[12373]: info: Loading plugins from folder /data/plugins/ May 25 01:08:48 volumio volumio[12373]: info: Loading plugin "system"... May 25 01:08:48 volumio volumio[12373]: info: Loading plugin "appearance"... May 25 01:08:48 volumio volumio[12373]: info: Loading plugin "network"... May 25 01:08:48 volumio volumio[12373]: info: Refreshing Cached IP Addresses May 25 01:08:48 volumio sudo[12401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 01:08:48 volumio sudo[12401]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:48 volumio sudo[12401]: pam_unix(sudo:session): session closed for user root May 25 01:08:48 volumio volumio[12373]: info: Loading plugin "services"... May 25 01:08:48 volumio volumio[12373]: info: Loading plugin "alsa_controller"... May 25 01:08:48 volumio sudo[12403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 01:08:48 volumio sudo[12403]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:48 volumio sudo[12406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 25 01:08:48 volumio sudo[12406]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:48 volumio sudo[12403]: pam_unix(sudo:session): session closed for user root May 25 01:08:48 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 01:08:48 volumio volumio[12373]: info: Loading plugin "wizard"... May 25 01:08:48 volumio volumio[12373]: info: Loading plugin "networkfs"... May 25 01:08:48 volumio volumio[12373]: info: Starting Udev Watcher for removable devices May 25 01:08:49 volumio volumio[12373]: info: Ignoring mount for partition: boot May 25 01:08:49 volumio volumio[12373]: info: Ignoring mount for partition: volumio May 25 01:08:49 volumio volumio[12373]: info: Ignoring mount for partition: volumio_data May 25 01:08:49 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "volumio_command_line_client"... May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "upnp"... May 25 01:08:49 volumio volumio[12373]: info: [1748110129015] Starting Upmpd Daemon May 25 01:08:49 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "my_music"... May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "mpd"... May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "upnp_browser"... May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "alarm-clock"... May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "airplay_emulation"... May 25 01:08:49 volumio volumio[12373]: info: Starting Shairport Sync May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "last_100"... May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "webradio"... May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "i2s_dacs"... May 25 01:08:49 volumio volumio[12373]: info: I2S DAC not set, start Auto-detection May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "volumiodiscovery"... May 25 01:08:49 volumio volumio[12373]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:08:49 volumio volumio[12373]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:49 volumio node[12373]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:08:49 volumio volumio[12373]: *** WARNING *** For more information see May 25 01:08:49 volumio volumio[12373]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:08:49 volumio volumio[12373]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:49 volumio volumio[12373]: *** WARNING *** For more information see May 25 01:08:49 volumio node[12373]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:49 volumio node[12373]: *** WARNING *** For more information see May 25 01:08:49 volumio node[12373]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:08:49 volumio node[12373]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:08:49 volumio node[12373]: *** WARNING *** For more information see May 25 01:08:49 volumio volumio[12373]: info: Applying required configuration parameters for plugin volumiodiscovery May 25 01:08:49 volumio volumio[12373]: info: Discovery: Started advertising with name: Volumio May 25 01:08:49 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:08:49 volumio volumio[12373]: info: Loading plugin "now_playing"... May 25 01:08:50 volumio volumio[12373]: info: Loading plugin "outputs"... May 25 01:08:50 volumio volumio[12373]: info: Loading plugin "albumart"... May 25 01:08:50 volumio volumio[12373]: info: Plugin example_plugin is not enabled May 25 01:08:50 volumio volumio[12373]: info: Loading plugin "inputs"... May 25 01:08:50 volumio volumio[12373]: info: Loading plugin "updater_comm"... May 25 01:08:50 volumio volumio[12373]: info: Plugin mpdemulation is not enabled May 25 01:08:50 volumio volumio[12373]: info: Loading plugin "rest_api"... May 25 01:08:50 volumio volumio[12373]: info: Loading plugin "websocket"... May 25 01:08:50 volumio volumio[12373]: info: Loading plugin "fusiondsp"... May 25 01:08:50 volumio volumio[12373]: Forking 3 albumart workers May 25 01:08:51 volumio volumio-remote-updater[496]: [2025-05-25 01:08:51] [connect] Successful connection May 25 01:08:51 volumio volumio[12373]: info: Applying required configuration parameters for plugin fusiondsp May 25 01:08:51 volumio volumio[12373]: info: Loading plugin "peppyspectrum"... May 25 01:08:51 volumio volumio[12373]: info: Loading plugin "touch_display"... May 25 01:08:51 volumio volumio[12373]: Starting albumart workers May 25 01:08:51 volumio volumio[12373]: Starting albumart workers May 25 01:08:51 volumio volumio[12373]: Starting albumart workers May 25 01:08:51 volumio volumio[12373]: info: Applying required configuration parameters for plugin touch_display May 25 01:08:52 volumio volumio[12373]: info: Loading i18n strings for locale en May 25 01:08:52 volumio volumio[12373]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. May 25 01:08:52 volumio volumio[12373]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. May 25 01:08:52 volumio volumio[12373]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. May 25 01:08:52 volumio volumio[12373]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. May 25 01:08:52 volumio volumio[12373]: Updating browse sources language May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::initPlayerControls May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:08:52 volumio volumio[12373]: Express server listening on port 3000 May 25 01:08:52 volumio volumio[12373]: [Metrics] WebUI: 5s 113.56ms May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::resetVolumioState May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::getcurrentVolume May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 1 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 2 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 3 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 4 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 5 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 6 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 7 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 8 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 9 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 10 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 11 May 25 01:08:52 volumio volumio-remote-updater[496]: [2025-05-25 01:08:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748110131 101 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 12 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 13 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 14 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 15 May 25 01:08:52 volumio volumio[12373]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 16 May 25 01:08:52 volumio volumio[12373]: info: Reloading queue from file May 25 01:08:52 volumio volumio[12373]: info: VolumeController:: Volume=86 Mute =false May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::pushState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioPushState May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::updateTrackBlock May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrackBlock May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::setRepeat null single undefined May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::pushState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioPushState May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::setRandom null May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::pushState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioPushState May 25 01:08:52 volumio volumio[12373]: info: Setting Device type: Raspberry PI May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: Received Get System Info May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:52 volumio volumio[12373]: info: Discovery: Getting this device information May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetQueue May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::getQueue May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getQueue May 25 01:08:52 volumio volumio[12373]: info: Listing playlists May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:08:52 volumio volumio[12373]: info: Received Get System Info May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:52 volumio volumio[12373]: info: Discovery: Getting this device information May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio sudo[12406]: pam_unix(sudo:session): session closed for user root May 25 01:08:52 volumio volumio[12373]: info: VolumeController:: Volume=86 Mute =false May 25 01:08:52 volumio volumio[12373]: info: CoreStateMachine::pushState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioPushState May 25 01:08:52 volumio volumio[12373]: info: Discovery: adding 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:08:52 volumio volumio[12373]: info: Discovery: Found device Volumio May 25 01:08:52 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:52 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:53 volumio volumio[12373]: info: Discovery: this is already registered, 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:08:53 volumio volumio[12373]: info: Discovery: Found device Volumio May 25 01:08:53 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:53 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:53 volumio volumio[12373]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:53 volumio volumio[12373]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:53 volumio volumio[12373]: info: FusionDsp - Choose a preset May 25 01:08:53 volumio volumio[12373]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:53 volumio volumio[12373]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:53 volumio volumio[12373]: info: FusionDsp - Choose a preset May 25 01:08:53 volumio volumio[12373]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:53 volumio volumio[12373]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:53 volumio volumio[12373]: info: FusionDsp - Choose a preset May 25 01:08:53 volumio volumio[12373]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:53 volumio ntpd[651]: Soliciting pool server 2401:5f80:5001:1f::31f May 25 01:08:53 volumio volumio[12373]: info: FusionDsp - Choose a preset May 25 01:08:53 volumio volumio[12373]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:54 volumio volumio[12373]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 17 May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:54 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:08:54 volumio volumio[12373]: info: Received Get System Info May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:08:54 volumio volumio[12373]: info: Discovery: Getting this device information May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:54 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::volumioGetState May 25 01:08:54 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:08:54 volumio volumio[12373]: info: Listing playlists May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:54 volumio volumio[12373]: info: FusionDsp - Choose a preset May 25 01:08:54 volumio volumio[12373]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:54 volumio volumio[12373]: info: FusionDsp - Choose a preset May 25 01:08:54 volumio volumio[12373]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:54 volumio volumio[12373]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:55 volumio volumio[12373]: info: FusionDsp - Choose a preset May 25 01:08:55 volumio volumio[12373]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:55 volumio volumio[12373]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:08:55 volumio volumio[12373]: info: FusionDsp - Choose a preset May 25 01:08:55 volumio volumio[12373]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:55 volumio volumio[12373]: info: FusionDsp - Choose a preset May 25 01:08:55 volumio volumio[12373]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:08:56 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:08:56 volumio volumio[12373]: info: Preload queue cleared May 25 01:08:58 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:08:58 volumio volumio[12373]: info: Preload queue cleared May 25 01:08:59 volumio sudo[12488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 01:08:59 volumio sudo[12488]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:59 volumio sudo[12488]: pam_unix(sudo:session): session closed for user root May 25 01:08:59 volumio sudo[12497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 01:08:59 volumio sudo[12497]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:59 volumio sudo[12497]: pam_unix(sudo:session): session closed for user root May 25 01:08:59 volumio sudo[12509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 25 01:08:59 volumio sudo[12509]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:08:59 volumio sudo[12509]: pam_unix(sudo:session): session closed for user root May 25 01:08:59 volumio volumio[12373]: info: Upmpdcli Daemon Started May 25 01:09:00 volumio volumio[12373]: info: Preload queue cleared May 25 01:09:00 volumio volumio[12373]: info: CoreCommandRouter::volumioReplaceandPlayItems May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::ClearQueue May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::stop May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 01:09:00 volumio volumio[12373]: info: CorePlayQueue::clearPlayQueue May 25 01:09:00 volumio volumio[12373]: info: CorePlayQueue::saveQueue May 25 01:09:00 volumio volumio[12373]: info: CoreCommandRouter::volumioPushQueue May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::addQueueItems May 25 01:09:00 volumio volumio[12373]: info: CorePlayQueue::addQueueItems May 25 01:09:00 volumio volumio[12373]: info: Preload queue cleared May 25 01:09:00 volumio volumio[12373]: info: Adding Item to queue: upnp/folder/http://192.168.1.21:2869/upnphost/udhisapi.dll?control=uuid:3f679fb4-d4cd-49af-b751-03e2a8a889cc+urn:upnp-org:serviceId:ContentDirectory@B May 25 01:09:00 volumio volumio[12373]: info: Exploding uri upnp/folder/http://192.168.1.21:2869/upnphost/udhisapi.dll?control=uuid:3f679fb4-d4cd-49af-b751-03e2a8a889cc+urn:upnp-org:serviceId:ContentDirectory@B in service upnp_browser May 25 01:09:00 volumio volumio[12373]: info: CoreCommandRouter::volumioPushQueue May 25 01:09:00 volumio volumio[12373]: info: CorePlayQueue::saveQueue May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::updateTrackBlock May 25 01:09:00 volumio volumio[12373]: info: CorePlayQueue::getTrackBlock May 25 01:09:00 volumio volumio[12373]: info: CoreCommandRouter::volumioPlay May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::play index 0 May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::stop May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::play index undefined May 25 01:09:00 volumio volumio[12373]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 01:09:00 volumio volumio[12373]: info: CorePlayQueue::getTrack 0 May 25 01:09:04 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:09:04 volumio volumio[12373]: info: Preload queue cleared May 25 01:09:07 volumio volumio[12373]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 25 01:09:07 volumio volumio[12373]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:09:07 volumio volumio[12373]: TypeError: Cannot read property 'length' of undefined May 25 01:09:07 volumio volumio[12373]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 25 01:09:07 volumio volumio[12373]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 25 01:09:07 volumio volumio[12373]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 25 01:09:07 volumio volumio[12373]: at Parser.emit (events.js:315:20) May 25 01:09:07 volumio volumio[12373]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 25 01:09:07 volumio volumio[12373]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 25 01:09:07 volumio volumio[12373]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 25 01:09:07 volumio volumio[12373]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 25 01:09:07 volumio volumio[12373]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 25 01:09:07 volumio volumio[12373]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 25 01:09:07 volumio volumio[12373]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 25 01:09:07 volumio volumio[12373]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 25 01:09:07 volumio volumio[12373]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 25 01:09:07 volumio volumio[12373]: at IncomingMessage.emit (events.js:327:22) May 25 01:09:07 volumio volumio[12373]: at endReadableNT (internal/streams/readable.js:1327:12) May 25 01:09:07 volumio volumio[12373]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 25 01:09:07 volumio volumio[12373]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:09:07 volumio sudo[12557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 01:08 May 25 01:09:07 volumio sudo[12557]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:09:07 volumio sudo[12557]: pam_unix(sudo:session): session closed for user root May 25 01:09:07 volumio volumio-remote-updater[496]: [2025-05-25 01:09:07] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 25 01:09:07 volumio volumio-remote-updater[496]: [2025-05-25 01:09:07] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 25 01:09:07 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 25 01:09:07 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. May 25 01:09:07 volumio systemd[1]: Started dynamicswap service. May 25 01:09:07 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:09:08 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 25 01:09:08 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. May 25 01:09:08 volumio systemd[1]: Stopped Volumio Backend Module. May 25 01:09:08 volumio systemd[1]: Started Volumio Backend Module. May 25 01:09:08 volumio systemd[1]: Started dynamicswap service. May 25 01:09:08 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 01:09:09 volumio volumio[12568]: info: ------------------------------------------- May 25 01:09:09 volumio volumio[12568]: info: ----- Volumio3 ---- May 25 01:09:09 volumio volumio[12568]: info: ------------------------------------------- May 25 01:09:09 volumio volumio[12568]: info: ----- System startup ---- May 25 01:09:09 volumio volumio[12568]: info: ------------------------------------------- May 25 01:09:09 volumio volumio[12568]: info: MYVOLUMIO Environment detected May 25 01:09:09 volumio volumio[12568]: info: Plugin folders cleanup May 25 01:09:09 volumio volumio[12568]: info: Scanning into folder /volumio/app/plugins/ May 25 01:09:09 volumio volumio[12568]: info: Scanning category audio_interface May 25 01:09:09 volumio volumio[12568]: info: Scanning category miscellanea May 25 01:09:09 volumio volumio[12568]: info: Scanning category music_service May 25 01:09:09 volumio volumio[12568]: info: Scanning category plugins.json May 25 01:09:09 volumio volumio[12568]: info: Scanning category system_controller May 25 01:09:09 volumio volumio[12568]: info: Scanning category user_interface May 25 01:09:09 volumio volumio[12568]: info: Scanning into folder /data/plugins/ May 25 01:09:09 volumio volumio[12568]: info: Scanning category audio_interface May 25 01:09:09 volumio volumio[12568]: info: Scanning category user_interface May 25 01:09:09 volumio volumio[12568]: info: Plugin folders cleanup completed May 25 01:09:09 volumio volumio[12568]: info: ------------------------------------------- May 25 01:09:09 volumio volumio[12568]: info: ----- Core plugins startup ---- May 25 01:09:09 volumio volumio[12568]: info: ------------------------------------------- May 25 01:09:09 volumio volumio[12568]: info: Loading plugins from folder /volumio/app/plugins/ May 25 01:09:09 volumio volumio[12568]: info: Adding plugin upnp to MyMusic Plugins May 25 01:09:09 volumio volumio[12568]: info: Adding plugin airplay_emulation to MyMusic Plugins May 25 01:09:09 volumio volumio[12568]: info: Adding plugin upnp_browser to MyMusic Plugins May 25 01:09:09 volumio volumio[12568]: info: Loading plugins from folder /data/plugins/ May 25 01:09:09 volumio volumio[12568]: info: Loading plugin "system"... May 25 01:09:09 volumio volumio[12568]: info: Loading plugin "appearance"... May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "network"... May 25 01:09:10 volumio volumio[12568]: info: Refreshing Cached IP Addresses May 25 01:09:10 volumio sudo[12596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 01:09:10 volumio sudo[12596]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:09:10 volumio sudo[12596]: pam_unix(sudo:session): session closed for user root May 25 01:09:10 volumio sudo[12598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 01:09:10 volumio sudo[12598]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "services"... May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "alsa_controller"... May 25 01:09:10 volumio sudo[12598]: pam_unix(sudo:session): session closed for user root May 25 01:09:10 volumio sudo[12602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 25 01:09:10 volumio sudo[12602]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:09:10 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "wizard"... May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "networkfs"... May 25 01:09:10 volumio volumio[12568]: info: Starting Udev Watcher for removable devices May 25 01:09:10 volumio volumio[12568]: info: Ignoring mount for partition: boot May 25 01:09:10 volumio volumio[12568]: info: Ignoring mount for partition: volumio May 25 01:09:10 volumio volumio[12568]: info: Ignoring mount for partition: volumio_data May 25 01:09:10 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "volumio_command_line_client"... May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "upnp"... May 25 01:09:10 volumio volumio[12568]: info: [1748110150726] Starting Upmpd Daemon May 25 01:09:10 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "my_music"... May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "mpd"... May 25 01:09:10 volumio volumio[12568]: info: Loading plugin "upnp_browser"... May 25 01:09:11 volumio volumio[12568]: info: Loading plugin "alarm-clock"... May 25 01:09:11 volumio volumio[12568]: info: Loading plugin "airplay_emulation"... May 25 01:09:11 volumio volumio[12568]: info: Starting Shairport Sync May 25 01:09:11 volumio volumio[12568]: info: Loading plugin "last_100"... May 25 01:09:11 volumio volumio[12568]: info: Loading plugin "webradio"... May 25 01:09:11 volumio volumio[12568]: info: Loading plugin "i2s_dacs"... May 25 01:09:11 volumio volumio[12568]: info: I2S DAC not set, start Auto-detection May 25 01:09:11 volumio volumio[12568]: info: Loading plugin "volumiodiscovery"... May 25 01:09:11 volumio volumio[12568]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:09:11 volumio volumio[12568]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:09:11 volumio volumio[12568]: *** WARNING *** For more information see May 25 01:09:11 volumio node[12568]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 01:09:11 volumio volumio[12568]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:09:11 volumio volumio[12568]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:09:11 volumio volumio[12568]: *** WARNING *** For more information see May 25 01:09:11 volumio node[12568]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:09:11 volumio node[12568]: *** WARNING *** For more information see May 25 01:09:11 volumio node[12568]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 01:09:11 volumio node[12568]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 01:09:11 volumio node[12568]: *** WARNING *** For more information see May 25 01:09:11 volumio volumio[12568]: info: Applying required configuration parameters for plugin volumiodiscovery May 25 01:09:11 volumio volumio[12568]: info: Discovery: Started advertising with name: Volumio May 25 01:09:11 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 01:09:11 volumio volumio[12568]: info: Loading plugin "now_playing"... May 25 01:09:12 volumio volumio[12568]: info: Loading plugin "outputs"... May 25 01:09:12 volumio volumio[12568]: info: Loading plugin "albumart"... May 25 01:09:12 volumio volumio[12568]: info: Plugin example_plugin is not enabled May 25 01:09:12 volumio volumio[12568]: info: Loading plugin "inputs"... May 25 01:09:12 volumio volumio[12568]: info: Loading plugin "updater_comm"... May 25 01:09:12 volumio volumio[12568]: info: Plugin mpdemulation is not enabled May 25 01:09:12 volumio volumio[12568]: info: Loading plugin "rest_api"... May 25 01:09:12 volumio volumio[12568]: info: Loading plugin "websocket"... May 25 01:09:12 volumio volumio[12568]: info: Loading plugin "fusiondsp"... May 25 01:09:12 volumio volumio[12568]: Forking 3 albumart workers May 25 01:09:12 volumio volumio[12568]: info: Applying required configuration parameters for plugin fusiondsp May 25 01:09:12 volumio volumio[12568]: info: Loading plugin "peppyspectrum"... May 25 01:09:12 volumio volumio-remote-updater[496]: [2025-05-25 01:09:12] [connect] Successful connection May 25 01:09:13 volumio volumio[12568]: info: Loading plugin "touch_display"... May 25 01:09:13 volumio volumio[12568]: Starting albumart workers May 25 01:09:13 volumio volumio[12568]: Starting albumart workers May 25 01:09:13 volumio volumio[12568]: Starting albumart workers May 25 01:09:13 volumio volumio[12568]: info: Applying required configuration parameters for plugin touch_display May 25 01:09:13 volumio volumio[12568]: info: Loading i18n strings for locale en May 25 01:09:13 volumio volumio[12568]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. May 25 01:09:13 volumio volumio[12568]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. May 25 01:09:13 volumio volumio[12568]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. May 25 01:09:13 volumio volumio[12568]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. May 25 01:09:13 volumio volumio[12568]: Updating browse sources language May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::initPlayerControls May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:09:13 volumio volumio[12568]: Express server listening on port 3000 May 25 01:09:13 volumio volumio[12568]: [Metrics] WebUI: 4s 964.97ms May 25 01:09:13 volumio volumio[12568]: info: CoreStateMachine::resetVolumioState May 25 01:09:13 volumio volumio[12568]: info: CoreStateMachine::getcurrentVolume May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:09:13 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 1 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 2 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 3 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 4 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 5 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 6 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 7 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 8 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 9 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 10 May 25 01:09:14 volumio volumio-remote-updater[496]: [2025-05-25 01:09:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748110152 101 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 11 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 12 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 13 May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 14 May 25 01:09:14 volumio volumio[12568]: info: Reloading queue from file May 25 01:09:14 volumio volumio[12568]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Total Clients: 15 May 25 01:09:14 volumio volumio[12568]: info: VolumeController:: Volume=86 Mute =false May 25 01:09:14 volumio volumio[12568]: info: CoreStateMachine::pushState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioPushState May 25 01:09:14 volumio volumio[12568]: info: CoreStateMachine::updateTrackBlock May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrackBlock May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioRetrievevolume May 25 01:09:14 volumio volumio[12568]: info: CoreStateMachine::setRepeat null single undefined May 25 01:09:14 volumio volumio[12568]: info: CoreStateMachine::pushState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioPushState May 25 01:09:14 volumio volumio[12568]: info: CoreStateMachine::setRandom null May 25 01:09:14 volumio volumio[12568]: info: CoreStateMachine::pushState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioPushState May 25 01:09:14 volumio volumio[12568]: info: Setting Device type: Raspberry PI May 25 01:09:14 volumio volumio[12568]: info: Discovery: adding 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:09:14 volumio volumio[12568]: info: Discovery: Found device Volumio May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: Discovery: this is already registered, 118533c8-b756-4628-b302-c2194fc05e7e May 25 01:09:14 volumio volumio[12568]: info: Discovery: Found device Volumio May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: VolumeController:: Volume=86 Mute =false May 25 01:09:14 volumio volumio[12568]: info: CoreStateMachine::pushState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioPushState May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: Received Get System Info May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:09:14 volumio volumio[12568]: info: Discovery: Getting this device information May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio sudo[12602]: pam_unix(sudo:session): session closed for user root May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetQueue May 25 01:09:14 volumio volumio[12568]: info: CoreStateMachine::getQueue May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getQueue May 25 01:09:14 volumio volumio[12568]: info: Listing playlists May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:09:14 volumio volumio[12568]: info: Received Get System Info May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:09:14 volumio volumio[12568]: info: Discovery: Getting this device information May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:14 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:14 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:14 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:14 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:14 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:15 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:15 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:15 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:15 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:15 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:15 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:16 volumio volumio[12568]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 16 May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::volumioGetVisibleSources May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:16 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 01:09:16 volumio volumio[12568]: info: Received Get System Info May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 01:09:16 volumio volumio[12568]: info: Discovery: Getting this device information May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:16 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:16 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:16 volumio volumio[12568]: info: Listing playlists May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:16 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:16 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:16 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:16 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:17 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:17 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:17 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:17 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:17 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:17 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:17 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:17 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:17 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:17 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:17 volumio volumio[12568]: info: FusionDsp - Choose a preset May 25 01:09:17 volumio volumio[12568]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 01:09:19 volumio volumio[12568]: info: Preload queue cleared May 25 01:09:20 volumio sudo[12676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 01:09:20 volumio sudo[12676]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:09:20 volumio sudo[12676]: pam_unix(sudo:session): session closed for user root May 25 01:09:20 volumio sudo[12679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 01:09:20 volumio sudo[12679]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:09:20 volumio sudo[12679]: pam_unix(sudo:session): session closed for user root May 25 01:09:20 volumio sudo[12682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 25 01:09:20 volumio sudo[12682]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 01:09:20 volumio sudo[12682]: pam_unix(sudo:session): session closed for user root May 25 01:09:20 volumio volumio[12568]: info: Upmpdcli Daemon Started May 25 01:09:21 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 01:09:21 volumio volumio[12568]: info: CURURI: playlists May 25 01:09:21 volumio volumio[12568]: info: Listing playlists May 25 01:09:21 volumio volumio[12568]: info: Preload queue cleared May 25 01:09:23 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 01:09:23 volumio volumio[12568]: info: CURURI: music-library May 25 01:09:23 volumio volumio[12568]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined May 25 01:09:27 volumio volumio[12568]: info: CoreCommandRouter::volumioGetState May 25 01:09:27 volumio volumio[12568]: info: CorePlayQueue::getTrack 0 May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::volumioGetBrowseSources May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::volumioGetBrowseSources May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::volumioGetBrowseSources May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 01:09:30 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 25 01:09:33 volumio volumio[12568]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 25 01:09:33 volumio volumio[12568]: verbose: ControllerMpd::sendMpdCommand update May 25 01:09:33 volumio volumio[12568]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:09:33 volumio volumio[12568]: TypeError: Cannot read property 'then' of undefined May 25 01:09:33 volumio volumio[12568]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6) May 25 01:09:33 volumio volumio[12568]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1898:15) May 25 01:09:33 volumio volumio[12568]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) May 25 01:09:33 volumio volumio[12568]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26) May 25 01:09:33 volumio volumio[12568]: at Socket.emit (events.js:315:20) May 25 01:09:33 volumio volumio[12568]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 25 01:09:33 volumio volumio[12568]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 25 01:09:33 volumio volumio[12568]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 01:09:33 volumio sudo[12694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 01:08 May 25 01:09:33 volumio sudo[12694]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"