-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Mon 2026-01-26 22:58:32 CET. -- Jan 26 22:57:00 volumio volumio[1170]: info: MYVOLUMIO Environment detected Jan 26 22:57:00 volumio volumio[1170]: info: Plugin folders cleanup Jan 26 22:57:00 volumio volumio[1170]: info: Scanning into folder /volumio/app/plugins/ Jan 26 22:57:00 volumio volumio[1170]: info: Scanning category audio_interface Jan 26 22:57:00 volumio volumio[1170]: info: Scanning category miscellanea Jan 26 22:57:00 volumio volumio[1170]: info: Scanning category music_service Jan 26 22:57:00 volumio volumio[1170]: info: Scanning category plugins.json Jan 26 22:57:00 volumio volumio[1170]: info: Scanning category system_controller Jan 26 22:57:00 volumio volumio[1170]: info: Scanning category user_interface Jan 26 22:57:00 volumio volumio[1170]: info: Scanning into folder /data/plugins/ Jan 26 22:57:00 volumio volumio[1170]: info: Scanning category user_interface Jan 26 22:57:00 volumio volumio[1170]: info: Plugin folders cleanup completed Jan 26 22:57:00 volumio volumio[1170]: info: ------------------------------------------- Jan 26 22:57:00 volumio volumio[1170]: info: ----- Core plugins startup ---- Jan 26 22:57:00 volumio volumio[1170]: info: ------------------------------------------- Jan 26 22:57:00 volumio volumio[1170]: info: Loading plugins from folder /volumio/app/plugins/ Jan 26 22:57:00 volumio volumio[1170]: info: Adding plugin upnp to MyMusic Plugins Jan 26 22:57:00 volumio volumio[1170]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 26 22:57:00 volumio volumio[1170]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 26 22:57:00 volumio volumio[1170]: info: Loading plugins from folder /data/plugins/ Jan 26 22:57:00 volumio volumio[1170]: info: Loading plugin "system"... Jan 26 22:57:00 volumio volumio[1170]: info: Loading plugin "appearance"... Jan 26 22:57:01 volumio volumio[1170]: info: Loading plugin "network"... Jan 26 22:57:01 volumio volumio[1170]: info: Refreshing Cached IP Addresses Jan 26 22:57:01 volumio sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 26 22:57:01 volumio sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:01 volumio sudo[1202]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:01 volumio sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 26 22:57:01 volumio sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:01 volumio sudo[1204]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:01 volumio volumio[1170]: info: Loading plugin "services"... Jan 26 22:57:01 volumio volumio[1170]: info: Loading plugin "alsa_controller"... Jan 26 22:57:01 volumio sudo[1213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 26 22:57:01 volumio sudo[1213]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 26 22:57:01 volumio volumio[1170]: info: Loading plugin "wizard"... Jan 26 22:57:01 volumio volumio[1170]: info: Loading plugin "networkfs"... Jan 26 22:57:01 volumio volumio[1170]: info: Starting Udev Watcher for removable devices Jan 26 22:57:01 volumio volumio[1170]: info: Ignoring mount for partition: boot Jan 26 22:57:01 volumio volumio[1170]: info: Ignoring mount for partition: volumio Jan 26 22:57:01 volumio volumio[1170]: info: Ignoring mount for partition: volumio_data Jan 26 22:57:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 26 22:57:01 volumio volumio[1170]: info: Loading plugin "volumio_command_line_client"... Jan 26 22:57:01 volumio volumio[1170]: info: Loading plugin "upnp"... Jan 26 22:57:01 volumio volumio[1170]: info: [1769464621764] Starting Upmpd Daemon Jan 26 22:57:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 26 22:57:01 volumio volumio[1170]: info: Loading plugin "my_music"... Jan 26 22:57:01 volumio volumio[1170]: info: Loading plugin "mpd"... Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "upnp_browser"... Jan 26 22:57:02 volumio volumio[1170]: info: Starting UPNP Browser Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "alarm-clock"... Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "airplay_emulation"... Jan 26 22:57:02 volumio volumio[1170]: info: Starting Shairport Sync Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "last_100"... Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "webradio"... Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "i2s_dacs"... Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "volumiodiscovery"... Jan 26 22:57:02 volumio volumio[1170]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 26 22:57:02 volumio volumio[1170]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 26 22:57:02 volumio node[1170]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 26 22:57:02 volumio volumio[1170]: *** WARNING *** For more information see Jan 26 22:57:02 volumio volumio[1170]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 26 22:57:02 volumio volumio[1170]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 26 22:57:02 volumio volumio[1170]: *** WARNING *** For more information see Jan 26 22:57:02 volumio node[1170]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 26 22:57:02 volumio node[1170]: *** WARNING *** For more information see Jan 26 22:57:02 volumio node[1170]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 26 22:57:02 volumio node[1170]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 26 22:57:02 volumio node[1170]: *** WARNING *** For more information see Jan 26 22:57:02 volumio volumio[1170]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 26 22:57:02 volumio volumio[1170]: info: Discovery: Started advertising with name: Volumio Jan 26 22:57:02 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "outputs"... Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "albumart"... Jan 26 22:57:02 volumio volumio[1170]: info: Plugin example_plugin is not enabled Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "inputs"... Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "updater_comm"... Jan 26 22:57:02 volumio volumio[1170]: info: Plugin mpdemulation is not enabled Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "rest_api"... Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "websocket"... Jan 26 22:57:02 volumio volumio[1170]: info: Starting Socket.io Server version 2.3.0 Jan 26 22:57:02 volumio volumio[1170]: info: Loading plugin "touch_display"... Jan 26 22:57:02 volumio volumio[1170]: Forking 3 albumart workers Jan 26 22:57:03 volumio volumio[1170]: info: Applying required configuration parameters for plugin touch_display Jan 26 22:57:03 volumio volumio[1170]: Starting albumart workers Jan 26 22:57:03 volumio volumio[1170]: info: Loading i18n strings for locale pl Jan 26 22:57:03 volumio volumio[1170]: Starting albumart workers Jan 26 22:57:03 volumio volumio[1170]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jan 26 22:57:03 volumio volumio[1170]: Updating browse sources language Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 22:57:03 volumio volumio-remote-updater[745]: [2026-01-26 22:57:03] [connect] Successful connection Jan 26 22:57:03 volumio volumio[1170]: Starting albumart workers Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::initPlayerControls Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 22:57:03 volumio volumio[1170]: Express server listening on port 3000 Jan 26 22:57:03 volumio volumio[1170]: [Metrics] WebUI: 4s 692.01ms Jan 26 22:57:03 volumio volumio[1170]: info: CoreStateMachine::resetVolumioState Jan 26 22:57:03 volumio volumio[1170]: info: CoreStateMachine::getcurrentVolume Jan 26 22:57:03 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrievevolume Jan 26 22:57:03 volumio volumio[1170]: info: Cannot read play queue from file Jan 26 22:57:03 volumio volumio[1170]: info: Volumio Network Manager: Network status updated: 3 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jan 26 22:57:04 volumio volumio-remote-updater[745]: [2026-01-26 22:57:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1769464623 101 Jan 26 22:57:04 volumio volumio[1170]: 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: 13 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:04 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 21 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 22 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 24 Jan 26 22:57:04 volumio volumio[1170]: info: VolumeController:: Volume=100 Mute =true Jan 26 22:57:04 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:04 volumio volumio[1170]: info: CoreStateMachine::updateTrackBlock Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrackBlock Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrievevolume Jan 26 22:57:04 volumio volumio[1170]: info: CoreStateMachine::setRepeat null single undefined Jan 26 22:57:04 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:04 volumio volumio[1170]: info: CoreStateMachine::setRandom null Jan 26 22:57:04 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:04 volumio volumio[1170]: info: Setting Device type: Raspberry PI Jan 26 22:57:04 volumio volumio[1170]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jan 26 22:57:04 volumio volumio[1170]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 Jan 26 22:57:04 volumio volumio[1170]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: Completed loading Core Plugins Jan 26 22:57:04 volumio volumio[1170]: info: Preparing to generate the ALSA configuration file Jan 26 22:57:04 volumio volumio[1170]: info: Received Get System Info Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:04 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 26 22:57:04 volumio volumio[1170]: info: Received Get System Info Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:04 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: Listing playlists Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 25 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 26 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 27 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 29 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 30 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 31 Jan 26 22:57:04 volumio volumio[1170]: info: Discovery: adding 9413c325-09ab-4590-87f1-0857c771a07e Jan 26 22:57:04 volumio volumio[1170]: info: Discovery: Found device Volumio Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: VolumeController:: Volume=100 Mute =true Jan 26 22:57:04 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:04 volumio volumio[1170]: info: Discovery: this is already registered, 9413c325-09ab-4590-87f1-0857c771a07e Jan 26 22:57:04 volumio volumio[1170]: info: Discovery: Found device Volumio Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:04 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:04 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 31 Jan 26 22:57:04 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70 from 192.168.0.40 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 32 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:04 volumio volumio[1170]: info: Asound.conf file written Jan 26 22:57:04 volumio sudo[1297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 26 22:57:04 volumio sudo[1297]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:04 volumio sudo[1297]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:04 volumio volumio[1170]: info: Output device has changed, restarting MPD Jan 26 22:57:04 volumio volumio[1170]: info: Output device has changed, restarting Shairport Sync Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:04 volumio sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 22:57:04 volumio sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:04 volumio sudo[1302]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:04 volumio sudo[1304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 22:57:04 volumio sudo[1304]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:04 volumio volumio[1170]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 26 22:57:04 volumio volumio[1170]: info: ___________ START PLUGINS ___________ Jan 26 22:57:04 volumio volumio[1170]: info: ControllerMpd::onStart: Initializing MPD Jan 26 22:57:04 volumio volumio[1170]: info: Creating MPD Configuration file Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 22:57:04 volumio sudo[1312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 22:57:04 volumio sudo[1312]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 26 22:57:04 volumio volumio[1170]: info: [1769464624705] CoreMusicLibrary::Adding element Serwery Mediów Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 22:57:04 volumio volumio[1170]: info: UPNP Browser: Client initialized successfully Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:04 volumio sudo[1312]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:04 volumio systemd[1]: Listening on mpd.socket. Jan 26 22:57:04 volumio sudo[1314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 22:57:04 volumio sudo[1314]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:04 volumio systemd[1]: Starting Music Player Daemon... Jan 26 22:57:04 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 26 22:57:04 volumio systemd[1]: mpd.service: Succeeded. Jan 26 22:57:04 volumio systemd[1]: Stopped Music Player Daemon. Jan 26 22:57:04 volumio systemd[1]: Starting Music Player Daemon... Jan 26 22:57:04 volumio volumio[1170]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:04 volumio volumio[1170]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 26 22:57:04 volumio volumio[1170]: info: [1769464624792] CoreMusicLibrary::Adding element Last_100 Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 26 22:57:04 volumio volumio[1170]: info: [1769464624795] CoreMusicLibrary::Adding element Webradio Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 26 22:57:04 volumio volumio[1170]: info: Initializing BBC Radios Jan 26 22:57:04 volumio sudo[1321]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 22:57:04 volumio sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:04 volumio sudo[1321]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 26 22:57:04 volumio sudo[1321]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:04 volumio volumio[1170]: info: Loading i18n strings for locale pl Jan 26 22:57:04 volumio volumio[1170]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jan 26 22:57:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 26 22:57:04 volumio volumio[1170]: info: Volumio Calling Home Jan 26 22:57:04 volumio sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jan 26 22:57:04 volumio sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:04 volumio sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jan 26 22:57:04 volumio sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:04 volumio sudo[1346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jan 26 22:57:04 volumio sudo[1346]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:05 volumio volumio[1170]: info: touch_display: Backlight interface detected. Jan 26 22:57:05 volumio systemd[1]: Reloading. Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:05 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 33 Jan 26 22:57:05 volumio volumio[1170]: info: MPD Permissions set Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:05 volumio volumio[1170]: info: Volumio called home Jan 26 22:57:05 volumio volumio[1170]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 34 Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:05 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:05 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:05 volumio 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. Jan 26 22:57:05 volumio sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/10-0045/brightness Jan 26 22:57:05 volumio sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:05 volumio volumio[1170]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Jan 26 22:57:05 volumio sudo[1374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jan 26 22:57:05 volumio sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:05 volumio sudo[1371]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:05 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:05 volumio volumio[1170]: info: Starting Shairport Sync Jan 26 22:57:05 volumio volumio[1170]: info: Starting Shairport Sync Jan 26 22:57:05 volumio volumio[1170]: info: Starting Shairport Sync Jan 26 22:57:05 volumio sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 26 22:57:05 volumio sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:05 volumio sudo[1374]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:05 volumio sudo[1379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 26 22:57:05 volumio sudo[1379]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:05 volumio sudo[1383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 26 22:57:05 volumio sudo[1383]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:05 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:05 volumio volumio[1170]: info: touch_display: File permissions for backlight brightness control set. Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:05 volumio volumio[1170]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:05 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:05 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:05 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:05 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:05 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:05 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:05 volumio sudo[1213]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:05 volumio sudo[1346]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:05 volumio volumio[1170]: info: touch_display: systemctl daemon-reload succeeded. Jan 26 22:57:05 volumio systemd[1]: Reloading. Jan 26 22:57:05 volumio sudo[1388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jan 26 22:57:05 volumio sudo[1388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:05 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:05 volumio 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. Jan 26 22:57:06 volumio sudo[1343]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:06 volumio volumio[1170]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jan 26 22:57:06 volumio sudo[1388]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:06 volumio volumio[1170]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service Jan 26 22:57:06 volumio volumio[1170]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found. Jan 26 22:57:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 26 22:57:06 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 26 22:57:06 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:06 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:06 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:06 volumio sudo[1341]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:06 volumio volumio[1170]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jan 26 22:57:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 26 22:57:06 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:06 volumio sudo[1383]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:06 volumio sudo[1377]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:06 volumio sudo[1379]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:06 volumio volumio[1170]: info: Shairport-Sync Started Jan 26 22:57:06 volumio volumio[1170]: Error adding Membership: Error: addMembership EINVAL Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:06 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:06 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:06 volumio volumio[1170]: info: Shairport-Sync Started Jan 26 22:57:06 volumio volumio[1170]: info: Shairport-Sync Started Jan 26 22:57:06 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:06 volumio mpd[1328]: Jan 26 22:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 22:57:06 volumio systemd[1]: Started Music Player Daemon. Jan 26 22:57:06 volumio sudo[1304]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:06 volumio sudo[1314]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:06 volumio volumio[1170]: info: Completed starting Core Plugins Jan 26 22:57:06 volumio volumio[1170]: info: ------------------------------------------- Jan 26 22:57:06 volumio volumio[1170]: info: ----- MyVolumio plugins startup ---- Jan 26 22:57:06 volumio volumio[1170]: info: ------------------------------------------- Jan 26 22:57:06 volumio volumio[1170]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 26 22:57:06 volumio volumio[1170]: error: MPD error: The expression evaluated to a falsy value: Jan 26 22:57:06 volumio volumio[1170]: assert.ok(self.idling) Jan 26 22:57:06 volumio volumio[1170]: error: The expression evaluated to a falsy value: Jan 26 22:57:06 volumio volumio[1170]: assert.ok(self.idling) Jan 26 22:57:06 volumio volumio[1170]: info: MPD running with PID1328 Jan 26 22:57:06 volumio volumio[1170]: ,establishing connection Jan 26 22:57:06 volumio volumio[1170]: error: updateQueue error: null Jan 26 22:57:06 volumio volumio[1170]: error: updateQueue error: null Jan 26 22:57:06 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:07 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:07 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:07 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:07 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:07 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:07 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:07 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:08 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:08 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:08 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:08 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:08 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:08 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:09 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:09 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jan 26 22:57:09 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:09 volumio sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 26 22:57:09 volumio sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:09 volumio sudo[1415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 26 22:57:09 volumio sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:09 volumio systemd[1]: Started MPD Monitor Service. Jan 26 22:57:09 volumio mpd_monitor.sh[1417]: MPD Monitor Service: Starting MPD Monitor Service Jan 26 22:57:09 volumio systemd[1]: Stopping MPD Monitor Service... Jan 26 22:57:09 volumio sudo[1412]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:09 volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Jan 26 22:57:09 volumio systemd[1]: mpd_monitor.service: Succeeded. Jan 26 22:57:09 volumio systemd[1]: Stopped MPD Monitor Service. Jan 26 22:57:09 volumio volumio[1170]: info: Successfully started MPD Monitor Jan 26 22:57:09 volumio systemd[1]: Started MPD Monitor Service. Jan 26 22:57:09 volumio sudo[1415]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:09 volumio volumio[1170]: info: Successfully started MPD Monitor Jan 26 22:57:09 volumio mpd_monitor.sh[1419]: MPD Monitor Service: Starting MPD Monitor Service Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:10 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:10 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:10 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:10 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:10 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:10 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:10 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:11 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:11 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:11 volumio sudo[1438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 26 22:57:11 volumio sudo[1438]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:11 volumio sudo[1438]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:11 volumio sudo[1440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 26 22:57:11 volumio sudo[1440]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:11 volumio sudo[1440]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:11 volumio sudo[1444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 26 22:57:11 volumio sudo[1444]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:11 volumio volumio[1170]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 26 22:57:11 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jan 26 22:57:11 volumio sudo[1444]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:11 volumio volumio[1170]: info: Upmpdcli Daemon Started Jan 26 22:57:11 volumio volumio[1446]: Generating RSA private key, 4096 bit long modulus (2 primes) Jan 26 22:57:12 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:12 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:13 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:13 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:14 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 26 22:57:15 volumio volumio[1170]: info: Adding plugin bluetooth to MyMusic Plugins Jan 26 22:57:15 volumio volumio[1170]: info: Adding plugin multiroom to MyMusic Plugins Jan 26 22:57:15 volumio volumio[1170]: info: Adding plugin metavolumio to MyMusic Plugins Jan 26 22:57:15 volumio volumio[1170]: info: Adding plugin cd_controller to MyMusic Plugins Jan 26 22:57:15 volumio volumio[1170]: info: Adding plugin qobuzconnect to MyMusic Plugins Jan 26 22:57:15 volumio volumio[1170]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 26 22:57:15 volumio volumio[1170]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 26 22:57:15 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 26 22:57:16 volumio volumio[1170]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 26 22:57:16 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 26 22:57:16 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:16 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:16 volumio volumio[1170]: info: Starting MyVolumio Remote Streaming Endpoints Jan 26 22:57:16 volumio volumio[1170]: info: MyVolumio login type: Token Jan 26 22:57:16 volumio volumio[1170]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 26 22:57:16 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 26 22:57:16 volumio volumio[1170]: info: Starting Streaming Service Transparent Proxy Jan 26 22:57:16 volumio volumio[1170]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 26 22:57:16 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 26 22:57:16 volumio volumio[1170]: info: Streaming services startup Jan 26 22:57:16 volumio volumio[1170]: info: Starting Streaming Daemon Jan 26 22:57:16 volumio sudo[1469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 26 22:57:16 volumio sudo[1469]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:17 volumio sudo[1469]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:17 volumio volumio[1170]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 26 22:57:17 volumio volumio[1170]: error: Cannot start Volumio Streaming Daemon Jan 26 22:57:17 volumio volumio[1170]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 26 22:57:17 volumio volumio[1170]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 26 22:57:17 volumio volumio[1170]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 26 22:57:17 volumio volumio[1170]: STREAMING PROXY: Starting server on port 3245 Jan 26 22:57:17 volumio volumio[1170]: Node JS runtime: 14 Jan 26 22:57:17 volumio volumio[1170]: info: MyVolumio token set successfully Jan 26 22:57:17 volumio volumio[1170]: info: MYVOLUMIO: Adding device Jan 26 22:57:17 volumio volumio[1170]: info: MYVOLUMIO: Evaluating Server Jan 26 22:57:18 volumio volumio[1170]: info: MyVolumio Plan changed: premium Jan 26 22:57:18 volumio volumio[1170]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jan 26 22:57:18 volumio volumio[1170]: info: Removing browser output: myVolumio user plan is not superstar Jan 26 22:57:18 volumio volumio[1170]: info: Removing audio output: Jan 26 22:57:18 volumio volumio[1170]: info: MYVOLUMIO: Adding device Jan 26 22:57:18 volumio volumio[1170]: info: MYVOLUMIO: Evaluating Server Jan 26 22:57:18 volumio volumio[1170]: info: Remote config written successfully Jan 26 22:57:18 volumio volumio[1170]: info: Starting Tunnel 1 Jan 26 22:57:18 volumio volumio[1170]: info: Starting Tunnel Connection Checker Jan 26 22:57:18 volumio volumio[1170]: info: Completed starting MyVolumio Plugin Jan 26 22:57:18 volumio volumio[1170]: info: MYVolumio Device enabled Jan 26 22:57:18 volumio volumio[1170]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jan 26 22:57:18 volumio volumio[1170]: info: MyVolumio status changed Jan 26 22:57:18 volumio volumio[1170]: info: Streaming services startup Jan 26 22:57:18 volumio volumio[1170]: info: Starting Streaming Daemon Jan 26 22:57:18 volumio volumio[1170]: info: Setting Geolocation for MyVolumio to eu7 Jan 26 22:57:18 volumio sudo[1515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 26 22:57:18 volumio sudo[1515]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:18 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:18 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:18 volumio sudo[1515]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:18 volumio volumio[1170]: error: Cannot start Volumio Streaming Daemon Jan 26 22:57:18 volumio volumio[1170]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 26 22:57:18 volumio volumio[1170]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 26 22:57:18 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jan 26 22:57:18 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jan 26 22:57:18 volumio volumio[1170]: info: [1769464638923] Starting BluetoothController Jan 26 22:57:18 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jan 26 22:57:20 volumio sudo[1518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jan 26 22:57:20 volumio sudo[1518]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio sudo[1518]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio volumio[1170]: info: MRS: MultiRoom plugin initialized Jan 26 22:57:20 volumio volumio[1170]: info: MRS: STOPPING SNAPCLIENT Jan 26 22:57:20 volumio volumio[1170]: info: MRS: Snap server stop Jan 26 22:57:20 volumio sudo[1534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jan 26 22:57:20 volumio sudo[1534]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio volumio[1170]: info: MRS: STOPPING volumioStreaming Jan 26 22:57:20 volumio sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jan 26 22:57:20 volumio sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jan 26 22:57:20 volumio sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio sudo[1534]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jan 26 22:57:20 volumio sudo[1543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jan 26 22:57:20 volumio sudo[1543]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio sudo[1543]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio sudo[1536]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio sudo[1540]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Jan 26 22:57:20 volumio volumio[1170]: info: Preparing to generate the ALSA configuration file Jan 26 22:57:20 volumio volumio[1170]: info: Updating MyVolumio device info Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:20 volumio volumio[1170]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 26 22:57:20 volumio volumio[1170]: info: Reading ALSA contributions from plugins. Jan 26 22:57:20 volumio volumio[1170]: info: Setting Geolocation for MyVolumio to eu8 Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:20 volumio volumio[1170]: info: MRS: Removed streaming files Jan 26 22:57:20 volumio volumio[1170]: info: MRS: volumioStreaming STOPPED Jan 26 22:57:20 volumio volumio[1170]: info: MRS: SNAPSERVER STOPPED Jan 26 22:57:20 volumio volumio[1170]: info: MRS: SNAPCLIENT STOPPED Jan 26 22:57:20 volumio volumio[1170]: info: Asound.conf file written Jan 26 22:57:20 volumio sudo[1546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 26 22:57:20 volumio sudo[1546]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio sudo[1546]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio volumio[1170]: info: Output device has changed, restarting MPD Jan 26 22:57:20 volumio sudo[1551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 22:57:20 volumio sudo[1551]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio volumio[1170]: info: Output device has changed, restarting Shairport Sync Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:20 volumio sudo[1551]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio sudo[1554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 22:57:20 volumio sudo[1554]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio systemd[1]: Stopping Music Player Daemon... Jan 26 22:57:20 volumio volumio[1170]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 26 22:57:20 volumio volumio[1170]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jan 26 22:57:20 volumio volumio[1170]: info: MRS: Pushing multiroomSync output for this device Jan 26 22:57:20 volumio volumio[1170]: info: MRS: Pushing multiroomSync output Jan 26 22:57:20 volumio volumio[1170]: info: Adding audio output: Jan 26 22:57:20 volumio sudo[1562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Jan 26 22:57:20 volumio sudo[1562]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio volumio[1170]: info: Adding audio output: Jan 26 22:57:20 volumio sudo[1562]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio volumio[1170]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jan 26 22:57:20 volumio systemd[1]: mpd.service: Succeeded. Jan 26 22:57:20 volumio systemd[1]: Stopped Music Player Daemon. Jan 26 22:57:20 volumio volumio[1170]: info: Adding METAVOLUMIO REST API Endpoints Jan 26 22:57:20 volumio volumio[1170]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jan 26 22:57:20 volumio volumio[1170]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jan 26 22:57:20 volumio volumio[1170]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jan 26 22:57:20 volumio volumio[1170]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jan 26 22:57:20 volumio volumio[1170]: info: Preparing CD Folders Jan 26 22:57:20 volumio volumio[1170]: info: Adding CD REST API Endpoints Jan 26 22:57:20 volumio volumio[1170]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jan 26 22:57:20 volumio volumio[1170]: info: Starting UDEV Watcher for CD Jan 26 22:57:20 volumio volumio[1170]: info: Detecting CD presence with UDEV Jan 26 22:57:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jan 26 22:57:20 volumio volumio[1170]: info: Adding inputs REST Endpoints Jan 26 22:57:20 volumio volumio[1170]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jan 26 22:57:20 volumio volumio[1170]: info: Scanning Audio Inputs Jan 26 22:57:20 volumio volumio[1170]: info: Checking against Known Cards name Jan 26 22:57:20 volumio volumio[1170]: info: Adding Server instance for streaming Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jan 26 22:57:20 volumio volumio[1170]: error: Hi Res Audio Failed Login: Missing Login Data Jan 26 22:57:20 volumio volumio[1170]: info: Adding HIGHRESAUDIO REST API Endpoints Jan 26 22:57:20 volumio volumio[1170]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 26 22:57:20 volumio volumio[1170]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jan 26 22:57:20 volumio systemd[1]: Starting Music Player Daemon... Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jan 26 22:57:20 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Jan 26 22:57:20 volumio volumio[1170]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Jan 26 22:57:20 volumio sudo[1571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 26 22:57:20 volumio sudo[1571]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio volumio[1170]: info: QobuzConnect: Starting Qobuz Connect socket and service Jan 26 22:57:20 volumio volumio[1170]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Jan 26 22:57:20 volumio volumio[1170]: info: Adding TIDAL REST API Endpoints Jan 26 22:57:20 volumio volumio[1170]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jan 26 22:57:20 volumio volumio[1170]: info: Stopping AccessToken refresher cron for QOBUZ Jan 26 22:57:20 volumio sudo[1577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 26 22:57:20 volumio sudo[1577]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio sudo[1571]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio sudo[1567]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 22:57:20 volumio sudo[1567]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:20 volumio sudo[1577]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio volumio[1170]: info: AccessToken refresher cron started for QOBUZ Jan 26 22:57:20 volumio sudo[1567]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:20 volumio volumio[1170]: info: Adding QOBUZ REST API Endpoints Jan 26 22:57:20 volumio volumio[1170]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jan 26 22:57:20 volumio sudo[1581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 26 22:57:20 volumio sudo[1581]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:21 volumio volumio[1170]: info: Successfully Added MyVolumio device Jan 26 22:57:21 volumio volumio[1170]: info: Bluetooth name changed to Volumio Jan 26 22:57:21 volumio volumio[1170]: info: MPD Permissions set Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:21 volumio systemd[1]: systemd-timedated.service: Succeeded. Jan 26 22:57:21 volumio volumio[1170]: info: Starting Shairport Sync Jan 26 22:57:21 volumio systemd[1]: Started Volumio Qobuz Connect Service. Jan 26 22:57:21 volumio sudo[1581]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:21 volumio sudo[1594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 26 22:57:21 volumio volumio[1170]: info: MRS: Found cast device: SHIELD-Android-TV-6342eac47aaaecaa412ced02b70b9d3c Jan 26 22:57:21 volumio volumio[1170]: info: Adding audio output: Jan 26 22:57:21 volumio sudo[1594]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:21 volumio volumio[1170]: info: MRS: Found cast device: SHIELD-Android-TV-6342eac47aaaecaa412ced02b70b9d3c Jan 26 22:57:21 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 26 22:57:21 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 26 22:57:21 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 26 22:57:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 26 22:57:21 volumio sudo[1594]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:21 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:21 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:21 volumio volumio[1170]: info: Shairport-Sync Started Jan 26 22:57:21 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:21 volumio volumio[1170]: info: Executing endpoint qc_getconfig Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 26 22:57:21 volumio qobuz-connect[1593]: 20260126 22:57:21.238 [1593.1593] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 26 22:57:21 volumio volumio[1170]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 26 22:57:21 volumio volumio[1170]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:21 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:21 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:21 volumio volumio[1170]: info: Successfully Added MyVolumio device Jan 26 22:57:21 volumio volumio[1170]: info: Successfully Updated MyVolumio device Jan 26 22:57:21 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:21 volumio qobuz-connect[1593]: 20260126 22:57:21.336 [1593.1593] INFO VolumeManager: [0x5119f8]: Setting new playback volume: 75 Jan 26 22:57:21 volumio qobuz-connect[1593]: 20260126 22:57:21.336 [1593.1593] INFO VolumeManager: [0x5119f8]: Setting new mute state: 0 Jan 26 22:57:21 volumio qobuz-connect[1593]: 20260126 22:57:21.336 [1593.1593] INFO QobuzConnect: [0x5123c8]: Client initialized! Jan 26 22:57:21 volumio qobuz-connect[1593]: 20260126 22:57:21.336 [1593.1593] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Jan 26 22:57:21 volumio qobuz-connect[1593]: 20260126 22:57:21.344 [1593.1593] INFO LocalConfigManager: [0x5112d8]: Starting Local Configuration server Jan 26 22:57:21 volumio qobuz-connect[1593]: 20260126 22:57:21.344 [1593.1593] INFO SampleApp: Starting Local configuration server Jan 26 22:57:21 volumio qobuz-connect[1593]: 20260126 22:57:21.344 [1593.1593] INFO SampleApp: Connected to UNIX socket client 0x506f60 Jan 26 22:57:21 volumio qobuz-connect[1593]: 20260126 22:57:21.388 [1593.1593] INFO SampleApp: Playback volume changed: 75 Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:21 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:21 volumio volumio[1170]: info: Updating MyVolumio device info Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:21 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:21 volumio mpd[1582]: Jan 26 22:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 22:57:21 volumio systemd[1]: Started Music Player Daemon. Jan 26 22:57:21 volumio sudo[1554]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:21 volumio volumio[1170]: error: updateQueue error: null Jan 26 22:57:21 volumio volumio[1170]: info: Successfully Updated MyVolumio device Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:22 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:22 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:22 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:22 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:22 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:22 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:22 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:23 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:23 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:23 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:23 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:23 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:23 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 34 Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:23 volumio sudo[1624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jan 26 22:57:23 volumio sudo[1624]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:23 volumio systemd[1]: Started MyVolumio SSH Tunnel. Jan 26 22:57:23 volumio sudo[1624]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:23 volumio volumio[1170]: info: Remote SSH Started Jan 26 22:57:23 volumio autossh[1627]: port set to 0, monitoring disabled Jan 26 22:57:23 volumio autossh[1627]: starting ssh (count 1) Jan 26 22:57:23 volumio autossh[1627]: ssh child pid is 1630 Jan 26 22:57:23 volumio volumio[1170]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 34 Jan 26 22:57:23 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:23 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:23 volumio volumiossh-tunnel[1626]: Warning: Permanently added '[eu8.myvolumio.org]:2222,[178.62.246.67]:2222' (RSA) to the list of known hosts. Jan 26 22:57:23 volumio sudo[1632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jan 26 22:57:23 volumio sudo[1632]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:23 volumio systemd[1]: Started Volumio Bluetooth Module. Jan 26 22:57:23 volumio sudo[1632]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:23 volumio volumio[1170]: info: Volumio BT Module successfully started Jan 26 22:57:23 volumio sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Jan 26 22:57:23 volumio sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:23 volumio volumiobt[1634]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Jan 26 22:57:23 volumio sudo[1635]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:23 volumio volumio[1170]: info: TidalConnect service stoped! Jan 26 22:57:23 volumio volumio[1170]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 26 22:57:23 volumio volumio[1170]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 26 22:57:24 volumio sudo[1647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 26 22:57:24 volumio sudo[1647]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:24 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 26 22:57:24 volumio sudo[1647]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:24 volumio volumio[1170]: info: Executing endpoint tc_getconfig Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 26 22:57:24 volumio vtcs[1649]: STARTING TidalConnect services, version: 1.5.2.56 Jan 26 22:57:24 volumio vtcs[1649]: STARTED TidalConnect services. Jan 26 22:57:24 volumio volumio[1170]: info: Executing endpoint tc_connect Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 26 22:57:24 volumio volumio[1170]: info: Connecting to TidalConnect Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::servicePushState Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output update for this device Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 26 22:57:24 volumio volumio[1170]: verbose: CURRENT POSITION 0 Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::syncState stateService stop Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::syncState currentStatus stop Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output update for this device Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: No code Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output update for this device Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::servicePushState Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output update for this device Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 26 22:57:24 volumio volumio[1170]: verbose: CURRENT POSITION 0 Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::syncState stateService stop Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::syncState currentStatus stop Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output update for this device Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: No code Jan 26 22:57:24 volumio volumio[1170]: info: CoreStateMachine::pushState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output update for this device Jan 26 22:57:24 volumio volumio[1170]: info: MRS: Pushing multiroomSync output Jan 26 22:57:24 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:24 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:24 volumio sudo[1669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 26 22:57:24 volumio sudo[1669]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:24 volumio systemd[1]: Stopping MPD Monitor Service... Jan 26 22:57:24 volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Jan 26 22:57:24 volumio systemd[1]: mpd_monitor.service: Succeeded. Jan 26 22:57:24 volumio systemd[1]: Stopped MPD Monitor Service. Jan 26 22:57:24 volumio volumio[1170]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 22:57:24 volumio volumio[1170]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 26 22:57:24 volumio systemd[1]: Started MPD Monitor Service. Jan 26 22:57:24 volumio sudo[1669]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:24 volumio mpd_monitor.sh[1671]: MPD Monitor Service: Starting MPD Monitor Service Jan 26 22:57:24 volumio volumio[1170]: info: Successfully started MPD Monitor Jan 26 22:57:24 volumio sudo[1673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Jan 26 22:57:24 volumio sudo[1673]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:57:24 volumio volumiobt[1634]: pulseaudio: no process found Jan 26 22:57:24 volumio sudo[1673]: pam_unix(sudo:session): session closed for user root Jan 26 22:57:24 volumio dbus-daemon[753]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.24' (uid=1000 pid=1679 comm="/usr/bin/pulseaudio --high-priority=true ") Jan 26 22:57:25 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jan 26 22:57:25 volumio volumio[1170]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 22:57:25 volumio dbus-daemon[753]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jan 26 22:57:25 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Jan 26 22:57:25 volumio rtkit-daemon[1680]: Successfully called chroot. Jan 26 22:57:25 volumio rtkit-daemon[1680]: Successfully dropped privileges. Jan 26 22:57:25 volumio rtkit-daemon[1680]: Successfully limited resources. Jan 26 22:57:25 volumio rtkit-daemon[1680]: Running. Jan 26 22:57:25 volumio rtkit-daemon[1680]: Canary thread running. Jan 26 22:57:25 volumio rtkit-daemon[1680]: Watchdog thread running. Jan 26 22:57:25 volumio dbus-daemon[753]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.25' (uid=0 pid=1680 comm="/usr/lib/rtkit/rtkit-daemon ") Jan 26 22:57:25 volumio systemd[1]: Starting Authorization Manager... Jan 26 22:57:25 volumio volumio[1170]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 22:57:25 volumio polkitd[1684]: started daemon version 0.105 using authority implementation `local' version `0.105' Jan 26 22:57:25 volumio dbus-daemon[753]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jan 26 22:57:25 volumio systemd[1]: Started Authorization Manager. Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:25 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:25 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:25 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 35 Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:25 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:25 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:25 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 35 Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:25 volumio pulseaudio[1679]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 26 22:57:25 volumio pulseaudio[1679]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 26 22:57:25 volumio bluetoothd[872]: Endpoint registered: sender=:1.45 path=/MediaEndpoint/A2DPSource Jan 26 22:57:25 volumio bluetoothd[872]: Endpoint registered: sender=:1.45 path=/MediaEndpoint/A2DPSink Jan 26 22:57:25 volumio volumiobt[1634]: Applying permissions Jan 26 22:57:25 volumio volumiobt[1634]: Setting BT discoverable and pairable Jan 26 22:57:25 volumio pulseaudio[1679]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Jan 26 22:57:25 volumio kernel: Bluetooth: RFCOMM TTY layer initialized Jan 26 22:57:25 volumio kernel: Bluetooth: RFCOMM socket layer initialized Jan 26 22:57:25 volumio kernel: Bluetooth: RFCOMM ver 1.11 Jan 26 22:57:25 volumio volumiobt[1634]: [96B blob data] Jan 26 22:57:25 volumio volumiobt[1634]: [77B blob data] Jan 26 22:57:25 volumio volumiobt[1634]: [77B blob data] Jan 26 22:57:25 volumio volumiobt[1634]: [33B blob data] Jan 26 22:57:25 volumio volumiobt[1634]: [65B blob data] Jan 26 22:57:25 volumio volumiobt[1634]: [78B blob data] Jan 26 22:57:25 volumio volumiobt[1634]: [bluetoothctl]> -e power on Jan 26 22:57:25 volumio volumiobt[1634]: Invalid command in menu main: -e Jan 26 22:57:25 volumio volumiobt[1634]: Jan 26 22:57:25 volumio volumiobt[1634]: Use "help" for a list of available commands in a menu. Jan 26 22:57:25 volumio volumiobt[1634]: Use "menu " if you want to enter any submenu. Jan 26 22:57:25 volumio volumiobt[1634]: Use "back" if you want to return to menu main. Jan 26 22:57:25 volumio volumiobt[1634]: [bluetoothctl]> agent on Jan 26 22:57:25 volumio volumiobt[1634]: Agent is already registered Jan 26 22:57:25 volumio volumiobt[1634]: [bluetoothctl]> discoverable on Jan 26 22:57:25 volumio volumiobt[1634]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Jan 26 22:57:25 volumio volumiobt[1634]: [bluetoothctl]> pairable on Jan 26 22:57:25 volumio volumiobt[1634]: [bluetoothctl]> agent NoInputNoOutput Jan 26 22:57:25 volumio volumiobt[1634]: Agent is already registered Jan 26 22:57:25 volumio volumiobt[1634]: [bluetoothctl]> default-agent Jan 26 22:57:25 volumio volumiobt[1634]: [90B blob data] Jan 26 22:57:25 volumio volumiobt[1634]: [bluetoothctl]> quit Jan 26 22:57:25 volumio bluetoothd[872]: src/adapter.c:store_adapter_info() Unable set contents for /usr/var/lib/bluetooth/E4:5F:01:0F:19:25/settings: (Failed to create file “/usr/var/lib/bluetooth/E4:5F:01:0F:19:25/settings.9CPJJ3”: No such file or directory) Jan 26 22:57:25 volumio volumiobt[1634]: [65B blob data] Jan 26 22:57:25 volumio volumio[1170]: info: MRS: Getting audio outputs on start Jan 26 22:57:25 volumio volumio[1170]: info: MRS: Requesting all other devices output Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:26 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:26 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:26 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 35 Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:26 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:26 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:26 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 35 Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:27 volumio volumio[1170]: info: TidalConnect service started! Jan 26 22:57:27 volumio volumio[1170]: [Metrics] CommandRouter: 27s 326.47ms Jan 26 22:57:27 volumio volumio[1170]: info: CoreCommandRouter::volumiosetStartupVolume Jan 26 22:57:27 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:27 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:27 volumio volumio[1170]: info: CoreCommandRouter::Close All Modals sent Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:28 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:28 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:28 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.68:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 35 Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:57:28 volumio volumio[1170]: info: Discovery: Getting this device information Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:28 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:57:28 volumio volumio[1170]: verbose: New Socket.io Connection to 192.168.0.70:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 35 Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:57:28 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:57:30 volumio volumio[1446]: .......................................................................................................................................................................................................++++ Jan 26 22:57:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 26 22:57:31 volumio volumio[1170]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 35 Jan 26 22:57:31 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Jan 26 22:57:31 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Jan 26 22:57:31 volumio volumio[1446]: .................++++ Jan 26 22:57:31 volumio volumio[1446]: e is 65537 (0x010001) Jan 26 22:57:31 volumio volumio[1446]: writing RSA key Jan 26 22:57:34 volumio volumio[1170]: info: BOOT COMPLETED Jan 26 22:57:34 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 26 22:57:34 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 22:57:34 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 26 22:57:35 volumio volumio-remote-updater[745]: Test mode enabled Jan 26 22:57:35 volumio volumio-remote-updater[745]: No alpha test mode Jan 26 22:57:35 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jan 26 22:57:35 volumio volumio[1170]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n
    \n
  • Fix for Streaming Services playback in case of network interruptions
  • \n
\n

NEW ADDITIONS

\n
    \n
  • BLE-based onboarding setup
  • \n
\n","title":"Update v3.902","updateavailable":true} Jan 26 22:57:35 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 26 22:57:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 22:57:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 26 22:57:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 26 22:57:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 26 22:57:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 26 22:57:36 volumio volumio[1170]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 22:57:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 26 22:57:47 volumio ntpd[887]: Soliciting pool server 194.146.251.101 Jan 26 22:57:48 volumio ntpd[887]: Soliciting pool server 162.159.200.1 Jan 26 22:57:48 volumio ntpd[887]: Soliciting pool server 193.70.94.182 Jan 26 22:57:49 volumio ntpd[887]: Soliciting pool server 89.161.47.136 Jan 26 22:57:49 volumio ntpd[887]: Soliciting pool server 162.159.200.123 Jan 26 22:57:49 volumio ntpd[887]: Soliciting pool server 194.146.251.114 Jan 26 22:57:50 volumio ntpd[887]: Soliciting pool server 194.146.251.102 Jan 26 22:57:50 volumio ntpd[887]: Soliciting pool server 89.161.47.132 Jan 26 22:57:50 volumio ntpd[887]: Soliciting pool server 51.68.141.5 Jan 26 22:57:50 volumio ntpd[887]: Soliciting pool server 194.146.251.100 Jan 26 22:57:51 volumio ntpd[887]: Soliciting pool server 213.222.217.10 Jan 26 22:57:51 volumio ntpd[887]: Soliciting pool server 178.215.228.24 Jan 26 22:57:51 volumio ntpd[887]: Soliciting pool server 91.212.242.20 Jan 26 22:57:52 volumio ntpd[887]: Soliciting pool server 156.17.245.123 Jan 26 22:57:52 volumio ntpd[887]: Soliciting pool server 79.190.98.149 Jan 26 22:57:53 volumio ntpd[887]: Soliciting pool server 94.240.10.55 Jan 26 22:57:53 volumio ntpd[887]: Soliciting pool server 2a05:9404::15e Jan 26 22:57:55 volumio ntpd[887]: receive: Unexpected origin timestamp 0xed2261e2.f107b74b does not match aorg 0000000000.00000000 from server@94.240.10.55 xmt 0xed2261e3.5b330556 Jan 26 22:57:55 volumio ntpd[887]: receive: Unexpected origin timestamp 0xed2261e2.f10cf954 does not match aorg 0000000000.00000000 from server@91.212.242.20 xmt 0xed2261e3.5b514e16 Jan 26 22:57:55 volumio ntpd[887]: receive: Unexpected origin timestamp 0xed2261e2.f10bc9ed does not match aorg 0000000000.00000000 from server@213.222.217.10 xmt 0xed2261e3.5bbff4b8 Jan 26 22:57:55 volumio ntpd[887]: receive: Unexpected origin timestamp 0xed2261e2.f10ac006 does not match aorg 0000000000.00000000 from server@178.215.228.24 xmt 0xed2261e3.5db16e7c Jan 26 22:57:55 volumio ntpd[887]: receive: Unexpected origin timestamp 0xed2261e2.f110f82e does not match aorg 0000000000.00000000 from server@89.161.47.136 xmt 0xed2261e3.5cb77da4 Jan 26 22:58:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 22:58:04 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 26 22:58:10 volumio volumio[1170]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 22:58:13 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 22:58:13 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 26 22:58:30 volumio volumio[1170]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/touch_display/volumio/buster/armhf Jan 26 22:58:32 volumio volumio[1170]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/touch_display/volumio/buster/armhf Jan 26 22:58:32 volumio sudo[1864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jan 26 22:58:32 volumio sudo[1864]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:58:32 volumio sudo[1864]: pam_unix(sudo:session): session closed for user root Jan 26 22:58:32 volumio sudo[1867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Jan 26 22:58:32 volumio sudo[1867]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:58:32 volumio sudo[1870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Jan 26 22:58:32 volumio sudo[1870]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:58:32 volumio volumio[1170]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jan 26 22:58:32 volumio volumio[1170]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 22:58:32 volumio sudo[1872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Jan 26 22:58:32 volumio systemd[1]: Created slice system-getty.slice. Jan 26 22:58:32 volumio sudo[1872]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 22:58:32 volumio volumio[1170]: TypeError: Cannot read property 'split' of undefined Jan 26 22:58:32 volumio volumio[1170]: at /data/plugins/user_interface/touch_display/index.js:1258:37 Jan 26 22:58:32 volumio volumio[1170]: at ChildProcess.exithandler (child_process.js:299:7) Jan 26 22:58:32 volumio volumio[1170]: at ChildProcess.emit (events.js:315:20) Jan 26 22:58:32 volumio volumio[1170]: at maybeClose (internal/child_process.js:1048:16) Jan 26 22:58:32 volumio volumio[1170]: at Socket. (internal/child_process.js:439:11) Jan 26 22:58:32 volumio volumio[1170]: at Socket.emit (events.js:315:20) Jan 26 22:58:32 volumio volumio[1170]: at Pipe. (net.js:673:12) Jan 26 22:58:32 volumio volumio[1170]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 22:58:32 volumio systemd[1]: Started Getty on tty1. Jan 26 22:58:32 volumio sudo[1867]: pam_unix(sudo:session): session closed for user root Jan 26 22:58:32 volumio sudo[1872]: pam_unix(sudo:session): session closed for user root Jan 26 22:58:32 volumio systemd[1]: Reloading. Jan 26 22:58:32 volumio 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. Jan 26 22:58:32 volumio sudo[1898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-26 22:57 Jan 26 22:58:32 volumio sudo[1898]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"