-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Wed 2025-07-16 19:04:54 +07. -- Jul 16 19:03:04 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 16 19:03:04 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 16 19:03:04 volumio9 volumio[32364]: info: Discovery: Getting this device information Jul 16 19:03:04 volumio9 volumio[32364]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:04 volumio9 volumio[32364]: info: CorePlayQueue::getTrack 11 Jul 16 19:03:04 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:03:07 volumio9 volumio[32364]: info: Retrieving Cloud Streaming UI Jul 16 19:03:07 volumio9 volumio[32364]: info: Getting Tidal Cloud Configuration Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:03:07 volumio9 volumio[32364]: info: Getting Qobuz Cloud Configuration Jul 16 19:03:07 volumio9 volumio[32364]: info: Asking plugin for UI Config Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:03:07 volumio9 volumio[32364]: info: Getting Spotify Cloud Configuration Jul 16 19:03:07 volumio9 volumio[32364]: info: Asking plugin for UI Config Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:03:07 volumio9 volumio[32364]: info: Saving Spotify Acccount Jul 16 19:03:07 volumio9 volumio[32364]: info: Got Tidal Cloud Configuration Jul 16 19:03:07 volumio9 volumio[32364]: info: Got it Jul 16 19:03:07 volumio9 volumio[32364]: info: Got it Jul 16 19:03:07 volumio9 volumio[32364]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:03:07 volumio9 volumio[32364]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::volumioGetBrowseSources Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::volumioGetBrowseSources Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::volumioGetBrowseSources Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:07 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 16 19:03:09 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 16 19:03:09 volumio9 volumio[32364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jul 16 19:03:09 volumio9 volumio[32364]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 16 19:03:09 volumio9 volumio[32364]: Error: getaddrinfo -3007 Jul 16 19:03:09 volumio9 volumio[32364]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Jul 16 19:03:09 volumio9 volumio[32364]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Jul 16 19:03:09 volumio9 volumio[32364]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Jul 16 19:03:09 volumio9 volumio[32364]: code: -3007, Jul 16 19:03:09 volumio9 volumio[32364]: errno: -3007, Jul 16 19:03:09 volumio9 volumio[32364]: syscall: 'getaddrinfo' Jul 16 19:03:09 volumio9 volumio[32364]: } Jul 16 19:03:09 volumio9 volumio[32364]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 16 19:03:10 volumio9 sudo[7090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-16 19:02 Jul 16 19:03:10 volumio9 sudo[7090]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:10 volumio9 sudo[7090]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:10 volumio9 go-librespot[32598]: time="2025-07-16T19:03:10+07:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Jul 16 19:03:10 volumio9 systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 16 19:03:10 volumio9 volumio-remote-updater[650]: [2025-07-16 19:03:10] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 16 19:03:10 volumio9 volumio-remote-updater[650]: [2025-07-16 19:03:10] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 16 19:03:10 volumio9 systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 16 19:03:10 volumio9 systemd[1]: Started dynamicswap service. Jul 16 19:03:10 volumio9 systemd[1]: dynamicswap.service: Succeeded. Jul 16 19:03:10 volumio9 systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 16 19:03:10 volumio9 systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jul 16 19:03:10 volumio9 systemd[1]: Started dynamicswap service. Jul 16 19:03:10 volumio9 systemd[1]: Stopped Volumio Backend Module. Jul 16 19:03:10 volumio9 systemd[1]: Started Volumio Backend Module. Jul 16 19:03:10 volumio9 systemd[1]: dynamicswap.service: Succeeded. Jul 16 19:03:11 volumio9 volumio[7102]: info: ------------------------------------------- Jul 16 19:03:11 volumio9 volumio[7102]: info: ----- Volumio3 ---- Jul 16 19:03:11 volumio9 volumio[7102]: info: ------------------------------------------- Jul 16 19:03:11 volumio9 volumio[7102]: info: ----- System startup ---- Jul 16 19:03:11 volumio9 volumio[7102]: info: ------------------------------------------- Jul 16 19:03:12 volumio9 volumio[7102]: info: MYVOLUMIO Environment detected Jul 16 19:03:12 volumio9 volumio[7102]: info: Plugin folders cleanup Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning into folder /volumio/app/plugins/ Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning category audio_interface Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning category miscellanea Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning category music_service Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning category plugins.json Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning category system_controller Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning category user_interface Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning into folder /data/plugins/ Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning category music_service Jul 16 19:03:12 volumio9 volumio[7102]: info: Scanning category user_interface Jul 16 19:03:12 volumio9 volumio[7102]: info: Plugin folders cleanup completed Jul 16 19:03:12 volumio9 volumio[7102]: info: ------------------------------------------- Jul 16 19:03:12 volumio9 volumio[7102]: info: ----- Core plugins startup ---- Jul 16 19:03:12 volumio9 volumio[7102]: info: ------------------------------------------- Jul 16 19:03:12 volumio9 volumio[7102]: info: Loading plugins from folder /volumio/app/plugins/ Jul 16 19:03:12 volumio9 volumio[7102]: info: Adding plugin upnp to MyMusic Plugins Jul 16 19:03:12 volumio9 volumio[7102]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 16 19:03:12 volumio9 volumio[7102]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 16 19:03:12 volumio9 volumio[7102]: info: Loading plugins from folder /data/plugins/ Jul 16 19:03:12 volumio9 volumio[7102]: info: Loading plugin "system"... Jul 16 19:03:12 volumio9 volumio[7102]: info: Loading plugin "appearance"... Jul 16 19:03:12 volumio9 volumio[7102]: info: Loading plugin "network"... Jul 16 19:03:12 volumio9 volumio[7102]: info: Refreshing Cached IP Addresses Jul 16 19:03:12 volumio9 sudo[7129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 16 19:03:12 volumio9 sudo[7129]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:12 volumio9 sudo[7129]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:12 volumio9 sudo[7131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 16 19:03:12 volumio9 sudo[7131]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:12 volumio9 sudo[7131]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:12 volumio9 volumio[7102]: info: Loading plugin "services"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "alsa_controller"... Jul 16 19:03:13 volumio9 sudo[7140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 16 19:03:13 volumio9 sudo[7140]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:13 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "wizard"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "networkfs"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Cannot mount NAS Music2 at system boot, trial number 1 ,retrying in 5 seconds Jul 16 19:03:13 volumio9 volumio[7102]: info: Cannot mount NAS Storage4 at system boot, trial number 1 ,retrying in 5 seconds Jul 16 19:03:13 volumio9 volumio[7102]: info: Starting Udev Watcher for removable devices Jul 16 19:03:13 volumio9 volumio[7102]: info: Ignoring mount for partition: boot Jul 16 19:03:13 volumio9 volumio[7102]: info: Ignoring mount for partition: volumio Jul 16 19:03:13 volumio9 volumio[7102]: info: Ignoring mount for partition: volumio_data Jul 16 19:03:13 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "volumio_command_line_client"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "upnp"... Jul 16 19:03:13 volumio9 volumio[7102]: info: [1752667393107] Starting Upmpd Daemon Jul 16 19:03:13 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "my_music"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "mpd"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "upnp_browser"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "alarm-clock"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "airplay_emulation"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Starting Shairport Sync Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "last_100"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "webradio"... Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "i2s_dacs"... Jul 16 19:03:13 volumio9 volumio[7102]: info: I2S DAC not set, start Auto-detection Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "volumiodiscovery"... Jul 16 19:03:13 volumio9 volumio[7102]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 16 19:03:13 volumio9 volumio[7102]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 16 19:03:13 volumio9 node[7102]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 16 19:03:13 volumio9 volumio[7102]: *** WARNING *** For more information see Jul 16 19:03:13 volumio9 volumio[7102]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 16 19:03:13 volumio9 volumio[7102]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 16 19:03:13 volumio9 volumio[7102]: *** WARNING *** For more information see Jul 16 19:03:13 volumio9 node[7102]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 16 19:03:13 volumio9 node[7102]: *** WARNING *** For more information see Jul 16 19:03:13 volumio9 node[7102]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 16 19:03:13 volumio9 node[7102]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 16 19:03:13 volumio9 node[7102]: *** WARNING *** For more information see Jul 16 19:03:13 volumio9 volumio[7102]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 16 19:03:13 volumio9 volumio[7102]: info: Discovery: Started advertising with name: Volumio9 Jul 16 19:03:13 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 16 19:03:13 volumio9 volumio[7102]: info: Loading plugin "spop"... Jul 16 19:03:14 volumio9 volumio[7102]: info: Loading plugin "outputs"... Jul 16 19:03:14 volumio9 volumio[7102]: info: Loading plugin "albumart"... Jul 16 19:03:14 volumio9 sudo[7140]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:14 volumio9 volumio[7102]: info: Plugin example_plugin is not enabled Jul 16 19:03:14 volumio9 volumio[7102]: info: Loading plugin "inputs"... Jul 16 19:03:14 volumio9 volumio[7102]: info: Loading plugin "updater_comm"... Jul 16 19:03:14 volumio9 volumio[7102]: info: Plugin mpdemulation is not enabled Jul 16 19:03:14 volumio9 volumio[7102]: info: Loading plugin "rest_api"... Jul 16 19:03:14 volumio9 volumio[7102]: info: Loading plugin "websocket"... Jul 16 19:03:14 volumio9 volumio[7102]: info: Starting Socket.io Server version 2.3.0 Jul 16 19:03:14 volumio9 volumio[7102]: info: Loading plugin "lms"... Jul 16 19:03:14 volumio9 volumio[7102]: Forking 3 albumart workers Jul 16 19:03:14 volumio9 volumio[7102]: info: Loading plugin "touch_display"... Jul 16 19:03:14 volumio9 volumio[7102]: info: Applying required configuration parameters for plugin touch_display Jul 16 19:03:15 volumio9 volumio[7102]: info: Loading i18n strings for locale en Jul 16 19:03:15 volumio9 volumio[7102]: Updating browse sources language Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::initPlayerControls Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: Express server listening on port 3000 Jul 16 19:03:15 volumio9 volumio[7102]: [Metrics] WebUI: 3s 745.06ms Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreStateMachine::resetVolumioState Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreStateMachine::getcurrentVolume Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::volumioRetrievevolume Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreStateMachine::pushState Jul 16 19:03:15 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::volumioPushState Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:15 volumio9 volumio[7102]: Starting albumart workers Jul 16 19:03:15 volumio9 volumio-remote-updater[650]: [2025-07-16 19:03:15] [connect] Successful connection Jul 16 19:03:15 volumio9 volumio[7102]: info: Volumio Network Manager: Network status updated: 1 Jul 16 19:03:15 volumio9 volumio[7102]: Starting albumart workers Jul 16 19:03:15 volumio9 volumio[7102]: 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 Engine version: 3 Transport: polling Total Clients: 1 Jul 16 19:03:15 volumio9 volumio[7102]: verbose: New Socket.io Connection to 192.168.1.80:3000 from 192.168.1.78 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Jul 16 19:03:15 volumio9 volumio[7102]: verbose: New Socket.io Connection to 192.168.1.80 from 192.168.1.78 UA: Mozilla/5.0 (Linux; Android 13; 2201117TG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 16 19:03:15 volumio9 volumio[7102]: verbose: New Socket.io Connection to 192.168.1.80 from 192.168.1.78 UA: Mozilla/5.0 (Linux; Android 13; 2201117TG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 16 19:03:15 volumio9 volumio[7102]: verbose: New Socket.io Connection to 192.168.1.80 from 192.168.1.78 UA: Mozilla/5.0 (Linux; Android 13; 2201117TG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 16 19:03:15 volumio9 volumio[7102]: 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 Engine version: 3 Transport: polling Total Clients: 6 Jul 16 19:03:15 volumio9 volumio[7102]: verbose: New Socket.io Connection to 192.168.1.80 from 192.168.1.78 UA: Mozilla/5.0 (Linux; Android 13; 2201117TG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 16 19:03:15 volumio9 volumio[7102]: info: Discovery: Getting this device information Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:15 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 16 19:03:15 volumio9 volumio[7102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jul 16 19:03:15 volumio9 volumio-remote-updater[650]: [2025-07-16 19:03:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1752667395 101 Jul 16 19:03:15 volumio9 volumio[7102]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9 Jul 16 19:03:15 volumio9 volumio[7102]: info: Reloading queue from file Jul 16 19:03:15 volumio9 volumio[7102]: Starting albumart workers Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreStateMachine::setRepeat null single undefined Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreStateMachine::pushState Jul 16 19:03:15 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::volumioPushState Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreStateMachine::setRandom null Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreStateMachine::pushState Jul 16 19:03:15 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::volumioPushState Jul 16 19:03:15 volumio9 volumio[7102]: info: Setting Device type: Raspberry PI Jul 16 19:03:15 volumio9 volumio[7102]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jul 16 19:03:15 volumio9 volumio[7102]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Jul 16 19:03:15 volumio9 volumio[7102]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jul 16 19:03:15 volumio9 volumio[7102]: verbose: New Socket.io Connection to 192.168.1.80:3000 from 192.168.1.78 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:15 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 16 19:03:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 16 19:03:15 volumio9 volumio[7102]: verbose: New Socket.io Connection to 192.168.1.80 from 192.168.1.78 UA: Mozilla/5.0 (Linux; Android 13; 2201117TG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jul 16 19:03:15 volumio9 volumio[7102]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jul 16 19:03:15 volumio9 volumio[7102]: info: Completed loading Core Plugins Jul 16 19:03:15 volumio9 volumio[7102]: info: Preparing to generate the ALSA configuration file Jul 16 19:03:15 volumio9 volumio[7102]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jul 16 19:03:15 volumio9 volumio[7102]: info: Asound.conf file unchanged, so no further update is needed Jul 16 19:03:16 volumio9 volumio[7102]: info: Output device has changed, restarting MPD Jul 16 19:03:16 volumio9 sudo[7213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 16 19:03:16 volumio9 sudo[7213]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:16 volumio9 sudo[7213]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:16 volumio9 volumio[7102]: info: Output device has changed, restarting Shairport Sync Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:16 volumio9 sudo[7216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 16 19:03:16 volumio9 sudo[7216]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:16 volumio9 systemd[1]: Stopping Music Player Daemon... Jul 16 19:03:16 volumio9 volumio[7102]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 16 19:03:16 volumio9 volumio[7102]: info: ___________ START PLUGINS ___________ Jul 16 19:03:16 volumio9 volumio[7102]: info: ControllerMpd::onStart: Initializing MPD Jul 16 19:03:16 volumio9 volumio[7102]: info: Creating MPD Configuration file Jul 16 19:03:16 volumio9 sudo[7223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 16 19:03:16 volumio9 sudo[7223]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 16 19:03:16 volumio9 volumio[7102]: info: [1752667396145] CoreMusicLibrary::Adding element Media Servers Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 19:03:16 volumio9 sudo[7223]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:16 volumio9 sudo[7225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 16 19:03:16 volumio9 sudo[7225]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 16 19:03:16 volumio9 volumio[7102]: info: [1752667396258] CoreMusicLibrary::Adding element Last_100 Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 16 19:03:16 volumio9 volumio[7102]: info: [1752667396261] CoreMusicLibrary::Adding element Webradio Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 19:03:16 volumio9 volumio[7102]: info: Initializing BBC Radios Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: Creating Spotify config file Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: Loading i18n strings for locale en Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 19:03:16 volumio9 sudo[7253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart logitechmediaserver Jul 16 19:03:16 volumio9 sudo[7253]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:16 volumio9 volumio[7102]: info: Volumio Calling Home Jul 16 19:03:16 volumio9 sudo[7253]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:16 volumio9 sudo[7259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jul 16 19:03:16 volumio9 sudo[7259]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:16 volumio9 sudo[7262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jul 16 19:03:16 volumio9 sudo[7262]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:16 volumio9 sudo[7265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jul 16 19:03:16 volumio9 sudo[7265]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:16 volumio9 sudo[7259]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:16 volumio9 systemd[1]: Reloading. Jul 16 19:03:16 volumio9 volumio[7102]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Jul 16 19:03:16 volumio9 volumio[7102]: info: Received Get System Info Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 16 19:03:16 volumio9 volumio[7102]: info: Discovery: Getting this device information Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:16 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:16 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetVisibleSources Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:16 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 16 19:03:16 volumio9 volumio[7102]: info: Received Get System Info Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 16 19:03:16 volumio9 volumio[7102]: info: Discovery: Getting this device information Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:16 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:16 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:16 volumio9 volumio[7102]: info: Listing playlists Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetQueue Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreStateMachine::getQueue Jul 16 19:03:16 volumio9 volumio[7102]: info: CorePlayQueue::getQueue Jul 16 19:03:16 volumio9 volumio[7102]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jul 16 19:03:16 volumio9 volumio[7102]: info: The following error occurred while starting logitechmediaserver: Error: Command failed: /usr/bin/sudo /bin/systemctl restart logitechmediaserver Jul 16 19:03:16 volumio9 volumio[7102]: Failed to restart logitechmediaserver.service: Unit logitechmediaserver.service not found. Jul 16 19:03:16 volumio9 volumio[7102]: info: Could not start the LMS plugin in a fashionable manner. Jul 16 19:03:16 volumio9 volumio[7102]: info: MPD Permissions set Jul 16 19:03:16 volumio9 volumio[7102]: info: MPD Permissions set Jul 16 19:03:16 volumio9 volumio[7102]: info: Spotify config file written Jul 16 19:03:16 volumio9 sudo[7282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jul 16 19:03:16 volumio9 sudo[7282]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:16 volumio9 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 16 19:03:16 volumio9 volumio[7102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:03:16 volumio9 volumio[7102]: info: No need to fix Spotify hosts Jul 16 19:03:17 volumio9 volumio[7102]: info: Volumio called home Jul 16 19:03:17 volumio9 volumio[7102]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Jul 16 19:03:17 volumio9 systemd[1]: Reloading. Jul 16 19:03:17 volumio9 sudo[7265]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:17 volumio9 volumio[7102]: info: Starting Shairport Sync Jul 16 19:03:17 volumio9 sudo[7293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jul 16 19:03:17 volumio9 sudo[7293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:17 volumio9 volumio[7102]: info: Starting Shairport Sync Jul 16 19:03:17 volumio9 sudo[7293]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:17 volumio9 sudo[7296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 16 19:03:17 volumio9 sudo[7296]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:17 volumio9 volumio[7102]: info: Starting Shairport Sync Jul 16 19:03:17 volumio9 sudo[7307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 16 19:03:17 volumio9 sudo[7307]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:17 volumio9 sudo[7315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 16 19:03:17 volumio9 sudo[7315]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:17 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:17 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:17 volumio9 volumio[7102]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jul 16 19:03:17 volumio9 volumio[7102]: info: touch_display: systemctl daemon-reload succeeded. Jul 16 19:03:17 volumio9 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 16 19:03:17 volumio9 volumio[7102]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 16 19:03:17 volumio9 volumio[7102]: SPOTIFY: BQB25NVW4O9wEB4VkQgrEGCjGqpoDmpVkr8IC5fFX0c66kXsvq0kBF_2rwZEm7BYlwgPF3VihqwUGN53JWOQ2rvjOJ_VRmSAY8yA841htnrfl6HbMuBkCMSTeJIMl5ER2Lcz9rYK1spWXTvkG2hH5Yvh8Eyoi5JP5FIbzMNectS1uyIroPHpbHL83P9hxrve3-E_3PbbKKp8Y-MQKOhaEv1MLx7BuJadboUrOlEsp1-Lp8B49xZT9UjwF-Da0iSD5FuTsXcqUkf-1DGozQtSZKN2htkIgwUpcmW_Ik5ww1a3FbC9cuI Jul 16 19:03:17 volumio9 volumio[7102]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 16 19:03:17 volumio9 volumio[7102]: info: New Spotify access token = BQB25NVW4O9wEB4VkQgrEGCjGqpoDmpVkr8IC5fFX0c66kXsvq0kBF_2rwZEm7BYlwgPF3VihqwUGN53JWOQ2rvjOJ_VRmSAY8yA841htnrfl6HbMuBkCMSTeJIMl5ER2Lcz9rYK1spWXTvkG2hH5Yvh8Eyoi5JP5FIbzMNectS1uyIroPHpbHL83P9hxrve3-E_3PbbKKp8Y-MQKOhaEv1MLx7BuJadboUrOlEsp1-Lp8B49xZT9UjwF-Da0iSD5FuTsXcqUkf-1DGozQtSZKN2htkIgwUpcmW_Ik5ww1a3FbC9cuI Jul 16 19:03:17 volumio9 volumio[7102]: info: Spotify credentials grant success - running version from March 24, 2019 Jul 16 19:03:17 volumio9 sudo[7318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jul 16 19:03:17 volumio9 sudo[7318]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:17 volumio9 volumio[7102]: SPOTIFY: User informations: {"country":"TH","display_name":"ชนะ ชนะภัย","email":"schanapai@hotmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31ujwh6hkh6kshabxeokjduu7j3e"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31ujwh6hkh6kshabxeokjduu7j3e","id":"31ujwh6hkh6kshabxeokjduu7j3e","images":[{"height":300,"url":"https://scontent-fra5-2.xx.fbcdn.net/v/t39.30808-1/405560085_6916165708500864_5513590859254949333_n.jpg?stp=c427.0.1518.1518a_dst-jpg_s240x240_tt6&_nc_cat=106&ccb=1-7&_nc_sid=79bf43&_nc_ohc=cSgXL4AutaIQ7kNvwFIm0uu&_nc_oc=AdmcEipsykNxYlxxZPyXadhFK414s-i-orsbv2drkThBKNoWK3kzR2onQrz_HTc16otmN72f8bOw-euCxVH0BB0e&_nc_zt=24&_nc_ht=scontent-fra5-2.xx&edm=AP4hL3IEAAAA&_nc_gid=2QS6Po-austcRYFbovjMMg&oh=00_AfRqfvd714NGoesnaXGkyXuDggwKlHINjE5_sEPHwi7mLQ&oe=687D4B35","width":300},{"height":64,"url":"https://scontent-fra5-2.xx.fbcdn.net/v/t39.30808-1/405560085_6916165708500864_5513590859254949333_n.jpg?stp=c427.0.1518.1518a_cp0_dst-jpg_s50x50_tt6&_nc_cat=106&ccb=1-7&_nc_sid=28885b&_nc_ohc=cSgXL4AutaIQ7kNvwFIm0uu&_nc_oc=AdmcEipsykNxYlxxZPyXadhFK414s-i-orsbv2drkThBKNoWK3kzR2onQrz_HTc16otmN72f8bOw-euCxVH0BB0e&_nc_zt=24&_nc_ht=scontent-fra5-2.xx&edm=AP4hL3IEAAAA&_nc_gid=2QS6Po-austcRYFbovjMMg&oh=00_AfS_jBfPfr3kpWMq8u8qkOc2wXrLo6WRWiFi1GisjcPjHw&oe=687D4B35","width":64}],"product":"premium","type":"user","uri":"spotify:user:31ujwh6hkh6kshabxeokjduu7j3e"} Jul 16 19:03:17 volumio9 volumio[7102]: info: Spotify Successfully logged in Jul 16 19:03:17 volumio9 sudo[7262]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:17 volumio9 volumio[7102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 16 19:03:17 volumio9 volumio[7102]: info: [1752667397704] CoreMusicLibrary::Adding element Spotify Jul 16 19:03:17 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 19:03:17 volumio9 volumio[7102]: Cannot find translation for source Spotify Jul 16 19:03:17 volumio9 volumio[7102]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jul 16 19:03:17 volumio9 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 16 19:03:17 volumio9 systemd[1]: Stopping go-librespot Daemon... Jul 16 19:03:17 volumio9 systemd[1]: shairport-sync.service: Succeeded. Jul 16 19:03:17 volumio9 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 16 19:03:17 volumio9 systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Jul 16 19:03:17 volumio9 systemd[1]: go-librespot-daemon.service: Succeeded. Jul 16 19:03:17 volumio9 systemd[1]: Stopped go-librespot Daemon. Jul 16 19:03:17 volumio9 sudo[7318]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:17 volumio9 volumio[7102]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Jul 16 19:03:17 volumio9 volumio[7102]: info: touch_display: Volumio Kiosk started. Jul 16 19:03:17 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:17 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:17 volumio9 systemd[1]: Started go-librespot Daemon. Jul 16 19:03:17 volumio9 go-librespot[7320]: Librespot-go daemon starting... Jul 16 19:03:17 volumio9 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 16 19:03:17 volumio9 sudo[7282]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:17 volumio9 sudo[7307]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:17 volumio9 sudo[7296]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:17 volumio9 sudo[7315]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:17 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:17 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:17 volumio9 volumio[7102]: info: Shairport-Sync Started Jul 16 19:03:17 volumio9 volumio[7102]: Error adding Membership: Error: addMembership EINVAL Jul 16 19:03:17 volumio9 volumio[7102]: info: Shairport-Sync Started Jul 16 19:03:17 volumio9 go-librespot[7320]: time="2025-07-16T19:03:17+07:00" level=info msg="generated new device id: 4c77a4de8a9b08926a8e968713da8892f6b2d9f6" Jul 16 19:03:17 volumio9 go-librespot[7320]: time="2025-07-16T19:03:17+07:00" level=debug msg="stored credentials found for 31ujwh6hkh6kshabxeokjduu7j3e" Jul 16 19:03:17 volumio9 volumio[7102]: info: Shairport-Sync Started Jul 16 19:03:17 volumio9 volumio[7102]: info: touch_display: X display number found: 0 Jul 16 19:03:17 volumio9 volumio[7102]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 16 19:03:18 volumio9 volumio[7102]: info: touch_display: X display number found: 0 Jul 16 19:03:18 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:18 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:18 volumio9 volumio[7102]: info: touch_display: Setting screensaver timeout to 30 seconds. Jul 16 19:03:18 volumio9 volumio[7102]: info: Cannot mount NAS Music2 at system boot, trial number 2 ,retrying in 5 seconds Jul 16 19:03:18 volumio9 volumio[7102]: info: Cannot mount NAS Storage4 at system boot, trial number 2 ,retrying in 5 seconds Jul 16 19:03:18 volumio9 go-librespot[7320]: time="2025-07-16T19:03:18+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Jul 16 19:03:18 volumio9 go-librespot[7320]: time="2025-07-16T19:03:18+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jul 16 19:03:18 volumio9 go-librespot[7320]: time="2025-07-16T19:03:18+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jul 16 19:03:18 volumio9 go-librespot[7320]: time="2025-07-16T19:03:18+07:00" level=debug msg="zeroconf server listening on port 36153" Jul 16 19:03:18 volumio9 go-librespot[7320]: time="2025-07-16T19:03:18+07:00" level=debug msg="obtained new client token: AACmvCJyH7HMMvYSQpXGVIJouuJR5JftYXaLPBBFmNuv0LhMn6J2gesJlKSepGmKmiM3ihxiVFAiNW31e3ov6yXjijuCNjP2hi4+RPiER7MwftggoSG2GPQ54nVjg17bG7SQcWd5ic0VPxgGqZMrjHLyHI4i9DYFY56KVUj8bFkVwh4J4rbDrMxPBjYtoUBm9Se3CJlrDDZG1KZizTYeNm2kddlqgjsgKIyQKe8/SGata+y8orYIoKdYMQQ=" Jul 16 19:03:18 volumio9 go-librespot[7320]: time="2025-07-16T19:03:18+07:00" level=info msg="connected to ap-gae2.spotify.com:4070" Jul 16 19:03:18 volumio9 go-librespot[7320]: time="2025-07-16T19:03:18+07:00" level=debug msg="completed keyexchange" Jul 16 19:03:18 volumio9 go-librespot[7320]: time="2025-07-16T19:03:18+07:00" level=debug msg="completed challenge" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="authenticated as 31ujwh6hkh6kshabxeokjduu7j3e" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="authenticated as 31ujwh6hkh6kshabxeokjduu7j3e" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="dealer connection opened" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="initializing zeroconf session, username: 31ujwh6hkh6kshabxeokjduu7j3e" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="autoplay enabled: false" Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="received connection id: M2ZjYjVmZTgtMjBjZS00MDY4LWFmYmMtNzgyYmY3OWNkMTFhK2RlYWxlcit0Y3A6Ly8wYWIxNTgwNi5pcC5nYWUyLnNwb3RpZnkubmV0OjU3MDArODU0RjA3OEFEOTJDMDQwQUQyNjY0MDNFQTYzRDg2N0E3OEI1RjcyMzFGMzg0Mzg0NTc0Qzg0MzFEODYzNUM0Mg==" Jul 16 19:03:19 volumio9 volumio[7102]: 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 Engine version: 3 Transport: polling Total Clients: 13 Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetVisibleSources Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:19 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:19 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 16 19:03:19 volumio9 volumio[7102]: info: Received Get System Info Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 16 19:03:19 volumio9 volumio[7102]: info: Discovery: Getting this device information Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:19 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:19 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:19 volumio9 go-librespot[7320]: time="2025-07-16T19:03:19+07:00" level=debug msg="put connect state because NEW_DEVICE" Jul 16 19:03:19 volumio9 volumio[7102]: info: Listing playlists Jul 16 19:03:19 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:20 volumio9 volumio[7102]: info: go-librespot daemon successfully initialized Jul 16 19:03:21 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:21 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:22 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:22 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:23 volumio9 volumio[7102]: info: Cannot mount NAS Music2 at system boot, trial number 3 ,retrying in 5 seconds Jul 16 19:03:23 volumio9 volumio[7102]: info: Cannot mount NAS Storage4 at system boot, trial number 3 ,retrying in 5 seconds Jul 16 19:03:23 volumio9 sudo[7356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 16 19:03:23 volumio9 sudo[7356]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:23 volumio9 sudo[7356]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:23 volumio9 sudo[7359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 16 19:03:23 volumio9 sudo[7359]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:23 volumio9 sudo[7359]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:23 volumio9 sudo[7362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 16 19:03:23 volumio9 sudo[7362]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:23 volumio9 sudo[7362]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:23 volumio9 volumio[7102]: info: Upmpdcli Daemon Started Jul 16 19:03:23 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:23 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:23 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:23 volumio9 volumio[7102]: info: Initializing connection to go-librespot Websocket Jul 16 19:03:23 volumio9 go-librespot[7320]: time="2025-07-16T19:03:23+07:00" level=debug msg="new websocket client" Jul 16 19:03:23 volumio9 volumio[7102]: info: Connection to go-librespot Websocket established Jul 16 19:03:24 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:24 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:25 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:25 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 16 19:03:26 volumio9 volumio[7102]: info: Getting Spotify volume Jul 16 19:03:26 volumio9 volumio[7102]: info: Spotify volume: 100 Jul 16 19:03:26 volumio9 volumio[7102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Jul 16 19:03:26 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:26 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:27 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:28 volumio9 volumio[7102]: info: Cannot mount NAS Music2 at system boot, trial number 4 ,retrying in 5 seconds Jul 16 19:03:28 volumio9 volumio[7102]: info: Cannot mount NAS Storage4 at system boot, trial number 4 ,retrying in 5 seconds Jul 16 19:03:31 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:33 volumio9 volumio[7102]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jul 16 19:03:33 volumio9 volumio[7102]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jul 16 19:03:34 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 16 19:03:34 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 16 19:03:34 volumio9 volumio[7102]: info: Discovery: Getting this device information Jul 16 19:03:34 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:03:34 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:03:34 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 16 19:03:35 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:39 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:43 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:44 volumio9 mpd_monitor.sh[648]: MPD Monitor Service: MPD Appears to be inactive, restarting Jul 16 19:03:46 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 19:03:46 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:46 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 16 19:03:46 volumio9 volumio[7102]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion Jul 16 19:03:46 volumio9 volumio[7102]: error: Plugin music_service lms failed to complete 'onStart' in a timely fashion Jul 16 19:03:46 volumio9 volumio[7102]: info: ------------------------------------------- Jul 16 19:03:46 volumio9 volumio[7102]: info: ----- MyVolumio plugins startup ---- Jul 16 19:03:46 volumio9 volumio[7102]: info: ------------------------------------------- Jul 16 19:03:46 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 16 19:03:47 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:51 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 16 19:03:55 volumio9 volumio[7102]: info: Adding plugin bluetooth to MyMusic Plugins Jul 16 19:03:55 volumio9 volumio[7102]: info: Adding plugin multiroom to MyMusic Plugins Jul 16 19:03:55 volumio9 volumio[7102]: info: Adding plugin metavolumio to MyMusic Plugins Jul 16 19:03:55 volumio9 volumio[7102]: info: Adding plugin cd_controller to MyMusic Plugins Jul 16 19:03:55 volumio9 volumio[7102]: info: Adding plugin qobuzconnect to MyMusic Plugins Jul 16 19:03:55 volumio9 volumio[7102]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 16 19:03:55 volumio9 volumio[7102]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 16 19:03:55 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:55 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:55 volumio9 volumio[7102]: info: Starting MyVolumio Remote Streaming Endpoints Jul 16 19:03:55 volumio9 volumio[7102]: info: MyVolumio login type: Token Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 16 19:03:55 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 16 19:03:56 volumio9 volumio[7102]: info: Starting Streaming Service Transparent Proxy Jul 16 19:03:56 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 16 19:03:56 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 16 19:03:56 volumio9 volumio[7102]: info: Streaming services startup Jul 16 19:03:56 volumio9 volumio[7102]: info: Starting Streaming Daemon Jul 16 19:03:56 volumio9 sudo[7465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 16 19:03:56 volumio9 sudo[7465]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:56 volumio9 sudo[7465]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:56 volumio9 volumio[7102]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 16 19:03:56 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:56 volumio9 volumio[7102]: error: Cannot start Volumio Streaming Daemon Jul 16 19:03:56 volumio9 volumio[7102]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 16 19:03:56 volumio9 volumio[7102]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 16 19:03:56 volumio9 volumio[7102]: STREAMING PROXY: Starting server on port 3245 Jul 16 19:03:56 volumio9 volumio[7102]: Node JS runtime: 14 Jul 16 19:03:57 volumio9 volumio[7102]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 16 19:03:58 volumio9 volumio[7102]: info: MyVolumio token set successfully Jul 16 19:03:58 volumio9 volumio[7102]: info: MYVOLUMIO: Adding device Jul 16 19:03:58 volumio9 volumio[7102]: info: MYVOLUMIO: Evaluating Server Jul 16 19:03:58 volumio9 volumio[7102]: info: MyVolumio status changed Jul 16 19:03:58 volumio9 volumio[7102]: info: Streaming services startup Jul 16 19:03:58 volumio9 volumio[7102]: info: Starting Streaming Daemon Jul 16 19:03:58 volumio9 volumio[7102]: info: Removing browser output: myVolumio user plan is not superstar Jul 16 19:03:58 volumio9 volumio[7102]: info: Removing audio output: Jul 16 19:03:58 volumio9 volumio[7102]: info: Stoppping Tunnel 1 Jul 16 19:03:58 volumio9 sudo[7490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 16 19:03:58 volumio9 sudo[7490]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:58 volumio9 sudo[7490]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:58 volumio9 sudo[7493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jul 16 19:03:58 volumio9 volumio[7102]: error: Cannot start Volumio Streaming Daemon Jul 16 19:03:58 volumio9 volumio[7102]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 16 19:03:58 volumio9 volumio[7102]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 16 19:03:58 volumio9 sudo[7493]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:03:58 volumio9 sudo[7493]: pam_unix(sudo:session): session closed for user root Jul 16 19:03:58 volumio9 volumio[7102]: info: Remote SSH Stopped Jul 16 19:03:58 volumio9 volumio[7102]: info: Setting Geolocation for MyVolumio to as1 Jul 16 19:03:58 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:58 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:58 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:59 volumio9 volumio[7102]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 16 19:03:59 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:03:59 volumio9 volumio[7102]: info: Updating MyVolumio device info Jul 16 19:03:59 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:59 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:03:59 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:04:00 volumio9 volumio[7102]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 16 19:04:01 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Jul 16 19:04:01 volumio9 volumio[7102]: info: Adding a new share Jul 16 19:04:01 volumio9 volumio[7102]: info: Checking key NasMounts.15033b90-65ad-4624-91fe-903bb178cac4 Jul 16 19:04:01 volumio9 volumio[7102]: info: Checking key NasMounts.b7d917a2-3fb0-4196-baaf-33d2a751a304 Jul 16 19:04:01 volumio9 volumio[7102]: info: No correspondence found in configuration for share Storage3 on IP 192.168.1.13 Jul 16 19:04:01 volumio9 volumio[7102]: info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.1.13 -N Jul 16 19:04:01 volumio9 volumio[7102]: info: Negotiated SMB version with Storage3: SMB3_00 Jul 16 19:04:01 volumio9 volumio[7102]: info: Detected device Storage3 with version SMB3_00 Jul 16 19:04:01 volumio9 volumio[7102]: warn: Could not determine version number from SMB3_00 Jul 16 19:04:01 volumio9 sudo[7498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Santichai,password=MmXp3152,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.13/Music /mnt/NAS/Storage3 Jul 16 19:04:01 volumio9 sudo[7498]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 19:04:01 volumio9 kernel: CIFS: Attempting to mount //192.168.1.13/Music Jul 16 19:04:01 volumio9 sudo[7498]: pam_unix(sudo:session): session closed for user root Jul 16 19:04:02 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 16 19:04:03 volumio9 volumio[7102]: info: MYVOLUMIO: Adding device Jul 16 19:04:03 volumio9 volumio[7102]: info: MYVOLUMIO: Evaluating Server Jul 16 19:04:03 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:04 volumio9 volumio[7102]: info: Setting Geolocation for MyVolumio to as1 Jul 16 19:04:04 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:04:04 volumio9 volumio[7102]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 16 19:04:04 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 16 19:04:04 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 16 19:04:04 volumio9 volumio[7102]: info: Discovery: Getting this device information Jul 16 19:04:04 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:04:04 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:04:04 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 16 19:04:05 volumio9 volumio[7102]: info: Updating MyVolumio device info Jul 16 19:04:05 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:04:05 volumio9 volumio[7102]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 16 19:04:07 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:10 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 16 19:04:10 volumio9 volumio[7102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 16 19:04:10 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:04:10 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:04:11 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:04:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:04:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 16 19:04:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 16 19:04:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 16 19:04:15 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetBrowseSources Jul 16 19:04:15 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 19:04:16 volumio9 volumio[7102]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jul 16 19:04:16 volumio9 volumio[7102]: info: Completed starting MyVolumio Plugin Jul 16 19:04:16 volumio9 volumio[7102]: [Metrics] CommandRouter: 64s 482.37ms Jul 16 19:04:16 volumio9 volumio[7102]: info: CoreCommandRouter::volumiosetStartupVolume Jul 16 19:04:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 19:04:16 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 19:04:16 volumio9 volumio[7102]: info: CoreCommandRouter::Close All Modals sent Jul 16 19:04:16 volumio9 volumio[7102]: info: CoreCommandRouter::Close All Modals sent Jul 16 19:04:17 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 16 19:04:17 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 16 19:04:17 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 16 19:04:19 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:23 volumio9 volumio[7102]: info: BOOT COMPLETED Jul 16 19:04:23 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:27 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:30 volumio9 volumio[7102]: info: CALLMETHOD: miscellanea albumart saveAlbumartOptions [object Object] Jul 16 19:04:30 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: albumart , saveAlbumartOptions Jul 16 19:04:31 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:31 volumio9 volumio[7102]: info: [1752667471982] Database scan error: Error: Command failed: /usr/bin/mpc update Jul 16 19:04:31 volumio9 volumio[7102]: MPD error: Timeout Jul 16 19:04:34 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 16 19:04:34 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 16 19:04:34 volumio9 volumio[7102]: info: Discovery: Getting this device information Jul 16 19:04:34 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetState Jul 16 19:04:34 volumio9 volumio[7102]: info: CorePlayQueue::getTrack 0 Jul 16 19:04:34 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 16 19:04:35 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:38 volumio9 volumio[7102]: info: CALLMETHOD: music_service mpd saveMusicLibraryOptions [object Object] Jul 16 19:04:38 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , saveMusicLibraryOptions Jul 16 19:04:39 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:04:44 volumio9 volumio[7102]: info: Retrieving Cloud Streaming UI Jul 16 19:04:44 volumio9 volumio[7102]: info: Getting Tidal Cloud Configuration Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:04:44 volumio9 volumio[7102]: info: Getting Qobuz Cloud Configuration Jul 16 19:04:44 volumio9 volumio[7102]: info: Asking plugin for UI Config Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:04:44 volumio9 volumio[7102]: info: Getting Spotify Cloud Configuration Jul 16 19:04:44 volumio9 volumio[7102]: info: Asking plugin for UI Config Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:04:44 volumio9 volumio[7102]: info: Saving Spotify Acccount Jul 16 19:04:44 volumio9 volumio[7102]: info: Got Tidal Cloud Configuration Jul 16 19:04:44 volumio9 volumio[7102]: info: Got it Jul 16 19:04:44 volumio9 volumio[7102]: info: Got it Jul 16 19:04:44 volumio9 volumio[7102]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 16 19:04:44 volumio9 volumio[7102]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetBrowseSources Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetBrowseSources Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::volumioGetBrowseSources Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:44 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 16 19:04:46 volumio9 systemd[1]: mpd.service: State 'stop-sigterm' timed out. Killing. Jul 16 19:04:46 volumio9 systemd[1]: mpd.service: Killing process 32510 (mpd) with signal SIGKILL. Jul 16 19:04:48 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:52 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 16 19:04:53 volumio9 volumio[7102]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jul 16 19:04:53 volumio9 volumio[7102]: verbose: ControllerMpd::sendMpdCommand update Jul 16 19:04:53 volumio9 volumio[7102]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 16 19:04:53 volumio9 volumio[7102]: TypeError: Cannot read property 'then' of undefined Jul 16 19:04:53 volumio9 volumio[7102]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6) Jul 16 19:04:53 volumio9 volumio[7102]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1899:15) Jul 16 19:04:53 volumio9 volumio[7102]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Jul 16 19:04:53 volumio9 volumio[7102]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1091:26) Jul 16 19:04:53 volumio9 volumio[7102]: at Socket.emit (events.js:315:20) Jul 16 19:04:53 volumio9 volumio[7102]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 16 19:04:53 volumio9 volumio[7102]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 16 19:04:53 volumio9 volumio[7102]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 16 19:04:54 volumio9 sudo[7689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-16 19:03 Jul 16 19:04:54 volumio9 sudo[7689]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"