-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Fri 2025-10-24 10:32:20 +07. --
Oct 24 10:31:43 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Oct 24 10:31:43 volumio3 volumio[894]: info: Loading i18n strings for locale th
Oct 24 10:31:43 volumio3 volumio[894]: Updating browse sources language
Oct 24 10:31:43 volumio3 volumio[894]: Cannot find translation for source TIDAL
Oct 24 10:31:43 volumio3 volumio[894]: Cannot find translation for source QOBUZ
Oct 24 10:31:43 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 24 10:31:43 volumio3 volumio[894]: Cannot find translation for source TIDAL
Oct 24 10:31:43 volumio3 volumio[894]: Cannot find translation for source QOBUZ
Oct 24 10:31:44 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Oct 24 10:31:44 volumio3 volumio[894]: info: Setting timezone to Asia/Bangkok
Oct 24 10:31:44 volumio3 sudo[3294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Oct 24 10:31:44 volumio3 sudo[3294]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:44 volumio3 sudo[3294]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:44 volumio3 sudo[3297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Bangkok /etc/localtime
Oct 24 10:31:44 volumio3 sudo[3297]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:44 volumio3 sudo[3297]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:44 volumio3 sudo[3300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Oct 24 10:31:44 volumio3 sudo[3300]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:44 volumio3 sudo[3300]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:44 volumio3 sudo[3303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Bangkok
Oct 24 10:31:44 volumio3 sudo[3303]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:44 volumio3 dbus-daemon[608]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.79' (uid=0 pid=3304 comm="/usr/bin/timedatectl set-timezone Asia/Bangkok ")
Oct 24 10:31:44 volumio3 systemd[1]: Starting Time & Date Service...
Oct 24 10:31:44 volumio3 dbus-daemon[608]: [system] Successfully activated service 'org.freedesktop.timedate1'
Oct 24 10:31:44 volumio3 systemd[1]: Started Time & Date Service.
Oct 24 10:31:44 volumio3 sudo[3303]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:44 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 24 10:31:44 volumio3 volumio[894]: info: Fetching Streaming Services browse cache
Oct 24 10:31:45 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Oct 24 10:31:45 volumio3 volumio[894]: info: Loading i18n strings for locale th
Oct 24 10:31:45 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Oct 24 10:31:45 volumio3 volumio[894]: info: Setting timezone to Asia/Bangkok
Oct 24 10:31:45 volumio3 sudo[3307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Oct 24 10:31:45 volumio3 sudo[3307]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:45 volumio3 sudo[3307]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:45 volumio3 sudo[3310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Bangkok /etc/localtime
Oct 24 10:31:45 volumio3 sudo[3310]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:45 volumio3 sudo[3310]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:45 volumio3 sudo[3313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Oct 24 10:31:45 volumio3 sudo[3313]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:45 volumio3 sudo[3313]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:45 volumio3 sudo[3316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Bangkok
Oct 24 10:31:45 volumio3 sudo[3316]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:45 volumio3 sudo[3316]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:45 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Oct 24 10:31:45 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Oct 24 10:31:45 volumio3 sudo[3319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 24 10:31:45 volumio3 sudo[3319]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:45 volumio3 volumio[894]: Updating browse sources language
Oct 24 10:31:45 volumio3 volumio[894]: Cannot find translation for source TIDAL
Oct 24 10:31:45 volumio3 volumio[894]: Cannot find translation for source QOBUZ
Oct 24 10:31:45 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 24 10:31:45 volumio3 volumio[894]: Cannot find translation for source TIDAL
Oct 24 10:31:45 volumio3 volumio[894]: Cannot find translation for source QOBUZ
Oct 24 10:31:46 volumio3 volumio[894]: info: Fetching Streaming Services browse cache
Oct 24 10:31:49 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
Oct 24 10:31:49 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices
Oct 24 10:31:49 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:49 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 24 10:31:49 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 24 10:31:49 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 24 10:31:49 volumio3 sudo[3319]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Oct 24 10:31:50 volumio3 volumio[894]: info: Preparing to save Alsa Options, stopping services first
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:50 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::volumioPause
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreStateMachine::pause
Oct 24 10:31:50 volumio3 volumio[894]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"Gustard USB Audio 2.0"},"disallowPush":true}
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 24 10:31:50 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:50 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 24 10:31:50 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:50 volumio3 volumio[894]: info: Setting mixer Gustard USB Audio 2.0 for card Gustard USB Audio 2.0
Oct 24 10:31:50 volumio3 volumio[894]: info: QobuzConnect: setDeactiveState invoked
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:50 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:50 volumio3 vtcs[2926]: [2025-10-24 10:31:50.396] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected
Oct 24 10:31:50 volumio3 vtcs[2926]: [2025-10-24 10:31:50.397] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE
Oct 24 10:31:50 volumio3 sudo[3345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Oct 24 10:31:50 volumio3 sudo[3345]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 systemd[1]: Stopping Volumio Tidal Connect Service...
Oct 24 10:31:50 volumio3 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Oct 24 10:31:50 volumio3 systemd[1]: vtcs.service: Succeeded.
Oct 24 10:31:50 volumio3 systemd[1]: Stopped Volumio Tidal Connect Service.
Oct 24 10:31:50 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 24 10:31:50 volumio3 volumio[894]: info: Updating Volume Controller Parameters: Device: 5 Name: Gustard USB Audio 2.0 Mixer: Gustard USB Audio 2.0 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 24 10:31:50 volumio3 volumio[894]: info: Disabling external Volume Control
Oct 24 10:31:50 volumio3 sudo[3345]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:31:50 volumio3 volumio[894]: info: Preparing to generate the ALSA configuration file
Oct 24 10:31:50 volumio3 sudo[3352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Oct 24 10:31:50 volumio3 sudo[3352]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 sudo[3352]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Oct 24 10:31:50 volumio3 sudo[3358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Oct 24 10:31:50 volumio3 sudo[3358]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Oct 24 10:31:50 volumio3 sudo[3358]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 sudo[3362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 24 10:31:50 volumio3 sudo[3362]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 24 10:31:50 volumio3 volumio[894]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Oct 24 10:31:50 volumio3 volumio[894]: info: Reading ALSA contributions from plugins.
Oct 24 10:31:50 volumio3 sudo[3364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Oct 24 10:31:50 volumio3 sudo[3364]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 sudo[3366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 24 10:31:50 volumio3 sudo[3366]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 sudo[3366]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 systemd[1]: Stopping Volumio Qobuz Connect Service...
Oct 24 10:31:50 volumio3 volumio[894]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Oct 24 10:31:50 volumio3 volumio[894]: wlan0 Interface doesn't support scanning : Device or resource busy
Oct 24 10:31:50 volumio3 volumio[894]: info: Cannot use regular scanning, forcing with ap-force
Oct 24 10:31:50 volumio3 qobuz-connect[2906]: 20251024 10:31:50.621 [2906.2906] INFO SampleApp: Stopping Local configuration server
Oct 24 10:31:50 volumio3 qobuz-connect[2906]: 20251024 10:31:50.632 [2906.2906] INFO SampleApp: shat down connection on UNIX socket
Oct 24 10:31:50 volumio3 systemd[1]: qobuz-connect.service: Succeeded.
Oct 24 10:31:50 volumio3 systemd[1]: Stopped Volumio Qobuz Connect Service.
Oct 24 10:31:50 volumio3 sudo[3371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Oct 24 10:31:50 volumio3 sudo[3371]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 systemd[1]: Started Volumio Qobuz Connect Service.
Oct 24 10:31:50 volumio3 volumio[894]: command failed: Device or resource busy (-16)
Oct 24 10:31:50 volumio3 volumio[894]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Oct 24 10:31:50 volumio3 volumio[894]: command failed: Device or resource busy (-16)
Oct 24 10:31:50 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 24 10:31:50 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Oct 24 10:31:50 volumio3 volumio[894]: info: VolumeController:: Volume=100 Mute =false
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreStateMachine::pushState
Oct 24 10:31:50 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:50 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:50 volumio3 volumio[894]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Oct 24 10:31:50 volumio3 volumio[894]: info: QobuzConnect: setDeactiveState invoked
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:50 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:50 volumio3 sudo[3371]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 sudo[3364]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 24 10:31:50 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 24 10:31:50 volumio3 volumio[894]: info: Executing endpoint qc_getconfig
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Oct 24 10:31:50 volumio3 qobuz-connect[3372]: 20251024 10:31:50.793 [3372.3372] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Oct 24 10:31:50 volumio3 volumio[894]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Oct 24 10:31:50 volumio3 volumio[894]: info: QobuzConnect: QOBUZ Connect daemon connected
Oct 24 10:31:50 volumio3 volumio[894]: info: Asound.conf file unchanged, so no further update is needed
Oct 24 10:31:50 volumio3 volumio[894]: info: Output device has changed, restarting MPD
Oct 24 10:31:50 volumio3 qobuz-connect[3372]: 20251024 10:31:50.797 [3372.3372] INFO VolumeManager: [0x1a66328]: Setting new playback volume: 75
Oct 24 10:31:50 volumio3 qobuz-connect[3372]: 20251024 10:31:50.797 [3372.3372] INFO VolumeManager: [0x1a66328]: Setting new mute state: 0
Oct 24 10:31:50 volumio3 qobuz-connect[3372]: 20251024 10:31:50.797 [3372.3372] INFO QobuzConnect: [0x1a66cf8]: Client initialized!
Oct 24 10:31:50 volumio3 qobuz-connect[3372]: 20251024 10:31:50.797 [3372.3372] INFO SampleApp: Starting Avahi advertising, name: Volumio3, service name: _qobuz-connect._tcp
Oct 24 10:31:50 volumio3 qobuz-connect[3372]: 20251024 10:31:50.810 [3372.3372] INFO LocalConfigManager: [0x1a65c08]: Starting Local Configuration server
Oct 24 10:31:50 volumio3 qobuz-connect[3372]: 20251024 10:31:50.810 [3372.3372] INFO SampleApp: Starting Local configuration server
Oct 24 10:31:50 volumio3 qobuz-connect[3372]: 20251024 10:31:50.811 [3372.3372] INFO SampleApp: Connected to UNIX socket client 0x1a5bf60
Oct 24 10:31:50 volumio3 sudo[3383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 24 10:31:50 volumio3 sudo[3383]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 sudo[3383]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 volumio[894]: info: Output device has changed, restarting Shairport Sync
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 24 10:31:50 volumio3 sudo[3386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 24 10:31:50 volumio3 sudo[3386]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 systemd[1]: Stopping Music Player Daemon...
Oct 24 10:31:50 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:50 volumio3 systemd[1]: mpd.service: Succeeded.
Oct 24 10:31:50 volumio3 volumio[894]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 24 10:31:50 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:50 volumio3 systemd[1]: Stopped Music Player Daemon.
Oct 24 10:31:50 volumio3 volumio[894]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:50 volumio3 volumio[894]: info: QobuzConnect: setDeactiveState invoked
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:50 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:50 volumio3 systemd[1]: Starting Music Player Daemon...
Oct 24 10:31:50 volumio3 sudo[3395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Oct 24 10:31:50 volumio3 sudo[3395]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 qobuz-connect[3372]: 20251024 10:31:50.946 [3372.3372] INFO SampleApp: Playback volume changed: 75
Oct 24 10:31:50 volumio3 sudo[3398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Oct 24 10:31:50 volumio3 sudo[3398]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:50 volumio3 sudo[3395]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 24 10:31:50 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Oct 24 10:31:50 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 24 10:31:50 volumio3 sudo[3398]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:50 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:50 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:51 volumio3 sudo[3391]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 24 10:31:51 volumio3 volumio[894]: info: MPD Permissions set
Oct 24 10:31:51 volumio3 sudo[3391]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:51 volumio3 sudo[3405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:51 volumio3 sudo[3405]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:51 volumio3 sudo[3391]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:51 volumio3 volumio[894]: info: Starting Shairport Sync
Oct 24 10:31:51 volumio3 sudo[3415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 24 10:31:51 volumio3 sudo[3415]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:51 volumio3 sudo[3405]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:51 volumio3 sudo[3417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Oct 24 10:31:51 volumio3 sudo[3417]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:51 volumio3 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 24 10:31:51 volumio3 systemd[1]: shairport-sync.service: Succeeded.
Oct 24 10:31:51 volumio3 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 24 10:31:51 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 24 10:31:51 volumio3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 24 10:31:51 volumio3 sudo[3415]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:51 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Oct 24 10:31:51 volumio3 volumio[894]: info: Shairport-Sync Started
Oct 24 10:31:51 volumio3 systemd[1]: Stopping Volumio Qobuz Connect Service...
Oct 24 10:31:51 volumio3 qobuz-connect[3372]: 20251024 10:31:51.116 [3372.3372] INFO SampleApp: Stopping Local configuration server
Oct 24 10:31:51 volumio3 qobuz-connect[3372]: 20251024 10:31:51.126 [3372.3372] INFO SampleApp: shat down connection on UNIX socket
Oct 24 10:31:51 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 24 10:31:51 volumio3 volumio[894]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Oct 24 10:31:51 volumio3 volumio[894]: info: QobuzConnect: setDeactiveState invoked
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:51 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:51 volumio3 systemd[1]: qobuz-connect.service: Succeeded.
Oct 24 10:31:51 volumio3 systemd[1]: Stopped Volumio Qobuz Connect Service.
Oct 24 10:31:51 volumio3 volumio[894]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Oct 24 10:31:51 volumio3 systemd[1]: Started Volumio Qobuz Connect Service.
Oct 24 10:31:51 volumio3 sudo[3417]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:51 volumio3 volumio[894]: info: Executing endpoint qc_getconfig
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Oct 24 10:31:51 volumio3 qobuz-connect[3422]: 20251024 10:31:51.184 [3422.3422] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Oct 24 10:31:51 volumio3 volumio[894]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Oct 24 10:31:51 volumio3 volumio[894]: info: QobuzConnect: QOBUZ Connect daemon connected
Oct 24 10:31:51 volumio3 qobuz-connect[3422]: 20251024 10:31:51.188 [3422.3422] INFO VolumeManager: [0x1f74328]: Setting new playback volume: 75
Oct 24 10:31:51 volumio3 qobuz-connect[3422]: 20251024 10:31:51.188 [3422.3422] INFO VolumeManager: [0x1f74328]: Setting new mute state: 0
Oct 24 10:31:51 volumio3 qobuz-connect[3422]: 20251024 10:31:51.188 [3422.3422] INFO QobuzConnect: [0x1f74cf8]: Client initialized!
Oct 24 10:31:51 volumio3 qobuz-connect[3422]: 20251024 10:31:51.189 [3422.3422] INFO SampleApp: Starting Avahi advertising, name: Volumio3, service name: _qobuz-connect._tcp
Oct 24 10:31:51 volumio3 qobuz-connect[3422]: 20251024 10:31:51.195 [3422.3422] INFO LocalConfigManager: [0x1f73c08]: Starting Local Configuration server
Oct 24 10:31:51 volumio3 qobuz-connect[3422]: 20251024 10:31:51.196 [3422.3422] INFO SampleApp: Starting Local configuration server
Oct 24 10:31:51 volumio3 qobuz-connect[3422]: 20251024 10:31:51.196 [3422.3422] INFO SampleApp: Connected to UNIX socket client 0x1f69f60
Oct 24 10:31:51 volumio3 qobuz-connect[3422]: 20251024 10:31:51.334 [3422.3422] INFO SampleApp: Playback volume changed: 75
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:51 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:31:51 volumio3 volumio[894]: info: Retrieving Cloud Streaming UI
Oct 24 10:31:51 volumio3 volumio[894]: info: Getting Tidal Cloud Configuration
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:31:51 volumio3 volumio[894]: info: Getting Qobuz Cloud Configuration
Oct 24 10:31:51 volumio3 volumio[894]: info: Asking plugin for UI Config
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:31:51 volumio3 volumio[894]: info: Getting Spotify Cloud Configuration
Oct 24 10:31:51 volumio3 volumio[894]: info: Asking plugin for UI Config
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:31:51 volumio3 volumio[894]: info: Saving Spotify Acccount
Oct 24 10:31:51 volumio3 volumio[894]: info: Got it
Oct 24 10:31:51 volumio3 volumio[894]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Oct 24 10:31:51 volumio3 volumio[894]: info: Got Tidal Cloud Configuration
Oct 24 10:31:51 volumio3 volumio[894]: info: Got it
Oct 24 10:31:51 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:31:51 volumio3 mpd[3409]: Oct 24 10:31 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 24 10:31:51 volumio3 systemd[1]: Started Music Player Daemon.
Oct 24 10:31:51 volumio3 sudo[3386]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:51 volumio3 volumio[894]: error: updateQueue error: null
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware
Oct 24 10:31:53 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware
Oct 24 10:31:53 volumio3 volumio[894]: xcb_connection_has_error() returned true
Oct 24 10:31:53 volumio3 volumio[894]: info: TidalConnect service stoped!
Oct 24 10:31:53 volumio3 volumio[894]: info: TidalConnect service stoped!
Oct 24 10:31:53 volumio3 volumio[894]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Oct 24 10:31:53 volumio3 volumio[894]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Oct 24 10:31:53 volumio3 sudo[3442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Oct 24 10:31:53 volumio3 sudo[3442]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:53 volumio3 systemd[1]: Started Volumio Tidal Connect Service.
Oct 24 10:31:53 volumio3 sudo[3442]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:53 volumio3 volumio[894]: info: Executing endpoint tc_getconfig
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Oct 24 10:31:53 volumio3 vtcs[3444]: STARTING TidalConnect services, version: 1.5.1-beta1
Oct 24 10:31:53 volumio3 vtcs[3444]: STARTED TidalConnect services.
Oct 24 10:31:53 volumio3 volumio[894]: info: Executing endpoint tc_connect
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Oct 24 10:31:53 volumio3 volumio[894]: info: Connecting to TidalConnect
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::servicePushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::pushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Oct 24 10:31:53 volumio3 volumio[894]: verbose: CURRENT POSITION 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::syncState stateService stop
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::pushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: No code
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::pushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::servicePushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::pushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Oct 24 10:31:53 volumio3 volumio[894]: verbose: CURRENT POSITION 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::syncState stateService stop
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::pushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: No code
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreStateMachine::pushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 24 10:31:53 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:53 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:53 volumio3 volumio[894]: info: TidalConnect service stoped!
Oct 24 10:31:54 volumio3 volumio[894]: info: TidalConnect service stoped!
Oct 24 10:31:54 volumio3 volumio[894]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Oct 24 10:31:54 volumio3 volumio[894]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Oct 24 10:31:54 volumio3 sudo[3472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Oct 24 10:31:54 volumio3 sudo[3472]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:54 volumio3 sudo[3472]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreStateMachine::getcurrentVolume
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreCommandRouter::volumioRetrievevolume
Oct 24 10:31:54 volumio3 volumio[894]: info: VolumeController:: Volume=100 Mute =false
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreStateMachine::pushState
Oct 24 10:31:54 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:54 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreStateMachine::updateTrackBlock
Oct 24 10:31:54 volumio3 volumio[894]: info: CorePlayQueue::getTrackBlock
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreCommandRouter::volumioRetrievevolume
Oct 24 10:31:54 volumio3 volumio[894]: info: VolumeController:: Volume=100 Mute =false
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreStateMachine::pushState
Oct 24 10:31:54 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 24 10:31:54 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:54 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:54 volumio3 sudo[3362]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:55 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction
Oct 24 10:31:55 volumio3 volumio[894]: info: CoreCommandRouter::Reload Ui
Oct 24 10:31:55 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard
Oct 24 10:31:55 volumio3 volumio[894]: info: Wizard terminated Successfully
Oct 24 10:31:55 volumio3 volumio[894]: info: CoreCommandRouter::volumiosetStartupVolume
Oct 24 10:31:55 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 24 10:31:56 volumio3 sudo[3535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 24 10:31:56 volumio3 sudo[3535]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:56 volumio3 sudo[3535]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:56 volumio3 sudo[3538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 24 10:31:56 volumio3 sudo[3538]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:56 volumio3 sudo[3538]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:56 volumio3 volumio[894]: verbose: New Socket.io Connection to 192.168.1.60 from 192.168.1.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Oct 24 10:31:56 volumio3 sudo[3541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 24 10:31:56 volumio3 sudo[3541]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:56 volumio3 sudo[3541]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:56 volumio3 volumio[894]: info: TidalConnect service started!
Oct 24 10:31:56 volumio3 sudo[3544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 24 10:31:56 volumio3 sudo[3544]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:31:56 volumio3 sudo[3544]: pam_unix(sudo:session): session closed for user root
Oct 24 10:31:56 volumio3 volumio[894]: verbose: New Socket.io Connection to 192.168.1.60 from 192.168.1.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:56 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 24 10:31:56 volumio3 volumio[894]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Oct 24 10:31:56 volumio3 volumio[894]: info: Received Get System Info
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 10:31:56 volumio3 volumio[894]: info: Discovery: Getting this device information
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:56 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:56 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:56 volumio3 volumio[894]: info: Listing playlists
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 24 10:31:56 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 24 10:31:57 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 24 10:31:57 volumio3 volumio[894]: info: TidalConnect service started!
Oct 24 10:31:57 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:57 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:58 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 24 10:31:58 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 24 10:31:58 volumio3 volumio[894]: info: Received Get System Info
Oct 24 10:31:58 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 10:31:58 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 10:31:58 volumio3 volumio[894]: info: Discovery: Getting this device information
Oct 24 10:31:58 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:31:58 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:31:58 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 10:32:00 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 24 10:32:00 volumio3 volumio[894]: info: Received Get System Info
Oct 24 10:32:00 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 10:32:00 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 10:32:00 volumio3 volumio[894]: info: Discovery: Getting this device information
Oct 24 10:32:00 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:32:00 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:32:00 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 10:32:01 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse
Oct 24 10:32:06 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 24 10:32:08 volumio3 volumio[894]: info: CoreCommandRouter::Close All Modals sent
Oct 24 10:32:08 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted
Oct 24 10:32:10 volumio3 sudo[3568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 24 10:32:10 volumio3 sudo[3568]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:32:10 volumio3 sudo[3568]: pam_unix(sudo:session): session closed for user root
Oct 24 10:32:10 volumio3 sudo[3571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 24 10:32:10 volumio3 sudo[3571]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 10:32:10 volumio3 sudo[3571]: pam_unix(sudo:session): session closed for user root
Oct 24 10:32:10 volumio3 volumio[894]: verbose: New Socket.io Connection to 192.168.1.60 from 192.168.1.63 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:32:10 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 24 10:32:10 volumio3 volumio[894]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Oct 24 10:32:10 volumio3 volumio[894]: info: Received Get System Info
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 10:32:10 volumio3 volumio[894]: info: Discovery: Getting this device information
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:32:10 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:32:10 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:32:10 volumio3 volumio[894]: info: Listing playlists
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 24 10:32:10 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 24 10:32:11 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:32:11 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:32:12 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 24 10:32:12 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 24 10:32:12 volumio3 volumio[894]: info: Received Get System Info
Oct 24 10:32:12 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 10:32:12 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 10:32:12 volumio3 volumio[894]: info: Discovery: Getting this device information
Oct 24 10:32:12 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:32:12 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:32:12 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 10:32:13 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 24 10:32:13 volumio3 volumio[894]: info: Received Get System Info
Oct 24 10:32:13 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 10:32:13 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 10:32:13 volumio3 volumio[894]: info: Discovery: Getting this device information
Oct 24 10:32:13 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 24 10:32:13 volumio3 volumio[894]: info: CorePlayQueue::getTrack 0
Oct 24 10:32:13 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 10:32:14 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Oct 24 10:32:14 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 24 10:32:14 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 24 10:32:14 volumio3 volumio-remote-updater[613]: No test mode
Oct 24 10:32:14 volumio3 volumio-remote-updater[613]: No alpha test mode
Oct 24 10:32:15 volumio3 volumio[894]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Oct 24 10:32:15 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 24 10:32:15 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Oct 24 10:32:15 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 24 10:32:15 volumio3 systemd[1]: systemd-timedated.service: Succeeded.
Oct 24 10:32:15 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 24 10:32:15 volumio3 volumio-remote-updater[613]: No test mode
Oct 24 10:32:15 volumio3 volumio-remote-updater[613]: No alpha test mode
Oct 24 10:32:16 volumio3 volumio[894]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Oct 24 10:32:16 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:32:17 volumio3 volumio[894]: info: Retrieving Cloud Streaming UI
Oct 24 10:32:17 volumio3 volumio[894]: info: Getting Tidal Cloud Configuration
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:32:17 volumio3 volumio[894]: info: Getting Qobuz Cloud Configuration
Oct 24 10:32:17 volumio3 volumio[894]: info: Asking plugin for UI Config
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:32:17 volumio3 volumio[894]: info: Getting Spotify Cloud Configuration
Oct 24 10:32:17 volumio3 volumio[894]: info: Asking plugin for UI Config
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:32:17 volumio3 volumio[894]: info: Saving Spotify Acccount
Oct 24 10:32:17 volumio3 volumio[894]: info: Got it
Oct 24 10:32:17 volumio3 volumio[894]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Oct 24 10:32:17 volumio3 volumio[894]: info: Got Tidal Cloud Configuration
Oct 24 10:32:17 volumio3 volumio[894]: info: Got it
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 24 10:32:17 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Oct 24 10:32:19 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Oct 24 10:32:19 volumio3 volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Oct 24 10:32:19 volumio3 volumio[894]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 24 10:32:19 volumio3 volumio[894]: Error: getaddrinfo -3007
Oct 24 10:32:19 volumio3 volumio[894]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Oct 24 10:32:19 volumio3 volumio[894]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Oct 24 10:32:19 volumio3 volumio[894]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Oct 24 10:32:19 volumio3 volumio[894]: code: -3007,
Oct 24 10:32:19 volumio3 volumio[894]: errno: -3007,
Oct 24 10:32:19 volumio3 volumio[894]: syscall: 'getaddrinfo'
Oct 24 10:32:19 volumio3 volumio[894]: }
Oct 24 10:32:19 volumio3 volumio[894]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 24 10:32:20 volumio3 sudo[3606]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-24 10:31
Oct 24 10:32:20 volumio3 sudo[3606]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"