-- Logs begin at Thu 2025-12-11 03:23:52 CET, end at Tue 2025-12-16 23:38:57 CET. --
Dec 16 23:37:12 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 23:37:12 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 23:37:12 volumio sudo[9073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 16 23:37:12 volumio sudo[9073]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:12 volumio sudo[9073]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:12 volumio sudo[9077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 16 23:37:13 volumio sudo[9077]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:13 volumio sudo[9077]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:13 volumio volumio[792]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 16 23:37:13 volumio volumio[792]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 16 23:37:13 volumio sudo[9094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 16 23:37:13 volumio sudo[9094]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:13 volumio sudo[9094]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:13 volumio sudo[9098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 16 23:37:13 volumio sudo[9098]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:13 volumio sudo[9098]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:13 volumio volumio[792]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 16 23:37:13 volumio volumio[792]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Dec 16 23:37:13 volumio volumio[792]: info: Listing playlists
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 23:37:13 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 16 23:37:14 volumio volumio[792]: info: CoreCommandRouter::volumioGetQueue
Dec 16 23:37:14 volumio volumio[792]: info: CoreStateMachine::getQueue
Dec 16 23:37:14 volumio volumio[792]: info: CorePlayQueue::getQueue
Dec 16 23:37:17 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 16 23:37:17 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 16 23:37:17 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 16 23:37:17 volumio volumio[792]: info: Received Get System Info
Dec 16 23:37:17 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 16 23:37:17 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 16 23:37:17 volumio volumio[792]: info: Discovery: Getting this device information
Dec 16 23:37:17 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:37:17 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 16 23:37:19 volumio volumio[792]: info: FusionDsp - Stopping FusionDsp service
Dec 16 23:37:19 volumio volumio[792]: info: camilladsp stopping service pid 6934...
Dec 16 23:37:19 volumio volumio[792]: info: camilladsp service terminated, instance 1
Dec 16 23:37:19 volumio volumio[792]: info: Disabling plugin fusiondsp
Dec 16 23:37:19 volumio volumio[792]: info: Preparing to generate the ALSA configuration file
Dec 16 23:37:19 volumio sudo[9131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service
Dec 16 23:37:19 volumio sudo[9131]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:20 volumio systemd[1]: Stopping FusionDsp Daemon...
Dec 16 23:37:20 volumio volumio[6805]: Backend configuration:
Dec 16 23:37:20 volumio volumio[6805]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
Dec 16 23:37:20 volumio volumio[6805]: active_config_txt: null
Dec 16 23:37:20 volumio volumio[6805]: camilla_host: 127.0.0.1
Dec 16 23:37:20 volumio volumio[6805]: camilla_port: 9876
Dec 16 23:37:20 volumio volumio[6805]: coeff_dir: /data/INTERNAL/FusionDsp/filters
Dec 16 23:37:20 volumio volumio[6805]: config_dir: /data/configuration/audio_interface/fusiondsp
Dec 16 23:37:20 volumio volumio[6805]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
Dec 16 23:37:20 volumio volumio[6805]: log_file: /tmp/camilladsp.log
Dec 16 23:37:20 volumio volumio[6805]: on_get_active_config: null
Dec 16 23:37:20 volumio volumio[6805]: on_set_active_config: null
Dec 16 23:37:20 volumio volumio[6805]: port: 5011
Dec 16 23:37:20 volumio volumio[6805]: supported_capture_types: null
Dec 16 23:37:20 volumio volumio[6805]: supported_playback_types: null
Dec 16 23:37:20 volumio volumio[6805]: update_config_symlink: false
Dec 16 23:37:20 volumio volumio[6805]: update_config_txt: false
Dec 16 23:37:20 volumio volumio[6805]: ======== Running on http://0.0.0.0:5011 ========
Dec 16 23:37:20 volumio volumio[6805]: (Press CTRL+C to quit)
Dec 16 23:37:20 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:20 volumio volumio[792]: info: Asound.conf file written
Dec 16 23:37:20 volumio sudo[9138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Dec 16 23:37:20 volumio sudo[9138]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:20 volumio sudo[9138]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:20 volumio volumio[792]: xcb_connection_has_error() returned true
Dec 16 23:37:20 volumio volumio[792]: info: Output device has changed, restarting MPD
Dec 16 23:37:20 volumio systemd[1]: fusiondsp.service: Succeeded.
Dec 16 23:37:20 volumio sudo[9131]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:20 volumio systemd[1]: Stopped FusionDsp Daemon.
Dec 16 23:37:20 volumio volumio[792]: info: Output device has changed, restarting Shairport Sync
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:37:20 volumio sudo[9150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 16 23:37:20 volumio sudo[9150]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:20 volumio sudo[9154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 16 23:37:20 volumio sudo[9150]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:20 volumio sudo[9154]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:20 volumio systemd[1]: Stopping Music Player Daemon...
Dec 16 23:37:20 volumio volumio[792]: xcb_connection_has_error() returned true
Dec 16 23:37:20 volumio volumio[792]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: Relinquishing Volumio State
Dec 16 23:37:20 volumio volumio[792]: verbose: UNSET VOLATILE: Service: tidalconnect
Dec 16 23:37:20 volumio volumio[792]: info: unSetVolatile called
Dec 16 23:37:20 volumio volumio[792]: info: Relinquishing Volumio State to another service
Dec 16 23:37:20 volumio vtcs[6825]: [close:85] Entering
Dec 16 23:37:20 volumio vtcs[6825]: [2025-12-16 23:37:20.277] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer
Dec 16 23:37:20 volumio vtcs[6825]: [2025-12-16 23:37:20.277] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected
Dec 16 23:37:20 volumio vtcs[6825]: [2025-12-16 23:37:20.277] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE
Dec 16 23:37:20 volumio systemd[1]: mpd.service: Succeeded.
Dec 16 23:37:20 volumio systemd[1]: Stopped Music Player Daemon.
Dec 16 23:37:20 volumio systemd[1]: Starting Music Player Daemon...
Dec 16 23:37:20 volumio volumio[792]: info: Done.
Dec 16 23:37:20 volumio sudo[9180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 16 23:37:20 volumio sudo[9180]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:20 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:20 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Dec 16 23:37:20 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:20 volumio sudo[9177]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 16 23:37:20 volumio volumio[792]: info: MPD Permissions set
Dec 16 23:37:20 volumio systemd[1]: Stopping Volumio Tidal Connect Service...
Dec 16 23:37:20 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:37:20 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:20 volumio sudo[9187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 16 23:37:20 volumio volumio[792]: info: FusionDsp - Reporting Fusion DSP Disabled
Dec 16 23:37:20 volumio volumio[792]: info: Removing fusiondspeq DSP Signal Path Element
Dec 16 23:37:20 volumio systemd[1]: vtcs.service: Succeeded.
Dec 16 23:37:20 volumio systemd[1]: Stopped Volumio Tidal Connect Service.
Dec 16 23:37:20 volumio sudo[9187]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:20 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:20 volumio sudo[9180]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio sudo[9177]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:20 volumio sudo[9187]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:20 volumio sudo[9177]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 16 23:37:20 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:20 volumio volumio[792]: info: Starting Shairport Sync
Dec 16 23:37:20 volumio sudo[9220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 16 23:37:20 volumio sudo[9220]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Dec 16 23:37:20 volumio systemd[1]: shairport-sync.service: Succeeded.
Dec 16 23:37:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Dec 16 23:37:20 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:20 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Dec 16 23:37:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Dec 16 23:37:20 volumio sudo[9220]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:20 volumio volumio[792]: info: Shairport-Sync Started
Dec 16 23:37:21 volumio mpd[9219]: Dec 16 23:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 16 23:37:21 volumio systemd[1]: Started Music Player Daemon.
Dec 16 23:37:21 volumio sudo[9154]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:21 volumio volumio[792]: error: updateQueue error: null
Dec 16 23:37:23 volumio volumio[792]: info: TidalConnect service stoped!
Dec 16 23:37:23 volumio volumio[792]: info: TidalConnect service stoped!
Dec 16 23:37:23 volumio volumio[792]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Dec 16 23:37:23 volumio volumio[792]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Dec 16 23:37:23 volumio sudo[9247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Dec 16 23:37:23 volumio sudo[9247]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:23 volumio systemd[1]: Started Volumio Tidal Connect Service.
Dec 16 23:37:23 volumio sudo[9247]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:23 volumio volumio[792]: info: Executing endpoint tc_getconfig
Dec 16 23:37:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Dec 16 23:37:23 volumio vtcs[9253]: STARTING TidalConnect services, version: 1.5.1-beta1
Dec 16 23:37:23 volumio vtcs[9253]: STARTED TidalConnect services.
Dec 16 23:37:23 volumio volumio[792]: info: Executing endpoint tc_connect
Dec 16 23:37:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Dec 16 23:37:23 volumio volumio[792]: info: Connecting to TidalConnect
Dec 16 23:37:23 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:23 volumio volumio[792]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect
Dec 16 23:37:23 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:23 volumio volumio[792]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect
Dec 16 23:37:24 volumio sudo[9276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Dec 16 23:37:24 volumio sudo[9276]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:24 volumio systemd[1]: Stopping MPD Monitor Service...
Dec 16 23:37:24 volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM
Dec 16 23:37:24 volumio systemd[1]: mpd_monitor.service: Succeeded.
Dec 16 23:37:24 volumio systemd[1]: Stopped MPD Monitor Service.
Dec 16 23:37:24 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:24 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Dec 16 23:37:24 volumio systemd[1]: Started MPD Monitor Service.
Dec 16 23:37:24 volumio sudo[9276]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:24 volumio mpd_monitor.sh[9282]: MPD Monitor Service: Starting MPD Monitor Service
Dec 16 23:37:24 volumio volumio[792]: info: Successfully started MPD Monitor
Dec 16 23:37:26 volumio volumio[792]: info: TidalConnect service started!
Dec 16 23:37:31 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 16 23:37:31 volumio volumio[792]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Dec 16 23:37:31 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Dec 16 23:37:31 volumio volumio[792]: info: Received Get System Version
Dec 16 23:37:31 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 16 23:37:31 volumio volumio[792]: info: Received Get System Info
Dec 16 23:37:31 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 16 23:37:31 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 16 23:37:31 volumio volumio[792]: info: Discovery: Getting this device information
Dec 16 23:37:31 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:37:31 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:31 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 16 23:37:34 volumio volumio[792]: info: Starting Uninstall of plugin audio_interface - fusiondsp
Dec 16 23:37:34 volumio volumio[792]: info: Uninstalling plugin fusiondsp
Dec 16 23:37:34 volumio volumio[792]: info: Disabling plugin fusiondsp
Dec 16 23:37:34 volumio volumio[792]: info: Preparing to generate the ALSA configuration file
Dec 16 23:37:34 volumio volumio[792]: info: Asound.conf file unchanged, so no further update is needed
Dec 16 23:37:34 volumio volumio[792]: info: Output device has changed, restarting MPD
Dec 16 23:37:34 volumio sudo[9306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 16 23:37:34 volumio volumio[792]: info: Output device has changed, restarting Shairport Sync
Dec 16 23:37:34 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:34 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:37:34 volumio sudo[9306]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:34 volumio sudo[9310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 16 23:37:34 volumio sudo[9306]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:34 volumio sudo[9310]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:34 volumio volumio[792]: xcb_connection_has_error() returned true
Dec 16 23:37:34 volumio volumio[792]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 16 23:37:34 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:34 volumio systemd[1]: Stopping Music Player Daemon...
Dec 16 23:37:34 volumio volumio[792]: info: Relinquishing Volumio State
Dec 16 23:37:34 volumio vtcs[9253]: [2025-12-16 23:37:34.933] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE
Dec 16 23:37:34 volumio vtcs[9253]: [2025-12-16 23:37:34.933] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected
Dec 16 23:37:34 volumio volumio[792]: info: Checking if uninstall.sh is present
Dec 16 23:37:34 volumio sudo[9328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 16 23:37:34 volumio volumio[792]: info: Executing uninstall.sh
Dec 16 23:37:34 volumio systemd[1]: mpd.service: Succeeded.
Dec 16 23:37:34 volumio systemd[1]: Stopped Music Player Daemon.
Dec 16 23:37:34 volumio systemd[1]: Starting Music Player Daemon...
Dec 16 23:37:34 volumio sudo[9328]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:35 volumio sudo[9333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 16 23:37:35 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:35 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Dec 16 23:37:35 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:35 volumio systemd[1]: Stopping Volumio Tidal Connect Service...
Dec 16 23:37:35 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Dec 16 23:37:35 volumio systemd[1]: vtcs.service: Succeeded.
Dec 16 23:37:35 volumio systemd[1]: Stopped Volumio Tidal Connect Service.
Dec 16 23:37:35 volumio volumio[792]: info: MPD Permissions set
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:37:35 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:35 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:35 volumio sudo[9333]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:35 volumio sudo[9328]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 16 23:37:35 volumio sudo[9333]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:35 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:37:35 volumio sudo[9334]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 16 23:37:35 volumio volumio[792]: info: Starting Shairport Sync
Dec 16 23:37:35 volumio sudo[9340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh
Dec 16 23:37:35 volumio sudo[9334]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:35 volumio sudo[9340]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:35 volumio sudo[9334]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:35 volumio sudo[9371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 16 23:37:35 volumio sudo[9371]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:35 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Dec 16 23:37:35 volumio sudo[9384]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /lib/systemd/system/fusiondsp.service
Dec 16 23:37:35 volumio systemd[1]: shairport-sync.service: Succeeded.
Dec 16 23:37:35 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Dec 16 23:37:35 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:35 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Dec 16 23:37:35 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Dec 16 23:37:35 volumio sudo[9371]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:35 volumio sudo[9384]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:35 volumio sudo[9384]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:35 volumio volumio[792]: info: Shairport-Sync Started
Dec 16 23:37:35 volumio sudo[9399]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Dec 16 23:37:35 volumio sudo[9399]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:35 volumio systemd[1]: Reloading.
Dec 16 23:37:35 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.
Dec 16 23:37:35 volumio systemd[1]: serial-getty@ttyS3.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Dec 16 23:37:35 volumio sudo[9399]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:35 volumio sudo[9340]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:35 volumio volumio[792]: info: Uninstall script completed
Dec 16 23:37:35 volumio volumio[792]: info: Removing plugin fusiondsp from configuration
Dec 16 23:37:35 volumio volumio[792]: info: Successfully removed fusiondsp configuration files
Dec 16 23:37:35 volumio volumio[792]: info: Plugin folders cleanup
Dec 16 23:37:35 volumio volumio[792]: info: Scanning into folder /volumio/app/plugins/
Dec 16 23:37:35 volumio volumio[792]: info: Scanning category audio_interface
Dec 16 23:37:35 volumio volumio[792]: info: Scanning category miscellanea
Dec 16 23:37:35 volumio volumio[792]: info: Scanning category music_service
Dec 16 23:37:35 volumio volumio[792]: info: Scanning category plugins.json
Dec 16 23:37:35 volumio volumio[792]: info: Scanning category system_controller
Dec 16 23:37:35 volumio volumio[792]: info: Scanning category user_interface
Dec 16 23:37:35 volumio volumio[792]: info: Scanning into folder /data/plugins/
Dec 16 23:37:35 volumio volumio[792]: info: Scanning category audio_interface
Dec 16 23:37:35 volumio volumio[792]: info: Cleaning folder for fusiondsp
Dec 16 23:37:36 volumio volumio[792]: info: Scanning category music_service
Dec 16 23:37:36 volumio volumio[792]: info: Scanning category system_controller
Dec 16 23:37:36 volumio volumio[792]: info: Scanning category user_interface
Dec 16 23:37:36 volumio volumio[792]: info: Plugin folders cleanup completed
Dec 16 23:37:36 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 16 23:37:36 volumio volumio[792]: info: [{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Music Your Brand","name":"myb","category":"music_service","version":"1.0.3","icon":"fa-solid fa-music","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.2.0","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.3.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Peppy-spectrum","name":"peppyspectrum","category":"user_interface","version":"0.0.35","icon":"fa-bar-chart","isManuallyInstalled":false,"enabled":false,"active":false}]
Dec 16 23:37:36 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 16 23:37:36 volumio mpd[9387]: Dec 16 23:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 16 23:37:36 volumio systemd[1]: Started Music Player Daemon.
Dec 16 23:37:36 volumio sudo[9310]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:36 volumio volumio[792]: error: updateQueue error: null
Dec 16 23:37:38 volumio volumio[792]: info: TidalConnect service stoped!
Dec 16 23:37:38 volumio volumio[792]: info: TidalConnect service stoped!
Dec 16 23:37:38 volumio volumio[792]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Dec 16 23:37:38 volumio volumio[792]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Dec 16 23:37:38 volumio sudo[9457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Dec 16 23:37:38 volumio sudo[9457]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:38 volumio systemd[1]: Started Volumio Tidal Connect Service.
Dec 16 23:37:38 volumio sudo[9457]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:38 volumio volumio[792]: info: Executing endpoint tc_getconfig
Dec 16 23:37:38 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Dec 16 23:37:38 volumio vtcs[9463]: STARTING TidalConnect services, version: 1.5.1-beta1
Dec 16 23:37:38 volumio vtcs[9463]: STARTED TidalConnect services.
Dec 16 23:37:38 volumio volumio[792]: info: Executing endpoint tc_connect
Dec 16 23:37:38 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Dec 16 23:37:38 volumio volumio[792]: info: Connecting to TidalConnect
Dec 16 23:37:38 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:38 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:38 volumio volumio[792]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect
Dec 16 23:37:38 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:38 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:38 volumio volumio[792]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect
Dec 16 23:37:39 volumio sudo[9486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Dec 16 23:37:39 volumio sudo[9486]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:39 volumio systemd[1]: Stopping MPD Monitor Service...
Dec 16 23:37:39 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 16 23:37:39 volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM
Dec 16 23:37:39 volumio systemd[1]: mpd_monitor.service: Succeeded.
Dec 16 23:37:39 volumio systemd[1]: Stopped MPD Monitor Service.
Dec 16 23:37:39 volumio volumio[792]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Dec 16 23:37:39 volumio systemd[1]: Started MPD Monitor Service.
Dec 16 23:37:39 volumio mpd_monitor.sh[9492]: MPD Monitor Service: Starting MPD Monitor Service
Dec 16 23:37:39 volumio sudo[9486]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:39 volumio volumio[792]: info: Successfully started MPD Monitor
Dec 16 23:37:41 volumio volumio[792]: info: TidalConnect service started!
Dec 16 23:37:43 volumio volumio[792]: info: Starting Uninstall of plugin music_service - minidlna
Dec 16 23:37:43 volumio volumio[792]: info: Uninstalling plugin minidlna
Dec 16 23:37:43 volumio volumio[792]: info: Disabling plugin minidlna
Dec 16 23:37:43 volumio volumio[792]: info: Checking if uninstall.sh is present
Dec 16 23:37:43 volumio volumio[792]: info: Executing uninstall.sh
Dec 16 23:37:43 volumio sudo[9501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/minidlna/uninstall.sh
Dec 16 23:37:43 volumio sudo[9501]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:37:47 volumio systemd[1]: Reloading.
Dec 16 23:37:47 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.
Dec 16 23:37:47 volumio systemd[1]: Reloading.
Dec 16 23:37:47 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.
Dec 16 23:37:49 volumio systemd[1]: Reloading.
Dec 16 23:37:49 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.
Dec 16 23:37:49 volumio systemd[1]: Reloading.
Dec 16 23:37:50 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.
Dec 16 23:37:50 volumio systemd[1]: Reloading.
Dec 16 23:37:51 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.
Dec 16 23:37:51 volumio systemd[1]: Reloading.
Dec 16 23:37:52 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.
Dec 16 23:37:52 volumio sudo[9501]: pam_unix(sudo:session): session closed for user root
Dec 16 23:37:52 volumio volumio[792]: info: Uninstall script completed
Dec 16 23:37:52 volumio volumio[792]: info: Removing plugin minidlna from configuration
Dec 16 23:37:52 volumio volumio[792]: info: Successfully removed minidlna configuration files
Dec 16 23:37:52 volumio volumio[792]: info: Plugin folders cleanup
Dec 16 23:37:52 volumio volumio[792]: info: Scanning into folder /volumio/app/plugins/
Dec 16 23:37:52 volumio volumio[792]: info: Scanning category audio_interface
Dec 16 23:37:52 volumio volumio[792]: info: Scanning category miscellanea
Dec 16 23:37:52 volumio volumio[792]: info: Scanning category music_service
Dec 16 23:37:52 volumio volumio[792]: info: Scanning category plugins.json
Dec 16 23:37:52 volumio volumio[792]: info: Scanning category system_controller
Dec 16 23:37:52 volumio volumio[792]: info: Scanning category user_interface
Dec 16 23:37:52 volumio volumio[792]: info: Scanning into folder /data/plugins/
Dec 16 23:37:52 volumio volumio[792]: info: Scanning category audio_interface
Dec 16 23:37:52 volumio volumio[792]: info: Scanning category music_service
Dec 16 23:37:52 volumio volumio[792]: info: Cleaning folder for minidlna
Dec 16 23:37:53 volumio volumio[792]: info: Scanning category system_controller
Dec 16 23:37:53 volumio volumio[792]: info: Scanning category user_interface
Dec 16 23:37:53 volumio volumio[792]: info: Plugin folders cleanup completed
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 16 23:37:53 volumio volumio[792]: info: [{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Music Your Brand","name":"myb","category":"music_service","version":"1.0.3","icon":"fa-solid fa-music","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.2.0","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.3.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Peppy-spectrum","name":"peppyspectrum","category":"user_interface","version":"0.0.35","icon":"fa-bar-chart","isManuallyInstalled":false,"enabled":false,"active":false}]
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:37:53 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:37:53 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:53 volumio volumio[792]: info: Currently active: webradio
Dec 16 23:37:53 volumio volumio[792]: info: Stopping currently active service
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioStop
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::stop
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::stPlaybackTimer
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::updateTrackBlock
Dec 16 23:37:53 volumio volumio[792]: info: CorePlayQueue::getTrackBlock
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:53 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::serviceStop
Dec 16 23:37:53 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::serviceStop
Dec 16 23:37:53 volumio volumio[792]: info: [1765924673460] ControllerWebradio::stop
Dec 16 23:37:53 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand stop
Dec 16 23:37:53 volumio volumio[792]: info: sendMpdCommand stop took 18 milliseconds
Dec 16 23:37:53 volumio volumio[792]: info: TidalConnect Active
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:37:53 volumio volumio[792]: info: CorePlayQueue::getTrack 0
Dec 16 23:37:53 volumio volumio[792]: info: Currently active: webradio
Dec 16 23:37:53 volumio volumio[792]: info: Setting Volatile state to tidalconnect
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:53 volumio vtcs[9463]: [2025-12-16 23:37:53.793] [tisoc] [warning] [PlaybackControllerImpl.cpp:520] Illegal state:1
Dec 16 23:37:53 volumio vtcs[9463]: [2025-12-16 23:37:53.794] [tisoc] [warning] [PlaybackControllerImpl.cpp:213] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:53 volumio volumio[792]: info: Pushing metadata
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:37:53 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:54 volumio volumio[792]: info: Pushing metadata
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:54 volumio vtcs[9463]: [close:85] Entering
Dec 16 23:37:54 volumio vtcs[9463]: [close:100] Exiting
Dec 16 23:37:54 volumio vtcs[9463]: [open:50] Opening with sample rate: 44100, type: 0
Dec 16 23:37:54 volumio vtcs[9463]: [start:106] Entering
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:54 volumio vtcs[9463]: [start:113] Reopening PCM device...
Dec 16 23:37:54 volumio vtcs[9463]: [start:115] PCM opened successfully.
Dec 16 23:37:54 volumio vtcs[9463]: [start:120] Exiting
Dec 16 23:37:54 volumio vtcs[9463]: [feedThread:223] Entering
Dec 16 23:37:54 volumio vtcs[9463]: [2025-12-16 23:37:54.484] [tisoc] [warning] [flac_decoder.cpp:302] FLACDecoder::error_callback FLAC__STREAM_DECODER_ERROR_STATUS_LOST_SYNC
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::servicePushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreStateMachine::pushState
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:37:54 volumio volumio[792]: info: CoreCommandRouter::volumioPushState
Dec 16 23:38:11 volumio volumio[792]: info: Enabling plugin myb
Dec 16 23:38:11 volumio volumio[792]: info: Loading plugin "myb"...
Dec 16 23:38:11 volumio volumio[792]: info: PLUGIN START: myb
Dec 16 23:38:11 volumio volumio[792]: info: Done.
Dec 16 23:38:13 volumio volumio[792]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 23:38:23 volumio sudo[9775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 16 23:38:23 volumio sudo[9775]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:23 volumio sudo[9779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 16 23:38:23 volumio sudo[9775]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:23 volumio sudo[9779]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:23 volumio sudo[9779]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:23 volumio volumio[792]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 16 23:38:23 volumio volumio[792]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 23:38:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 16 23:38:23 volumio sudo[9795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 16 23:38:23 volumio sudo[9795]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:23 volumio sudo[9795]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:23 volumio sudo[9799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 16 23:38:23 volumio sudo[9799]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:23 volumio sudo[9799]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:23 volumio volumio[792]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Dec 16 23:38:24 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:24 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 16 23:38:24 volumio volumio[792]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Dec 16 23:38:24 volumio volumio[792]: info: Listing playlists
Dec 16 23:38:24 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 16 23:38:24 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 23:38:24 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 23:38:24 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 16 23:38:25 volumio volumio[792]: info: CoreCommandRouter::volumioGetQueue
Dec 16 23:38:25 volumio volumio[792]: info: CoreStateMachine::getQueue
Dec 16 23:38:25 volumio volumio[792]: info: CorePlayQueue::getQueue
Dec 16 23:38:27 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 16 23:38:27 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 16 23:38:28 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 16 23:38:28 volumio volumio[792]: info: Received Get System Info
Dec 16 23:38:28 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 16 23:38:28 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 16 23:38:28 volumio volumio[792]: info: Discovery: Getting this device information
Dec 16 23:38:28 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:28 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 16 23:38:33 volumio volumio[792]: info: Starting Uninstall of plugin music_service - myb
Dec 16 23:38:33 volumio volumio[792]: info: Uninstalling plugin myb
Dec 16 23:38:33 volumio volumio[792]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMusic Your Brand
Dec 16 23:38:33 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:38:33 volumio volumio[792]: Cannot find translation for source Mixcloud
Dec 16 23:38:33 volumio volumio[792]: Cannot find translation for source SoundCloud
Dec 16 23:38:33 volumio volumio[792]: Cannot find translation for source YouTube Music
Dec 16 23:38:33 volumio volumio[792]: Cannot find translation for source TIDAL
Dec 16 23:38:33 volumio volumio[792]: info: Disabling plugin myb
Dec 16 23:38:33 volumio volumio[792]: info: Checking if uninstall.sh is present
Dec 16 23:38:33 volumio volumio[792]: info: Executing uninstall.sh
Dec 16 23:38:33 volumio sudo[9830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/myb/uninstall.sh
Dec 16 23:38:33 volumio sudo[9830]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:33 volumio sudo[9830]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:33 volumio volumio[792]: info: Uninstall script completed
Dec 16 23:38:33 volumio volumio[792]: info: Removing plugin myb from configuration
Dec 16 23:38:33 volumio volumio[792]: info: Successfully removed myb configuration files
Dec 16 23:38:33 volumio volumio[792]: info: Plugin folders cleanup
Dec 16 23:38:33 volumio volumio[792]: info: Scanning into folder /volumio/app/plugins/
Dec 16 23:38:33 volumio volumio[792]: info: Scanning category audio_interface
Dec 16 23:38:33 volumio volumio[792]: info: Scanning category miscellanea
Dec 16 23:38:33 volumio volumio[792]: info: Scanning category music_service
Dec 16 23:38:33 volumio volumio[792]: info: Scanning category plugins.json
Dec 16 23:38:33 volumio volumio[792]: info: Scanning category system_controller
Dec 16 23:38:33 volumio volumio[792]: info: Scanning category user_interface
Dec 16 23:38:33 volumio volumio[792]: info: Scanning into folder /data/plugins/
Dec 16 23:38:33 volumio volumio[792]: info: Scanning category music_service
Dec 16 23:38:33 volumio volumio[792]: info: Cleaning folder for myb
Dec 16 23:38:33 volumio volumio[792]: info: Scanning category system_controller
Dec 16 23:38:33 volumio volumio[792]: info: Scanning category user_interface
Dec 16 23:38:33 volumio volumio[792]: info: Plugin folders cleanup completed
Dec 16 23:38:33 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 16 23:38:33 volumio volumio[792]: info: [{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.2.0","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.3.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Peppy-spectrum","name":"peppyspectrum","category":"user_interface","version":"0.0.35","icon":"fa-bar-chart","isManuallyInstalled":false,"enabled":false,"active":false}]
Dec 16 23:38:33 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 16 23:38:41 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 16 23:38:41 volumio volumio[792]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Dec 16 23:38:41 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Dec 16 23:38:41 volumio volumio[792]: info: Received Get System Version
Dec 16 23:38:41 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 16 23:38:41 volumio volumio[792]: info: Received Get System Info
Dec 16 23:38:41 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 16 23:38:41 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 16 23:38:41 volumio volumio[792]: info: Discovery: Getting this device information
Dec 16 23:38:41 volumio volumio[792]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:41 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 16 23:38:45 volumio volumio[792]: info: Starting Uninstall of plugin system_controller - ampswitch
Dec 16 23:38:45 volumio volumio[792]: info: Uninstalling plugin ampswitch
Dec 16 23:38:45 volumio volumio[792]: info: [ASDebug] Port: 24
Dec 16 23:38:45 volumio volumio[792]: info: [ASDebug] Inverted: false
Dec 16 23:38:45 volumio volumio[792]: info: [ASDebug] Delay: 720
Dec 16 23:38:45 volumio volumio[792]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 23:38:45 volumio volumio[792]: TypeError: Cannot read property 'unexport' of undefined
Dec 16 23:38:45 volumio volumio[792]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19)
Dec 16 23:38:45 volumio volumio[792]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10)
Dec 16 23:38:45 volumio volumio[792]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Dec 16 23:38:45 volumio volumio[792]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10)
Dec 16 23:38:45 volumio volumio[792]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22)
Dec 16 23:38:45 volumio volumio[792]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1271:45)
Dec 16 23:38:45 volumio volumio[792]: at Socket.emit (events.js:400:28)
Dec 16 23:38:45 volumio volumio[792]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Dec 16 23:38:45 volumio volumio[792]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Dec 16 23:38:45 volumio volumio[792]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 23:38:46 volumio sudo[9871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-16 23:37
Dec 16 23:38:46 volumio sudo[9871]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:46 volumio sudo[9871]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:46 volumio vtcs[9463]: [2025-12-16 23:38:46.386] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer
Dec 16 23:38:46 volumio vtcs[9463]: [2025-12-16 23:38:46.386] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected
Dec 16 23:38:46 volumio volumio-remote-updater[546]: [2025-12-16 23:38:46] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Dec 16 23:38:46 volumio volumio-remote-updater[546]: [2025-12-16 23:38:46] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Dec 16 23:38:46 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Dec 16 23:38:46 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Dec 16 23:38:46 volumio systemd[1]: Started dynamicswap service.
Dec 16 23:38:46 volumio systemd[1]: dynamicswap.service: Succeeded.
Dec 16 23:38:46 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Dec 16 23:38:46 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Dec 16 23:38:46 volumio systemd[1]: Stopped Volumio Backend Module.
Dec 16 23:38:46 volumio systemd[1]: Started Volumio Backend Module.
Dec 16 23:38:46 volumio systemd[1]: Started dynamicswap service.
Dec 16 23:38:46 volumio systemd[1]: dynamicswap.service: Succeeded.
Dec 16 23:38:47 volumio volumio[9905]: info: -------------------------------------------
Dec 16 23:38:47 volumio volumio[9905]: info: ----- Volumio3 ----
Dec 16 23:38:47 volumio volumio[9905]: info: -------------------------------------------
Dec 16 23:38:47 volumio volumio[9905]: info: ----- System startup ----
Dec 16 23:38:47 volumio volumio[9905]: info: -------------------------------------------
Dec 16 23:38:48 volumio volumio[9905]: info: MYVOLUMIO Environment detected
Dec 16 23:38:48 volumio volumio[9905]: info: Plugin folders cleanup
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning into folder /volumio/app/plugins/
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning category audio_interface
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning category miscellanea
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning category music_service
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning category plugins.json
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning category system_controller
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning category user_interface
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning into folder /data/plugins/
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning category music_service
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning category system_controller
Dec 16 23:38:48 volumio volumio[9905]: info: Scanning category user_interface
Dec 16 23:38:48 volumio volumio[9905]: info: Plugin folders cleanup completed
Dec 16 23:38:48 volumio volumio[9905]: info: -------------------------------------------
Dec 16 23:38:48 volumio volumio[9905]: info: ----- Core plugins startup ----
Dec 16 23:38:48 volumio volumio[9905]: info: -------------------------------------------
Dec 16 23:38:48 volumio volumio[9905]: info: Loading plugins from folder /volumio/app/plugins/
Dec 16 23:38:48 volumio volumio[9905]: info: Adding plugin upnp to MyMusic Plugins
Dec 16 23:38:48 volumio volumio[9905]: info: Adding plugin airplay_emulation to MyMusic Plugins
Dec 16 23:38:48 volumio volumio[9905]: info: Adding plugin upnp_browser to MyMusic Plugins
Dec 16 23:38:48 volumio volumio[9905]: info: Loading plugins from folder /data/plugins/
Dec 16 23:38:48 volumio volumio[9905]: info: Loading plugin "system"...
Dec 16 23:38:48 volumio volumio[9905]: info: Loading plugin "ampswitch"...
Dec 16 23:38:48 volumio volumio[9905]: info: Applying required configuration parameters for plugin ampswitch
Dec 16 23:38:48 volumio volumio[9905]: info: Loading plugin "appearance"...
Dec 16 23:38:48 volumio volumio[9905]: info: Loading plugin "network"...
Dec 16 23:38:48 volumio volumio[9905]: info: Refreshing Cached IP Addresses
Dec 16 23:38:48 volumio sudo[9933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "services"...
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "alsa_controller"...
Dec 16 23:38:49 volumio sudo[9935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 16 23:38:49 volumio sudo[9933]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:49 volumio sudo[9933]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:49 volumio sudo[9935]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:49 volumio sudo[9935]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:49 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "wizard"...
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "networkfs"...
Dec 16 23:38:49 volumio volumio[9905]: info: Starting Udev Watcher for removable devices
Dec 16 23:38:49 volumio volumio[9905]: info: Ignoring mount for partition: BOOT
Dec 16 23:38:49 volumio volumio[9905]: info: Ignoring mount for partition: volumio
Dec 16 23:38:49 volumio volumio[9905]: info: Ignoring mount for partition: volumio_data
Dec 16 23:38:49 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "volumio_command_line_client"...
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "upnp"...
Dec 16 23:38:49 volumio volumio[9905]: info: [1765924729157] Starting Upmpd Daemon
Dec 16 23:38:49 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "my_music"...
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "mpd"...
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "upnp_browser"...
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "alarm-clock"...
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "airplay_emulation"...
Dec 16 23:38:49 volumio volumio[9905]: info: Starting Shairport Sync
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "last_100"...
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "webradio"...
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "i2s_dacs"...
Dec 16 23:38:49 volumio volumio[9905]: info: I2S DAC not set, start Auto-detection
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "volumiodiscovery"...
Dec 16 23:38:49 volumio volumio[9905]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Dec 16 23:38:49 volumio node[9905]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Dec 16 23:38:49 volumio volumio[9905]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 16 23:38:49 volumio node[9905]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 16 23:38:49 volumio volumio[9905]: *** WARNING *** For more information see
Dec 16 23:38:49 volumio node[9905]: *** WARNING *** For more information see
Dec 16 23:38:49 volumio volumio[9905]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Dec 16 23:38:49 volumio node[9905]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Dec 16 23:38:49 volumio volumio[9905]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 16 23:38:49 volumio node[9905]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 16 23:38:49 volumio volumio[9905]: *** WARNING *** For more information see
Dec 16 23:38:49 volumio node[9905]: *** WARNING *** For more information see
Dec 16 23:38:49 volumio volumio[9905]: info: Applying required configuration parameters for plugin volumiodiscovery
Dec 16 23:38:49 volumio volumio[9905]: info: Discovery: Started advertising with name: Volumio
Dec 16 23:38:49 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 16 23:38:49 volumio volumio[9905]: info: Loading plugin "mixcloud"...
Dec 16 23:38:50 volumio volumio[9905]: info: Loading plugin "soundcloud"...
Dec 16 23:38:50 volumio volumio[9905]: info: Loading plugin "ytcr"...
Dec 16 23:38:51 volumio volumio-remote-updater[546]: [2025-12-16 23:38:51] [connect] Successful connection
Dec 16 23:38:52 volumio volumio[9905]: info: Loading plugin "ytmusic"...
Dec 16 23:38:54 volumio volumio[9905]: info: Loading plugin "outputs"...
Dec 16 23:38:54 volumio volumio[9905]: info: Loading plugin "albumart"...
Dec 16 23:38:54 volumio volumio[9905]: info: Plugin example_plugin is not enabled
Dec 16 23:38:54 volumio volumio[9905]: info: Loading plugin "inputs"...
Dec 16 23:38:54 volumio volumio[9905]: info: Loading plugin "updater_comm"...
Dec 16 23:38:54 volumio volumio[9905]: info: Plugin mpdemulation is not enabled
Dec 16 23:38:54 volumio volumio[9905]: info: Loading plugin "rest_api"...
Dec 16 23:38:54 volumio volumio[9905]: info: Loading plugin "websocket"...
Dec 16 23:38:54 volumio volumio[9905]: info: Starting Socket.io Server version 2.3.0
Dec 16 23:38:54 volumio volumio[9905]: info: Plugin peppyspectrum is not enabled
Dec 16 23:38:54 volumio volumio[9905]: info: Loading i18n strings for locale de
Dec 16 23:38:54 volumio volumio[9905]: Updating browse sources language
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::initPlayerControls
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: Forking 3 albumart workers
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: Express server listening on port 3000
Dec 16 23:38:54 volumio volumio[9905]: [Metrics] WebUI: 7s 156.13ms
Dec 16 23:38:54 volumio volumio[9905]: info: CoreStateMachine::resetVolumioState
Dec 16 23:38:54 volumio volumio[9905]: info: CoreStateMachine::getcurrentVolume
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::volumioRetrievevolume
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:38:54 volumio volumio[9905]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Dec 16 23:38:54 volumio volumio[9905]: info: Completed loading Core Plugins
Dec 16 23:38:54 volumio volumio[9905]: info: Preparing to generate the ALSA configuration file
Dec 16 23:38:54 volumio volumio[9905]: info: Volumio Network Manager: Network status updated: 1
Dec 16 23:38:54 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Dec 16 23:38:54 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Dec 16 23:38:54 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Dec 16 23:38:54 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.38 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4
Dec 16 23:38:54 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Dec 16 23:38:54 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Dec 16 23:38:54 volumio volumio-remote-updater[546]: [2025-12-16 23:38:54] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1765924731 101
Dec 16 23:38:54 volumio volumio[9905]: 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: 7
Dec 16 23:38:54 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Dec 16 23:38:54 volumio volumio[9905]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Dec 16 23:38:54 volumio volumio[9905]: info: CoreStateMachine::setRepeat false single undefined
Dec 16 23:38:54 volumio volumio[9905]: info: CoreStateMachine::pushState
Dec 16 23:38:54 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::volumioPushState
Dec 16 23:38:54 volumio volumio[9905]: info: CoreStateMachine::setRandom null
Dec 16 23:38:54 volumio volumio[9905]: info: CoreStateMachine::pushState
Dec 16 23:38:54 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:54 volumio volumio[9905]: info: CoreCommandRouter::volumioPushState
Dec 16 23:38:55 volumio volumio[9905]: info: Setting Device type: Tinkerboard
Dec 16 23:38:55 volumio volumio[9905]: info: VolumeController:: Volume=4 Mute =false
Dec 16 23:38:55 volumio volumio[9905]: info: CoreStateMachine::pushState
Dec 16 23:38:55 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::volumioPushState
Dec 16 23:38:55 volumio volumio[9905]: info: CoreStateMachine::updateTrackBlock
Dec 16 23:38:55 volumio volumio[9905]: info: CorePlayQueue::getTrackBlock
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::volumioRetrievevolume
Dec 16 23:38:55 volumio volumio[9905]: info: Asound.conf file unchanged, so no further update is needed
Dec 16 23:38:55 volumio volumio[9905]: info: Output device has changed, restarting MPD
Dec 16 23:38:55 volumio volumio[9905]: info: Output device has changed, restarting Shairport Sync
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:38:55 volumio sudo[10072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 16 23:38:55 volumio sudo[10076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 16 23:38:55 volumio volumio[9905]: info: ___________ START PLUGINS ___________
Dec 16 23:38:55 volumio sudo[10072]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:55 volumio sudo[10076]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:55 volumio sudo[10072]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:55 volumio kernel: rockchip-pinctrl pinctrl: pin 0 is unrouted
Dec 16 23:38:55 volumio volumio[9905]: info: ControllerMpd::onStart: Initializing MPD
Dec 16 23:38:55 volumio volumio[9905]: info: Creating MPD Configuration file
Dec 16 23:38:55 volumio systemd[1]: Stopping Music Player Daemon...
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 16 23:38:55 volumio volumio[9905]: info: [1765924735297] CoreMusicLibrary::Adding element Medienserver
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:38:55 volumio volumio[9905]: Starting albumart workers
Dec 16 23:38:55 volumio volumio[9905]: Starting albumart workers
Dec 16 23:38:55 volumio sudo[10098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 16 23:38:55 volumio sudo[10100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 16 23:38:55 volumio sudo[10098]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:38:55 volumio sudo[10100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:55 volumio systemd[1]: mpd.service: Succeeded.
Dec 16 23:38:55 volumio systemd[1]: Stopped Music Player Daemon.
Dec 16 23:38:55 volumio systemd[1]: Starting Music Player Daemon...
Dec 16 23:38:55 volumio sudo[10098]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:38:55 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Dec 16 23:38:55 volumio systemd[1]: mpd.service: Succeeded.
Dec 16 23:38:55 volumio systemd[1]: Stopped Music Player Daemon.
Dec 16 23:38:55 volumio systemd[1]: Starting Music Player Daemon...
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 16 23:38:55 volumio volumio[9905]: info: [1765924735451] CoreMusicLibrary::Adding element Last_100
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 16 23:38:55 volumio volumio[9905]: info: [1765924735454] CoreMusicLibrary::Adding element Webradio
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 16 23:38:55 volumio volumio[9905]: info: Initializing BBC Radios
Dec 16 23:38:55 volumio volumio[9905]: Starting albumart workers
Dec 16 23:38:55 volumio sudo[10120]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 16 23:38:55 volumio sudo[10120]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:38:55 volumio sudo[10120]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 16 23:38:55 volumio volumio[9905]: info: [1765924735613] CoreMusicLibrary::Adding element Mixcloud
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:38:55 volumio volumio[9905]: Cannot find translation for source Mixcloud
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 16 23:38:55 volumio volumio[9905]: info: [1765924735635] CoreMusicLibrary::Adding element SoundCloud
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:38:55 volumio volumio[9905]: Cannot find translation for source Mixcloud
Dec 16 23:38:55 volumio volumio[9905]: Cannot find translation for source SoundCloud
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 16 23:38:55 volumio volumio[9905]: info: [1765924735687] CoreMusicLibrary::Adding element YouTube Music
Dec 16 23:38:55 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 23:38:55 volumio volumio[9905]: Cannot find translation for source Mixcloud
Dec 16 23:38:55 volumio volumio[9905]: Cannot find translation for source SoundCloud
Dec 16 23:38:55 volumio volumio[9905]: Cannot find translation for source YouTube Music
Dec 16 23:38:55 volumio volumio[9905]: info: Volumio Calling Home
Dec 16 23:38:55 volumio volumio[9905]: info: MPD Permissions set
Dec 16 23:38:55 volumio volumio[9905]: info: MPD Permissions set
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] CurState: stop PrevState: na
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] CurState: stop PrevState: na
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] CurState: stop PrevState: na
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] CurState: stop PrevState: na
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Dec 16 23:38:56 volumio volumio[9905]: info: Volumio called home
Dec 16 23:38:56 volumio volumio[9905]: info: Discovery: adding 009929a0-f413-4a13-a312-90def98326b0
Dec 16 23:38:56 volumio volumio[9905]: info: Discovery: Found device Volumio
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:56 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:56 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:56 volumio volumio[9905]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Dec 16 23:38:56 volumio volumio[9905]: info: VolumeController:: Volume=4 Mute =false
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:56 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:56 volumio volumio[9905]: info: CoreStateMachine::pushState
Dec 16 23:38:56 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::volumioPushState
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] CurState: stop PrevState: na
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] CurState: stop PrevState: na
Dec 16 23:38:56 volumio volumio[9905]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Dec 16 23:38:56 volumio volumio[9905]: info: Starting Shairport Sync
Dec 16 23:38:56 volumio volumio[9905]: info: Starting Shairport Sync
Dec 16 23:38:56 volumio volumio[9905]: info: Starting Shairport Sync
Dec 16 23:38:56 volumio sudo[10181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 16 23:38:56 volumio sudo[10181]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:56 volumio sudo[10184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:56 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:56 volumio sudo[10184]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:56 volumio sudo[10190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 16 23:38:56 volumio sudo[10190]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Dec 16 23:38:56 volumio systemd[1]: shairport-sync.service: Succeeded.
Dec 16 23:38:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Dec 16 23:38:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Dec 16 23:38:56 volumio sudo[10181]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:56 volumio sudo[10184]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Dec 16 23:38:56 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Dec 16 23:38:56 volumio systemd[1]: shairport-sync.service: Succeeded.
Dec 16 23:38:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Dec 16 23:38:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Dec 16 23:38:56 volumio sudo[10190]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:56 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.38 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11
Dec 16 23:38:56 volumio volumio[9905]: info: Shairport-Sync Started
Dec 16 23:38:56 volumio volumio[9905]: Error adding Membership: Error: addMembership EINVAL
Dec 16 23:38:56 volumio volumio[9905]: info: Shairport-Sync Started
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 16 23:38:56 volumio volumio[9905]: info: Discovery: Getting this device information
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:56 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 16 23:38:56 volumio volumio[9905]: info: Shairport-Sync Started
Dec 16 23:38:56 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 16 23:38:56 volumio volumio[9905]: info: Discovery: Getting this device information
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:56 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:56 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 16 23:38:56 volumio volumio[9905]: info: Listing playlists
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::volumioGetQueue
Dec 16 23:38:56 volumio volumio[9905]: info: CoreStateMachine::getQueue
Dec 16 23:38:56 volumio volumio[9905]: info: CorePlayQueue::getQueue
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone
Dec 16 23:38:56 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Dec 16 23:38:56 volumio sudo[10216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Dec 16 23:38:56 volumio sudo[10216]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:56 volumio sudo[10216]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:56 volumio sudo[10231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 16 23:38:56 volumio sudo[10223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 16 23:38:56 volumio sudo[10231]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:56 volumio sudo[10239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 16 23:38:56 volumio sudo[10223]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:56 volumio sudo[10231]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:56 volumio sudo[10252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 16 23:38:56 volumio sudo[10223]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:56 volumio sudo[10252]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:56 volumio sudo[10239]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:56 volumio sudo[10261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 16 23:38:56 volumio sudo[10239]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:56 volumio sudo[10252]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:56 volumio sudo[10261]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 23:38:56 volumio sudo[10261]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 16 23:38:57 volumio volumio[9905]: info: Discovery: Getting this device information
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:57 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:57 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 16 23:38:57 volumio volumio[9905]: info: Discovery: Getting this device information
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::volumioGetState
Dec 16 23:38:57 volumio volumio[9905]: info: CorePlayQueue::getTrack 0
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 23:38:57 volumio volumio[9905]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.38 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 13
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 23:38:57 volumio volumio[9905]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 23:38:57 volumio volumio[9905]: info: [ASDebug] Togle GPIO: OFF
Dec 16 23:38:57 volumio volumio[9905]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 23:38:57 volumio volumio[9905]: Error: EPERM: operation not permitted, write
Dec 16 23:38:57 volumio volumio[9905]: at Object.writeSync (fs.js:737:3)
Dec 16 23:38:57 volumio volumio[9905]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8)
Dec 16 23:38:57 volumio volumio[9905]: at AmpSwitchController.off (/data/plugins/system_controller/ampswitch/index.js:221:23)
Dec 16 23:38:57 volumio volumio[9905]: at Timeout._onTimeout (/data/plugins/system_controller/ampswitch/index.js:195:88)
Dec 16 23:38:57 volumio volumio[9905]: at listOnTimeout (internal/timers.js:557:17)
Dec 16 23:38:57 volumio volumio[9905]: at processTimers (internal/timers.js:500:7) {
Dec 16 23:38:57 volumio volumio[9905]: errno: -1,
Dec 16 23:38:57 volumio volumio[9905]: syscall: 'write',
Dec 16 23:38:57 volumio volumio[9905]: code: 'EPERM'
Dec 16 23:38:57 volumio volumio[9905]: }
Dec 16 23:38:57 volumio volumio[9905]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 23:38:57 volumio mpd[10140]: Dec 16 23:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 16 23:38:57 volumio systemd[1]: Started Music Player Daemon.
Dec 16 23:38:57 volumio sudo[10076]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:57 volumio sudo[10100]: pam_unix(sudo:session): session closed for user root
Dec 16 23:38:57 volumio sudo[10309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-16 23:37
Dec 16 23:38:57 volumio sudo[10309]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 07:17:52 PM CET"
VOLUMIO_VERSION="3.874"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_DEVICENAME="Asus Tinkerboard"
VOLUMIO_HASH="3b20d491450ccf59e0e519a97572dc60"