-- Logs begin at Sat 2025-08-30 15:09:26 CEST, end at Sat 2025-08-30 15:12:58 CEST. --
Aug 30 15:11:00 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:00 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:00 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:00 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:01 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:01 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:01 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:01 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:02 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:02 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:02 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:02 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:03 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:03 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:03 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:03 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:04 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:04 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:04 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:04 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:05 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:05 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:05 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:05 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:06 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:06 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:06 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:06 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:07 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:07 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:07 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:07 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:08 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:08 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:08 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:08 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:09 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:09 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:09 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:09 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Enabling plugin fusiondsp
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Loading plugin "fusiondsp"...
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Applying required configuration parameters for plugin fusiondsp
Aug 30 15:11:10 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:10 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:10 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:10 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Preparing to generate the ALSA configuration file
Aug 30 15:11:10 volumio-miro volumio[1267]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Aug 30 15:11:10 volumio-miro volumio[1267]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Reading ALSA contributions from plugins.
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Asound.conf file unchanged, so no further update is needed
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Output device has changed, restarting MPD
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Output device has changed, restarting Shairport Sync
Aug 30 15:11:10 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:10 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:11:10 volumio-miro sudo[3130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 30 15:11:10 volumio-miro sudo[3130]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:10 volumio-miro sudo[3133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 30 15:11:10 volumio-miro sudo[3130]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:10 volumio-miro sudo[3133]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:10 volumio-miro volumio[1267]: No protocol specified
Aug 30 15:11:10 volumio-miro volumio[1267]: xcb_connection_has_error() returned true
Aug 30 15:11:10 volumio-miro volumio[1267]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Aug 30 15:11:10 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:10 volumio-miro systemd[1]: Stopping Music Player Daemon...
Aug 30 15:11:10 volumio-miro volumio[1267]: info: QobuzConnect: setDeactiveState invoked
Aug 30 15:11:10 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:11:10 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:10 volumio-miro vtcs[2490]: [2025-08-30 15:11:10.869] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE
Aug 30 15:11:10 volumio-miro vtcs[2490]: [2025-08-30 15:11:10.871] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer
Aug 30 15:11:10 volumio-miro vtcs[2490]: [2025-08-30 15:11:10.871] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected
Aug 30 15:11:10 volumio-miro volumio[1267]: info: PLUGIN START: fusiondsp
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Loading i18n strings for locale pl
Aug 30 15:11:10 volumio-miro sudo[3153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored.
Aug 30 15:11:10 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Aug 30 15:11:10 volumio-miro systemd[1]: mpd.service: Succeeded.
Aug 30 15:11:10 volumio-miro systemd[1]: Stopped Music Player Daemon.
Aug 30 15:11:10 volumio-miro systemd[1]: Starting Music Player Daemon...
Aug 30 15:11:10 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:10 volumio-miro volumio[1267]: info: FusionDsp - mixtype--------------------- None
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Preparing to generate the ALSA configuration file
Aug 30 15:11:10 volumio-miro sudo[3153]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:10 volumio-miro systemd[1]: Stopping Volumio Tidal Connect Service...
Aug 30 15:11:10 volumio-miro systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Aug 30 15:11:10 volumio-miro systemd[1]: vtcs.service: Succeeded.
Aug 30 15:11:10 volumio-miro systemd[1]: Stopped Volumio Tidal Connect Service.
Aug 30 15:11:10 volumio-miro volumio[1267]: info: Done.
Aug 30 15:11:10 volumio-miro sudo[3153]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:10 volumio-miro sudo[3164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:11:11 volumio-miro sudo[3156]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 30 15:11:11 volumio-miro sudo[3164]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Aug 30 15:11:11 volumio-miro volumio[1267]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Reading ALSA contributions from plugins.
Aug 30 15:11:11 volumio-miro sudo[3156]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro sudo[3156]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro sudo[3178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Aug 30 15:11:11 volumio-miro sudo[3164]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro sudo[3178]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro sudo[3178]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro volumio[1267]: info: MPD Permissions set
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro sudo[3196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Aug 30 15:11:11 volumio-miro sudo[3196]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro systemd[1]: Stopping Volumio Qobuz Connect Service...
Aug 30 15:11:11 volumio-miro qobuz-connect[2403]: 20250830 15:11:11.141 [2403.2403] INFO SampleApp: Stopping Local configuration server
Aug 30 15:11:11 volumio-miro qobuz-connect[2403]: 20250830 15:11:11.159 [2403.2403] INFO SampleApp: shat down connection on UNIX socket
Aug 30 15:11:11 volumio-miro systemd[1]: qobuz-connect.service: Succeeded.
Aug 30 15:11:11 volumio-miro systemd[1]: Stopped Volumio Qobuz Connect Service.
Aug 30 15:11:11 volumio-miro systemd[1]: Started Volumio Qobuz Connect Service.
Aug 30 15:11:11 volumio-miro sudo[3196]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:11 volumio-miro volumio[1267]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Aug 30 15:11:11 volumio-miro volumio[1267]: info: QobuzConnect: setDeactiveState invoked
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Starting Shairport Sync
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Asound.conf file unchanged, so no further update is needed
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Output device has changed, restarting MPD
Aug 30 15:11:11 volumio-miro sudo[3215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 30 15:11:11 volumio-miro sudo[3215]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Output device has changed, restarting Shairport Sync
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:11:11 volumio-miro sudo[3220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 30 15:11:11 volumio-miro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 30 15:11:11 volumio-miro systemd[1]: shairport-sync.service: Succeeded.
Aug 30 15:11:11 volumio-miro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 30 15:11:11 volumio-miro sudo[3220]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 30 15:11:11 volumio-miro sudo[3215]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro volumio[1267]: No protocol specified
Aug 30 15:11:11 volumio-miro volumio[1267]: xcb_connection_has_error() returned true
Aug 30 15:11:11 volumio-miro volumio[1267]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro sudo[3220]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro sudo[3228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 30 15:11:11 volumio-miro volumio[1267]: info: QobuzConnect: setDeactiveState invoked
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:11 volumio-miro sudo[3228]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Preparing to generate the ALSA configuration file
Aug 30 15:11:11 volumio-miro sudo[3250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:11:11 volumio-miro sudo[3250]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro sudo[3255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:11:11 volumio-miro systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Aug 30 15:11:11 volumio-miro systemd[1]: mpd.service: Succeeded.
Aug 30 15:11:11 volumio-miro systemd[1]: Stopped Music Player Daemon.
Aug 30 15:11:11 volumio-miro systemd[1]: Starting Music Player Daemon...
Aug 30 15:11:11 volumio-miro sudo[3255]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro sudo[3250]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Executing endpoint qc_getconfig
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.466 [3209.3209] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Aug 30 15:11:11 volumio-miro volumio[1267]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Aug 30 15:11:11 volumio-miro volumio[1267]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Reading ALSA contributions from plugins.
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.471 [3209.3209] INFO VolumeManager: [0x81174920]: Setting new playback volume: 75
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.471 [3209.3209] INFO VolumeManager: [0x81174920]: Setting new mute state: 0
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.471 [3209.3209] INFO QobuzConnect: [0x811752f0]: Client initialized!
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.471 [3209.3209] INFO SampleApp: Starting Avahi advertising, name: Volumio Miro, service name: _qobuz-connect._tcp
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:11 volumio-miro sudo[3270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.488 [3209.3209] INFO LocalConfigManager: [0x81174200]: Starting Local Configuration server
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.488 [3209.3209] INFO SampleApp: Starting Local configuration server
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.489 [3209.3209] INFO SampleApp: Connected to UNIX socket client 0x81169ed8
Aug 30 15:11:11 volumio-miro sudo[3255]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:11 volumio-miro sudo[3270]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro volumio[1267]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Aug 30 15:11:11 volumio-miro volumio[1267]: info: QobuzConnect: QOBUZ Connect daemon connected
Aug 30 15:11:11 volumio-miro volumio[1267]: info: MPD Permissions set
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Shairport-Sync Started
Aug 30 15:11:11 volumio-miro sudo[3270]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro sudo[3265]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Aug 30 15:11:11 volumio-miro sudo[3265]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro sudo[3288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Aug 30 15:11:11 volumio-miro sudo[3265]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro sudo[3288]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Starting Shairport Sync
Aug 30 15:11:11 volumio-miro systemd[1]: Stopping Volumio Qobuz Connect Service...
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.603 [3209.3209] INFO SampleApp: Stopping Local configuration server
Aug 30 15:11:11 volumio-miro qobuz-connect[3209]: 20250830 15:11:11.614 [3209.3209] INFO SampleApp: shat down connection on UNIX socket
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro systemd[1]: qobuz-connect.service: Succeeded.
Aug 30 15:11:11 volumio-miro systemd[1]: Stopped Volumio Qobuz Connect Service.
Aug 30 15:11:11 volumio-miro volumio[1267]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Aug 30 15:11:11 volumio-miro volumio[1267]: info: QobuzConnect: setDeactiveState invoked
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:11 volumio-miro systemd[1]: Started Volumio Qobuz Connect Service.
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Asound.conf file written
Aug 30 15:11:11 volumio-miro sudo[3288]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro sudo[3308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 30 15:11:11 volumio-miro sudo[3308]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro sudo[3315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Aug 30 15:11:11 volumio-miro sudo[3315]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 30 15:11:11 volumio-miro systemd[1]: shairport-sync.service: Succeeded.
Aug 30 15:11:11 volumio-miro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 30 15:11:11 volumio-miro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 30 15:11:11 volumio-miro sudo[3308]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro sudo[3315]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:11 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:11 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:11 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:11 volumio-miro volumio[1267]: No protocol specified
Aug 30 15:11:11 volumio-miro volumio[1267]: xcb_connection_has_error() returned true
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Output device has changed, restarting MPD
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Output device has changed, restarting Shairport Sync
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:11:11 volumio-miro sudo[3339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 30 15:11:11 volumio-miro sudo[3339]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro sudo[3342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 30 15:11:11 volumio-miro sudo[3339]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro sudo[3342]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: No protocol specified
Aug 30 15:11:11 volumio-miro volumio[1267]: xcb_connection_has_error() returned true
Aug 30 15:11:11 volumio-miro volumio[1267]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:11 volumio-miro volumio[1267]: info: QobuzConnect: setDeactiveState invoked
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:11 volumio-miro sudo[3361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:11:11 volumio-miro sudo[3361]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Aug 30 15:11:11 volumio-miro systemd[1]: mpd.service: Succeeded.
Aug 30 15:11:11 volumio-miro systemd[1]: Stopped Music Player Daemon.
Aug 30 15:11:11 volumio-miro systemd[1]: Starting Music Player Daemon...
Aug 30 15:11:11 volumio-miro sudo[3366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:11:11 volumio-miro sudo[3361]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro sudo[3366]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:11 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:11 volumio-miro sudo[3366]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:11 volumio-miro volumio[1267]: info: MPD Permissions set
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Shairport-Sync Started
Aug 30 15:11:11 volumio-miro sudo[3381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Aug 30 15:11:11 volumio-miro volumio[1267]: info: Executing endpoint qc_getconfig
Aug 30 15:11:11 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Aug 30 15:11:11 volumio-miro qobuz-connect[3309]: 20250830 15:11:11.988 [3309.3309] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Aug 30 15:11:11 volumio-miro qobuz-connect[3309]: 20250830 15:11:11.993 [3309.3309] INFO VolumeManager: [0x8136c920]: Setting new playback volume: 75
Aug 30 15:11:11 volumio-miro qobuz-connect[3309]: 20250830 15:11:11.993 [3309.3309] INFO VolumeManager: [0x8136c920]: Setting new mute state: 0
Aug 30 15:11:11 volumio-miro qobuz-connect[3309]: 20250830 15:11:11.993 [3309.3309] INFO QobuzConnect: [0x8136d2f0]: Client initialized!
Aug 30 15:11:11 volumio-miro qobuz-connect[3309]: 20250830 15:11:11.993 [3309.3309] INFO SampleApp: Starting Avahi advertising, name: Volumio Miro, service name: _qobuz-connect._tcp
Aug 30 15:11:12 volumio-miro volumio[1267]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Aug 30 15:11:12 volumio-miro qobuz-connect[3309]: 20250830 15:11:12.002 [3309.3309] INFO LocalConfigManager: [0x8136c200]: Starting Local Configuration server
Aug 30 15:11:12 volumio-miro volumio[1267]: info: QobuzConnect: QOBUZ Connect daemon connected
Aug 30 15:11:12 volumio-miro qobuz-connect[3309]: 20250830 15:11:12.003 [3309.3309] INFO SampleApp: Starting Local configuration server
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:12 volumio-miro sudo[3381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:12 volumio-miro qobuz-connect[3309]: 20250830 15:11:12.006 [3309.3309] INFO SampleApp: Connected to UNIX socket client 0x81361ed8
Aug 30 15:11:12 volumio-miro sudo[3370]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 30 15:11:12 volumio-miro sudo[3370]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:12 volumio-miro sudo[3381]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Aug 30 15:11:12 volumio-miro sudo[3370]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:12 volumio-miro volumio[1267]: info: Starting Shairport Sync
Aug 30 15:11:12 volumio-miro sudo[3411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Aug 30 15:11:12 volumio-miro sudo[3411]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:12 volumio-miro sudo[3415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 30 15:11:12 volumio-miro sudo[3415]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:12 volumio-miro qobuz-connect[3309]: 20250830 15:11:12.096 [3309.3309] INFO SampleApp: Stopping Local configuration server
Aug 30 15:11:12 volumio-miro systemd[1]: Stopping Volumio Qobuz Connect Service...
Aug 30 15:11:12 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:12 volumio-miro qobuz-connect[3309]: 20250830 15:11:12.107 [3309.3309] INFO SampleApp: shat down connection on UNIX socket
Aug 30 15:11:12 volumio-miro volumio[1267]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Aug 30 15:11:12 volumio-miro volumio[1267]: info: QobuzConnect: setDeactiveState invoked
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:12 volumio-miro systemd[1]: qobuz-connect.service: Succeeded.
Aug 30 15:11:12 volumio-miro systemd[1]: Stopped Volumio Qobuz Connect Service.
Aug 30 15:11:12 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:12 volumio-miro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 30 15:11:12 volumio-miro systemd[1]: Started Volumio Qobuz Connect Service.
Aug 30 15:11:12 volumio-miro sudo[3411]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:12 volumio-miro systemd[1]: shairport-sync.service: Succeeded.
Aug 30 15:11:12 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:12 volumio-miro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 30 15:11:12 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:11:12 volumio-miro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 30 15:11:12 volumio-miro sudo[3415]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:12 volumio-miro volumio[1267]: info: Executing endpoint qc_getconfig
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Aug 30 15:11:12 volumio-miro qobuz-connect[3426]: 20250830 15:11:12.193 [3426.3426] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Aug 30 15:11:12 volumio-miro qobuz-connect[3426]: 20250830 15:11:12.198 [3426.3426] INFO VolumeManager: [0x81248920]: Setting new playback volume: 75
Aug 30 15:11:12 volumio-miro qobuz-connect[3426]: 20250830 15:11:12.198 [3426.3426] INFO VolumeManager: [0x81248920]: Setting new mute state: 0
Aug 30 15:11:12 volumio-miro qobuz-connect[3426]: 20250830 15:11:12.198 [3426.3426] INFO QobuzConnect: [0x812492f0]: Client initialized!
Aug 30 15:11:12 volumio-miro qobuz-connect[3426]: 20250830 15:11:12.198 [3426.3426] INFO SampleApp: Starting Avahi advertising, name: Volumio Miro, service name: _qobuz-connect._tcp
Aug 30 15:11:12 volumio-miro volumio[1267]: info: Shairport-Sync Started
Aug 30 15:11:12 volumio-miro volumio[1267]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Aug 30 15:11:12 volumio-miro volumio[1267]: info: QobuzConnect: QOBUZ Connect daemon connected
Aug 30 15:11:12 volumio-miro qobuz-connect[3426]: 20250830 15:11:12.208 [3426.3426] INFO LocalConfigManager: [0x81248200]: Starting Local Configuration server
Aug 30 15:11:12 volumio-miro qobuz-connect[3426]: 20250830 15:11:12.209 [3426.3426] INFO SampleApp: Starting Local configuration server
Aug 30 15:11:12 volumio-miro qobuz-connect[3426]: 20250830 15:11:12.210 [3426.3426] INFO SampleApp: Connected to UNIX socket client 0x8123ded8
Aug 30 15:11:12 volumio-miro qobuz-connect[3426]: 20250830 15:11:12.344 [3426.3426] INFO SampleApp: Playback volume changed: 75
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:12 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:12 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:12 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:12 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:12 volumio-miro volumio[1267]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Aug 30 15:11:12 volumio-miro volumio[1267]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Aug 30 15:11:12 volumio-miro volumio[1267]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Aug 30 15:11:12 volumio-miro volumio[1267]: info: camilladsp service started and running in background, instance 2
Aug 30 15:11:12 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:11:12 volumio-miro mpd[3425]: Aug 30 15:11 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 30 15:11:12 volumio-miro systemd[1]: Started Music Player Daemon.
Aug 30 15:11:12 volumio-miro volumio[1267]: No protocol specified
Aug 30 15:11:12 volumio-miro volumio[1267]: xcb_connection_has_error() returned true
Aug 30 15:11:12 volumio-miro volumio[1267]: cannot open device 'volumioHw': Device or resource busy
Aug 30 15:11:12 volumio-miro volumio[1267]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Aug 30 15:11:12 volumio-miro volumio[1267]: No protocol specified
Aug 30 15:11:12 volumio-miro volumio[1267]: xcb_connection_has_error() returned true
Aug 30 15:11:12 volumio-miro volumio[1267]: cannot open device 'volumioHw': Device or resource busy
Aug 30 15:11:12 volumio-miro sudo[3133]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:12 volumio-miro sudo[3228]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:12 volumio-miro sudo[3342]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp loaded
Aug 30 15:11:13 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 15:11:13 volumio-miro sudo[3465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - Reporting Fusion DSP Enabled
Aug 30 15:11:13 volumio-miro volumio[1267]: info: Adding Signal Path Element [object Object]
Aug 30 15:11:13 volumio-miro volumio[1267]: info: Adding fusiondspeq DSP Signal Path Element
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - ---- installed callbackRead
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - ---- read samplerate from file: 44100
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - crossfeed bauer
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Aug 30 15:11:13 volumio-miro sudo[3465]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - ---- read samplerate from file: 44100
Aug 30 15:11:13 volumio-miro volumio[1267]: info: camilladsp stopping service pid 3444...
Aug 30 15:11:13 volumio-miro volumio[1267]: info: camilladsp service terminated, instance 2
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - crossfeed bauer
Aug 30 15:11:13 volumio-miro volumio[1267]: info: camilladsp service started and running in background, instance 2
Aug 30 15:11:13 volumio-miro systemd[1]: Started FusionDsp Daemon.
Aug 30 15:11:13 volumio-miro sudo[3465]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Aug 30 15:11:13 volumio-miro volumio[1267]: info: FusionDsp - crossfeed bauer
Aug 30 15:11:13 volumio-miro volumio[1267]: error: FusionDsp - WebSocket error: [object Object]
Aug 30 15:11:13 volumio-miro volumio[1267]: error: MPD error: The expression evaluated to a falsy value:
Aug 30 15:11:13 volumio-miro volumio[1267]: assert.ok(self.idling)
Aug 30 15:11:13 volumio-miro volumio[1267]: error: The expression evaluated to a falsy value:
Aug 30 15:11:13 volumio-miro volumio[1267]: assert.ok(self.idling)
Aug 30 15:11:13 volumio-miro volumio[1267]: error: MPD error: The expression evaluated to a falsy value:
Aug 30 15:11:13 volumio-miro volumio[1267]: assert.ok(self.idling)
Aug 30 15:11:13 volumio-miro volumio[1267]: error: The expression evaluated to a falsy value:
Aug 30 15:11:13 volumio-miro volumio[1267]: assert.ok(self.idling)
Aug 30 15:11:13 volumio-miro volumio[1267]: error: FusionDsp - WebSocket error: [object Object]
Aug 30 15:11:13 volumio-miro volumio[1267]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11
Aug 30 15:11:13 volumio-miro volumio[1267]: error: updateQueue error: null
Aug 30 15:11:13 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:13 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:13 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:13 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:13 volumio-miro volumio[1267]: info: TidalConnect service stoped!
Aug 30 15:11:14 volumio-miro volumio[1267]: info: TidalConnect service stoped!
Aug 30 15:11:14 volumio-miro volumio[1267]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Aug 30 15:11:14 volumio-miro volumio[1267]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Aug 30 15:11:14 volumio-miro sudo[3493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Aug 30 15:11:14 volumio-miro sudo[3493]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:14 volumio-miro systemd[1]: Started Volumio Tidal Connect Service.
Aug 30 15:11:14 volumio-miro sudo[3493]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:14 volumio-miro volumio[1267]: info: Executing endpoint tc_getconfig
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Aug 30 15:11:14 volumio-miro vtcs[3499]: STARTING TidalConnect services, version: 1.5.1-beta1
Aug 30 15:11:14 volumio-miro vtcs[3499]: STARTED TidalConnect services.
Aug 30 15:11:14 volumio-miro volumio[1267]: info: Executing endpoint tc_connect
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Aug 30 15:11:14 volumio-miro volumio[1267]: info: Connecting to TidalConnect
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreCommandRouter::servicePushState
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreStateMachine::pushState
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioPushState
Aug 30 15:11:14 volumio-miro volumio[1267]: info: MRS: Pushing multiroomSync output update for this device
Aug 30 15:11:14 volumio-miro volumio[1267]: info: MRS: Pushing multiroomSync output
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:14 volumio-miro volumio[1267]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received tidalconnect
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreCommandRouter::servicePushState
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreStateMachine::pushState
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioPushState
Aug 30 15:11:14 volumio-miro volumio[1267]: info: MRS: Pushing multiroomSync output update for this device
Aug 30 15:11:14 volumio-miro volumio[1267]: info: MRS: Pushing multiroomSync output
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:14 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:11:14 volumio-miro volumio[1267]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received tidalconnect
Aug 30 15:11:14 volumio-miro volumio[1267]: info: TidalConnect service stoped!
Aug 30 15:11:14 volumio-miro volumio[1267]: info: TidalConnect service stoped!
Aug 30 15:11:14 volumio-miro volumio[1267]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Aug 30 15:11:14 volumio-miro volumio[1267]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Aug 30 15:11:14 volumio-miro sudo[3530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Aug 30 15:11:14 volumio-miro sudo[3530]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:14 volumio-miro sudo[3530]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:14 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:14 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:14 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:14 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:14 volumio-miro volumio[1267]: info: TidalConnect service stoped!
Aug 30 15:11:14 volumio-miro volumio[1267]: info: TidalConnect service stoped!
Aug 30 15:11:15 volumio-miro volumio[1267]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Aug 30 15:11:15 volumio-miro volumio[1267]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Aug 30 15:11:15 volumio-miro sudo[3549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Aug 30 15:11:15 volumio-miro sudo[3549]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:15 volumio-miro sudo[3549]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:15 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:15 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:15 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:15 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:16 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:16 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:16 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:16 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:17 volumio-miro volumio[1267]: info: TidalConnect service started!
Aug 30 15:11:17 volumio-miro volumio[1267]: info: TidalConnect service started!
Aug 30 15:11:17 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:17 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:17 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:17 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:18 volumio-miro volumio[1267]: info: TidalConnect service started!
Aug 30 15:11:18 volumio-miro volumio[1267]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 15:11:18 volumio-miro volumio[1267]: info: FusionDsp - no preset used
Aug 30 15:11:18 volumio-miro volumio[1267]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,.json
Aug 30 15:11:18 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:18 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:18 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:18 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:19 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:19 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:19 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:19 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:20 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:20 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:20 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:20 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:21 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:21 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:21 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:21 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:22 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:22 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:22 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:22 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:23 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:23 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:23 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:23 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:24 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:24 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:24 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:24 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:25 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:25 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:25 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:25 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:25 volumio-miro go-librespot[1748]: time="2025-08-30T15:11:25+02:00" level=trace msg="sent dealer ping"
Aug 30 15:11:25 volumio-miro go-librespot[1748]: time="2025-08-30T15:11:25+02:00" level=trace msg="received dealer pong"
Aug 30 15:11:26 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:26 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:26 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:26 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:27 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:27 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:27 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:27 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:28 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:28 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:28 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:28 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:29 volumio-miro volumiologrotate[562]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Aug 30 15:11:29 volumio-miro volumiologrotate[562]: ls: cannot access 'MIRO': No such file or directory
Aug 30 15:11:29 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:29 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:29 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:29 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:30 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:30 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:30 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:30 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:31 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:31 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:31 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:31 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:32 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:32 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:32 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:32 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:33 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:33 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:33 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:33 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:34 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:34 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:34 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:34 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:35 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:35 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:35 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:35 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:36 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:36 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:36 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:36 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:37 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:37 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:37 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:37 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:38 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:38 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:38 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:38 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:39 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:39 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:39 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:39 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:40 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:40 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:40 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:40 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:41 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:41 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:41 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:41 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:41 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 15:11:41 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 30 15:11:42 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:42 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:42 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:42 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:43 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:43 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:43 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:43 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:44 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:44 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:44 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:44 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:45 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:45 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:45 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:45 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:46 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:46 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:46 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:46 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:47 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:47 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:47 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:47 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:48 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:48 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:48 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:48 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:49 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:49 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:49 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:49 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:50 volumio-miro volumio[1267]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Aug 30 15:11:50 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:50 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:50 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:50 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:51 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:51 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:51 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:51 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:52 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:52 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:52 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:52 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:52 volumio-miro volumio[1267]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Aug 30 15:11:52 volumio-miro volumio[1267]: info: FusionDsp - Stopping FusionDsp service
Aug 30 15:11:52 volumio-miro volumio[1267]: info: camilladsp stopping service pid 3477...
Aug 30 15:11:52 volumio-miro volumio[1267]: info: camilladsp service terminated, instance 2
Aug 30 15:11:52 volumio-miro sudo[3671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service
Aug 30 15:11:52 volumio-miro sudo[3671]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:52 volumio-miro volumio[3473]: Backend configuration:
Aug 30 15:11:52 volumio-miro volumio[3473]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
Aug 30 15:11:52 volumio-miro volumio[3473]: active_config_txt: null
Aug 30 15:11:52 volumio-miro volumio[3473]: camilla_host: 127.0.0.1
Aug 30 15:11:52 volumio-miro volumio[3473]: camilla_port: 9876
Aug 30 15:11:52 volumio-miro volumio[3473]: coeff_dir: /data/INTERNAL/FusionDsp/filters
Aug 30 15:11:52 volumio-miro volumio[3473]: config_dir: /data/configuration/audio_interface/fusiondsp
Aug 30 15:11:52 volumio-miro volumio[3473]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
Aug 30 15:11:52 volumio-miro volumio[3473]: log_file: /tmp/camilladsp.log
Aug 30 15:11:52 volumio-miro volumio[3473]: on_get_active_config: null
Aug 30 15:11:52 volumio-miro volumio[3473]: on_set_active_config: null
Aug 30 15:11:52 volumio-miro volumio[3473]: port: 5011
Aug 30 15:11:52 volumio-miro volumio[3473]: supported_capture_types: null
Aug 30 15:11:52 volumio-miro volumio[3473]: supported_playback_types: null
Aug 30 15:11:52 volumio-miro volumio[3473]: update_config_symlink: false
Aug 30 15:11:52 volumio-miro volumio[3473]: update_config_txt: false
Aug 30 15:11:52 volumio-miro volumio[3473]: ======== Running on http://0.0.0.0:5011 ========
Aug 30 15:11:52 volumio-miro volumio[3473]: (Press CTRL+C to quit)
Aug 30 15:11:52 volumio-miro systemd[1]: Stopping FusionDsp Daemon...
Aug 30 15:11:52 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:11:53 volumio-miro systemd[1]: fusiondsp.service: Succeeded.
Aug 30 15:11:53 volumio-miro systemd[1]: Stopped FusionDsp Daemon.
Aug 30 15:11:53 volumio-miro sudo[3671]: pam_unix(sudo:session): session closed for user root
Aug 30 15:11:53 volumio-miro volumio[1267]: info: FusionDsp - Reporting Fusion DSP Disabled
Aug 30 15:11:53 volumio-miro volumio[1267]: info: Removing fusiondspeq DSP Signal Path Element
Aug 30 15:11:53 volumio-miro volumio[1267]: info: Check plugin dependencies
Aug 30 15:11:53 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 30 15:11:53 volumio-miro volumio[1267]: info: Rename folder
Aug 30 15:11:53 volumio-miro volumio[1267]: info: Folder /tmp/downloaded_plugin.zip removed
Aug 30 15:11:53 volumio-miro volumio[1267]: info: Move to category
Aug 30 15:11:53 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:53 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:53 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:53 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:54 volumio-miro volumio[1267]: info: Checking if install.sh is present
Aug 30 15:11:54 volumio-miro volumio[1267]: info: Executing install.sh
Aug 30 15:11:54 volumio-miro sudo[3692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh
Aug 30 15:11:54 volumio-miro sudo[3692]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:54 volumio-miro volumio[1267]: info: creating filters folder and copying demo filters
Aug 30 15:11:54 volumio-miro volumio[1267]: info: copying demo flters
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/2XEQ15/
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/2XEQ15/.Bass-FusionDsp.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json
Aug 30 15:11:54 volumio-miro sudo[3722]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update
Aug 30 15:11:54 volumio-miro sudo[3722]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/2XEQ15/.Classic-FusionDsp.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/2XEQ15/.Voice-FusionDsp.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/2XEQ15/.Rock-FusionDsp.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/PEQ/
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/convfir/
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/convfir/kef.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/convfir/test.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/EQ15/
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/EQ15/.Bass-FusionDsp.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/EQ15/.Classic-FusionDsp.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/EQ15/.Voice-FusionDsp.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: ./presets/EQ15/.Rock-FusionDsp.json
Aug 30 15:11:54 volumio-miro volumio[1267]: info: Installing/fusiondsp dependencies
Aug 30 15:11:54 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:54 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:54 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:54 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:54 volumio-miro volumio[1267]: info: Hit:1 http://archive.debian.org/debian buster InRelease
Aug 30 15:11:55 volumio-miro volumio[1267]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease
Aug 30 15:11:55 volumio-miro go-librespot[1748]: time="2025-08-30T15:11:55+02:00" level=trace msg="received accesspoint ping"
Aug 30 15:11:55 volumio-miro go-librespot[1748]: time="2025-08-30T15:11:55+02:00" level=trace msg="received accesspoint pong ack"
Aug 30 15:11:55 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:55 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:55 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:55 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:55 volumio-miro go-librespot[1748]: time="2025-08-30T15:11:55+02:00" level=trace msg="sent dealer ping"
Aug 30 15:11:55 volumio-miro go-librespot[1748]: time="2025-08-30T15:11:55+02:00" level=trace msg="received dealer pong"
Aug 30 15:11:56 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:56 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:56 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:56 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:57 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:57 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:57 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:57 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:58 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:58 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:58 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:58 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:59 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:59 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:11:59 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:11:59 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:00 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:00 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:00 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:00 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:00 volumio-miro volumio[1267]: info: Reading package lists...
Aug 30 15:12:01 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:01 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:01 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:01 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:01 volumio-miro volumio[1267]: info: Building dependency tree...
Aug 30 15:12:01 volumio-miro volumio[1267]: info: Reading state information...
Aug 30 15:12:02 volumio-miro volumio[1267]: info: All packages are up to date.
Aug 30 15:12:02 volumio-miro sudo[3722]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:02 volumio-miro sudo[3971]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip
Aug 30 15:12:02 volumio-miro sudo[3971]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:02 volumio-miro volumio[1267]: info: Reading package lists...
Aug 30 15:12:02 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:02 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:02 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:02 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:03 volumio-miro volumio[1267]: info: Building dependency tree...
Aug 30 15:12:03 volumio-miro volumio[1267]: info: Reading state information...
Aug 30 15:12:03 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:03 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:03 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:03 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:04 volumio-miro volumio[1267]: info: python3-aiohttp is already the newest version (3.5.1-1+deb10u1).
Aug 30 15:12:04 volumio-miro sudo[3971]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:04 volumio-miro volumio[1267]: info: python3-pip is already the newest version (18.1-5).
Aug 30 15:12:04 volumio-miro volumio[1267]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
Aug 30 15:12:04 volumio-miro sudo[3982]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C /
Aug 30 15:12:04 volumio-miro sudo[3982]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:04 volumio-miro volumio[1267]: info: lib/systemd/system/fusiondsp.service
Aug 30 15:12:04 volumio-miro sudo[3982]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:04 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:04 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:04 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:04 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:05 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:05 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:05 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:05 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:06 volumio-miro volumio[1267]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant
Aug 30 15:12:06 volumio-miro volumio[1267]: info: more info at http://www.winimage.com/zLibDll/unzip.html
Aug 30 15:12:06 volumio-miro volumio[1267]: info:
Aug 30 15:12:06 volumio-miro volumio[1267]: info: cgui-1.0.0.zip opened
Aug 30 15:12:06 volumio-miro sudo[3993]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui
Aug 30 15:12:06 volumio-miro volumio[1267]: info: creating directory: cgui/
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/LICENSE.txt
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/README.md
Aug 30 15:12:06 volumio-miro volumio[1267]: info: creating directory: cgui/build/
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/robots.txt
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/logo512.png
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/asset-manifest.json
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/index.html
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/.put_statics_here
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/favicon.ico
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/logo192.png
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX
Aug 30 15:12:06 volumio-miro sudo[3993]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/manifest.json
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/css-variables.css
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/service-worker.js
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js
Aug 30 15:12:06 volumio-miro sudo[3993]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:06 volumio-miro volumio[1267]: info: creating directory: cgui/build/static/
Aug 30 15:12:06 volumio-miro volumio[1267]: info: creating directory: cgui/build/static/css/
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/main.1503f6cd.css
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css
Aug 30 15:12:06 volumio-miro volumio[1267]: info: creating directory: cgui/build/static/media/
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg
Aug 30 15:12:06 volumio-miro volumio[1267]: info: creating directory: cgui/build/static/js/
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/main.71e11955.js
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/main.71e11955.js.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map
Aug 30 15:12:06 volumio-miro sudo[4002]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt
Aug 30 15:12:06 volumio-miro volumio[1267]: info: creating directory: cgui/config/
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/config/camillagui.yml
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/config/gui-config.yml
Aug 30 15:12:06 volumio-miro volumio[1267]: info: creating directory: cgui/backend/
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/filters_test.py
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/version.py
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/filters.py
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/settings.py
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/views.py
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/filterdefaults.py
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/__init__.py
Aug 30 15:12:06 volumio-miro sudo[4002]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:06 volumio-miro volumio[1267]: info: creating directory: cgui/backend/__pycache__/
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/routes.py
Aug 30 15:12:06 volumio-miro sudo[4002]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/backend/filemanagement.py
Aug 30 15:12:06 volumio-miro volumio[1267]: info: extracting: cgui/main.py
Aug 30 15:12:06 volumio-miro sudo[4011]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip
Aug 30 15:12:06 volumio-miro sudo[4011]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:06 volumio-miro sudo[4011]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:06 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:06 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:06 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:06 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:07 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:07 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:07 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:07 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:08 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:08 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:08 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:08 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:09 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:09 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:09 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:09 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:10 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:10 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:10 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:10 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:11 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:11 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:11 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:11 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:11 volumio-miro volumio[1267]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0
Aug 30 15:12:12 volumio-miro volumio[1267]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-e5esakdn
Aug 30 15:12:12 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:12 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:12 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:12 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:13 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:13 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:13 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:13 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:13 volumio-miro volumio[1267]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp==1.0.0 from git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 in /usr/local/lib/python3.7/dist-packages
Aug 30 15:12:13 volumio-miro volumio[1267]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (6.0.1)
Aug 30 15:12:14 volumio-miro volumio[1267]: info: Requirement already satisfied: websocket_client in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (1.6.1)
Aug 30 15:12:14 volumio-miro volumio[1267]: info: Building wheels for collected packages: camilladsp
Aug 30 15:12:14 volumio-miro volumio[1267]: info: Running setup.py bdist_wheel for camilladsp: started
Aug 30 15:12:14 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:14 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:14 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:14 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:14 volumio-miro volumio[1267]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done'
Aug 30 15:12:14 volumio-miro volumio[1267]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-ytpwfx44/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6
Aug 30 15:12:14 volumio-miro volumio[1267]: info: Successfully built camilladsp
Aug 30 15:12:15 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:15 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:15 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:15 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:16 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:16 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:16 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:16 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:17 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:17 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:17 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:17 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:18 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:18 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:18 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:18 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:19 volumio-miro volumio[1267]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2
Aug 30 15:12:19 volumio-miro volumio[1267]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-d1o36xlw
Aug 30 15:12:19 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:19 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:19 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:19 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:20 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:20 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:20 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:20 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:20 volumio-miro volumio[1267]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp-plot==1.0.2 from git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 in /usr/local/lib/python3.7/dist-packages
Aug 30 15:12:20 volumio-miro volumio[1267]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1)
Aug 30 15:12:20 volumio-miro volumio[1267]: info: Requirement already satisfied: jsonschema in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (4.17.3)
Aug 30 15:12:20 volumio-miro volumio[1267]: info: Requirement already satisfied: importlib-resources>=1.4.0; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (5.12.0)
Aug 30 15:12:21 volumio-miro volumio[1267]: info: Requirement already satisfied: pkgutil-resolve-name>=1.3.10; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (1.3.10)
Aug 30 15:12:21 volumio-miro volumio[1267]: info: Requirement already satisfied: importlib-metadata; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (6.7.0)
Aug 30 15:12:21 volumio-miro volumio[1267]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0)
Aug 30 15:12:21 volumio-miro volumio[1267]: info: Requirement already satisfied: typing-extensions; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (4.7.1)
Aug 30 15:12:21 volumio-miro volumio[1267]: info: Requirement already satisfied: pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (0.19.3)
Aug 30 15:12:21 volumio-miro volumio[1267]: info: Requirement already satisfied: zipp>=3.1.0; python_version < "3.10" in /usr/local/lib/python3.7/dist-packages (from importlib-resources>=1.4.0; python_version < "3.9"->jsonschema->camilladsp-plot==1.0.2) (3.15.0)
Aug 30 15:12:21 volumio-miro volumio[1267]: info: Building wheels for collected packages: camilladsp-plot
Aug 30 15:12:21 volumio-miro volumio[1267]: info: Running setup.py bdist_wheel for camilladsp-plot: started
Aug 30 15:12:21 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:21 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:21 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:21 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:22 volumio-miro volumio[1267]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done'
Aug 30 15:12:22 volumio-miro volumio[1267]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-s4zdhe44/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9
Aug 30 15:12:22 volumio-miro volumio[1267]: info: Successfully built camilladsp-plot
Aug 30 15:12:22 volumio-miro volumio[1267]: info: copying hw detection script
Aug 30 15:12:22 volumio-miro volumio[1267]: info: Detected cpu architecture as armv7l
Aug 30 15:12:22 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:22 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:22 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:22 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:23 volumio-miro sudo[4111]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params
Aug 30 15:12:23 volumio-miro sudo[4111]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:23 volumio-miro sudo[4111]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:23 volumio-miro sudo[4120]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params
Aug 30 15:12:23 volumio-miro sudo[4120]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:23 volumio-miro sudo[4120]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:23 volumio-miro sudo[4129]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc
Aug 30 15:12:23 volumio-miro sudo[4129]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:23 volumio-miro volumio[1267]: info: Reading package lists...
Aug 30 15:12:23 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:23 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:23 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:23 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:24 volumio-miro volumio[1267]: info: Building dependency tree...
Aug 30 15:12:24 volumio-miro volumio[1267]: info: Reading state information...
Aug 30 15:12:24 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:24 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:24 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:24 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:25 volumio-miro volumio[1267]: info: drc is already the newest version (3.2.2~dfsg0-2).
Aug 30 15:12:25 volumio-miro sudo[4129]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:25 volumio-miro volumio[1267]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
Aug 30 15:12:25 volumio-miro sudo[3692]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:25 volumio-miro volumio[1267]: Plugin install end detected on script
Aug 30 15:12:25 volumio-miro volumio[1267]: info: Install script completed
Aug 30 15:12:25 volumio-miro volumio[1267]: info: Done installing plugin.
Aug 30 15:12:25 volumio-miro volumio[1267]: info: Enabling plugin fusiondsp
Aug 30 15:12:25 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 15:12:25 volumio-miro volumio[1267]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.61","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.2.2","icon":"fa-spotify","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":"Audiophonics Evo Sabre","name":"audiophonics_evo_sabre","category":"system_hardware","version":"1.0.0","icon":"fa-hdd-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Volumio Onkyo Control","name":"onkyo_control","category":"system_hardware","version":"1.1.2","icon":"fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true}]
Aug 30 15:12:25 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 30 15:12:25 volumio-miro volumio[1267]: info: Folder /tmp/plugins removed
Aug 30 15:12:25 volumio-miro volumio[1267]: info: Folder /tmp/downloaded_plugin.zip removed
Aug 30 15:12:25 volumio-miro volumio[1267]: info: Folder /data/temp removed
Aug 30 15:12:25 volumio-miro go-librespot[1748]: time="2025-08-30T15:12:25+02:00" level=trace msg="sent dealer ping"
Aug 30 15:12:25 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:25 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:25 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:25 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:25 volumio-miro go-librespot[1748]: time="2025-08-30T15:12:25+02:00" level=trace msg="received dealer pong"
Aug 30 15:12:26 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:26 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:26 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:26 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:27 volumio-miro volumio[1267]: info: MRS: Found cast device: Onkyo-TX-RZ3400-182e0856e2764fe8aa07c3598a981577
Aug 30 15:12:27 volumio-miro volumio[1267]: info: MRS: Found cast device: Onkyo-TX-RZ3400-182e0856e2764fe8aa07c3598a981577
Aug 30 15:12:27 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:27 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:27 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:27 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:28 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:28 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:28 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:28 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:29 volumio-miro volumiologrotate[562]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Aug 30 15:12:29 volumio-miro volumiologrotate[562]: ls: cannot access 'MIRO': No such file or directory
Aug 30 15:12:29 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:29 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:29 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:29 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:30 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:30 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:30 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:30 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:31 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:31 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:31 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:31 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:32 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:32 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:32 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:32 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:33 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:33 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:33 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:33 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:34 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:34 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:34 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:34 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:35 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:35 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:35 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:35 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:36 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:36 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:36 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:36 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:37 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:37 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:37 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:37 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:38 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:38 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:38 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:38 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:39 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:39 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:39 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:39 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:40 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:40 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:40 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:40 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:41 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:41 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:41 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:41 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:42 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:42 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:42 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:42 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:43 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:43 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:43 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:43 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:44 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:44 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:44 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:44 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:45 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:45 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:45 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:45 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Enabling plugin fusiondsp
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Loading plugin "fusiondsp"...
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Applying required configuration parameters for plugin fusiondsp
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Preparing to generate the ALSA configuration file
Aug 30 15:12:46 volumio-miro volumio[1267]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Aug 30 15:12:46 volumio-miro volumio[1267]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Reading ALSA contributions from plugins.
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Asound.conf file unchanged, so no further update is needed
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Output device has changed, restarting MPD
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Output device has changed, restarting Shairport Sync
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:46 volumio-miro sudo[4222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 30 15:12:46 volumio-miro sudo[4224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 30 15:12:46 volumio-miro sudo[4222]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro sudo[4224]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro sudo[4222]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro volumio[1267]: No protocol specified
Aug 30 15:12:46 volumio-miro volumio[1267]: xcb_connection_has_error() returned true
Aug 30 15:12:46 volumio-miro volumio[1267]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro systemd[1]: Stopping Music Player Daemon...
Aug 30 15:12:46 volumio-miro volumio[1267]: info: QobuzConnect: setDeactiveState invoked
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:46 volumio-miro vtcs[3499]: [2025-08-30 15:12:46.159] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE
Aug 30 15:12:46 volumio-miro vtcs[3499]: [2025-08-30 15:12:46.160] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected
Aug 30 15:12:46 volumio-miro volumio[1267]: info: PLUGIN START: fusiondsp
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Loading i18n strings for locale pl
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored.
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: FusionDsp - mixtype--------------------- None
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Preparing to generate the ALSA configuration file
Aug 30 15:12:46 volumio-miro sudo[4245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:12:46 volumio-miro sudo[4245]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Done.
Aug 30 15:12:46 volumio-miro systemd[1]: mpd.service: Succeeded.
Aug 30 15:12:46 volumio-miro systemd[1]: Stopped Music Player Daemon.
Aug 30 15:12:46 volumio-miro systemd[1]: Stopping Volumio Tidal Connect Service...
Aug 30 15:12:46 volumio-miro systemd[1]: Starting Music Player Daemon...
Aug 30 15:12:46 volumio-miro systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Aug 30 15:12:46 volumio-miro systemd[1]: vtcs.service: Succeeded.
Aug 30 15:12:46 volumio-miro systemd[1]: Stopped Volumio Tidal Connect Service.
Aug 30 15:12:46 volumio-miro sudo[4252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:12:46 volumio-miro sudo[4245]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro sudo[4252]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro volumio[1267]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Aug 30 15:12:46 volumio-miro volumio[1267]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Reading ALSA contributions from plugins.
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:12:46 volumio-miro sudo[4265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Aug 30 15:12:46 volumio-miro sudo[4265]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro sudo[4252]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro volumio[1267]: info: MPD Permissions set
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro sudo[4265]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Aug 30 15:12:46 volumio-miro sudo[4253]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 30 15:12:46 volumio-miro sudo[4253]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro sudo[4253]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro sudo[4288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Starting Shairport Sync
Aug 30 15:12:46 volumio-miro sudo[4288]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Asound.conf file unchanged, so no further update is needed
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Output device has changed, restarting MPD
Aug 30 15:12:46 volumio-miro qobuz-connect[3426]: 20250830 15:12:46.417 [3426.3426] INFO SampleApp: Stopping Local configuration server
Aug 30 15:12:46 volumio-miro systemd[1]: Stopping Volumio Qobuz Connect Service...
Aug 30 15:12:46 volumio-miro sudo[4301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 30 15:12:46 volumio-miro qobuz-connect[3426]: 20250830 15:12:46.427 [3426.3426] INFO SampleApp: shat down connection on UNIX socket
Aug 30 15:12:46 volumio-miro volumio[1267]: info: Output device has changed, restarting Shairport Sync
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro systemd[1]: qobuz-connect.service: Succeeded.
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:46 volumio-miro systemd[1]: Stopped Volumio Qobuz Connect Service.
Aug 30 15:12:46 volumio-miro sudo[4301]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro sudo[4303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 30 15:12:46 volumio-miro systemd[1]: Started Volumio Qobuz Connect Service.
Aug 30 15:12:46 volumio-miro sudo[4288]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro sudo[4309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 30 15:12:46 volumio-miro sudo[4303]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro sudo[4303]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro volumio[1267]: No protocol specified
Aug 30 15:12:46 volumio-miro volumio[1267]: xcb_connection_has_error() returned true
Aug 30 15:12:46 volumio-miro volumio[1267]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:46 volumio-miro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 30 15:12:46 volumio-miro sudo[4309]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro systemd[1]: shairport-sync.service: Succeeded.
Aug 30 15:12:46 volumio-miro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 30 15:12:46 volumio-miro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 30 15:12:46 volumio-miro sudo[4301]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro volumio[1267]: info: QobuzConnect: setDeactiveState invoked
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CoreCommandRouter::volumioGetState
Aug 30 15:12:46 volumio-miro volumio[1267]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:46 volumio-miro sudo[4341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:12:46 volumio-miro systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Aug 30 15:12:46 volumio-miro systemd[1]: mpd.service: Succeeded.
Aug 30 15:12:46 volumio-miro systemd[1]: Stopped Music Player Daemon.
Aug 30 15:12:46 volumio-miro sudo[4341]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro systemd[1]: Starting Music Player Daemon...
Aug 30 15:12:46 volumio-miro sudo[4349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:12:46 volumio-miro sudo[4341]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro sudo[4349]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 30 15:12:46 volumio-miro volumio[1267]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 30 15:12:46 volumio-miro sudo[4361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Aug 30 15:12:46 volumio-miro volumio[1267]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 15:12:46 volumio-miro volumio[1267]: TypeError: Cannot read property 'off' of undefined
Aug 30 15:12:46 volumio-miro volumio[1267]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15)
Aug 30 15:12:46 volumio-miro volumio[1267]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Aug 30 15:12:46 volumio-miro volumio[1267]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8)
Aug 30 15:12:46 volumio-miro volumio[1267]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29)
Aug 30 15:12:46 volumio-miro volumio[1267]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47)
Aug 30 15:12:46 volumio-miro volumio[1267]: at Socket.emit (events.js:400:28)
Aug 30 15:12:46 volumio-miro volumio[1267]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Aug 30 15:12:46 volumio-miro volumio[1267]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Aug 30 15:12:46 volumio-miro volumio[1267]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 15:12:46 volumio-miro sudo[4349]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro sudo[4361]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro sudo[4361]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro sudo[4351]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 30 15:12:46 volumio-miro sudo[4351]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro sudo[4387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Aug 30 15:12:46 volumio-miro sudo[4351]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro sudo[4387]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:46 volumio-miro systemd[1]: Stopping Volumio Qobuz Connect Service...
Aug 30 15:12:46 volumio-miro systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT
Aug 30 15:12:46 volumio-miro systemd[1]: qobuz-connect.service: Succeeded.
Aug 30 15:12:46 volumio-miro systemd[1]: Stopped Volumio Qobuz Connect Service.
Aug 30 15:12:46 volumio-miro systemd[1]: Started Volumio Qobuz Connect Service.
Aug 30 15:12:46 volumio-miro sudo[4387]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:46 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:46 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:46 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:46 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:47 volumio-miro sudo[4408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 15:11
Aug 30 15:12:47 volumio-miro sudo[4408]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:47 volumio-miro sudo[4408]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:47 volumio-miro volumio-remote-updater[553]: [2025-08-30 15:12:47] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Aug 30 15:12:47 volumio-miro volumio-remote-updater[553]: [2025-08-30 15:12:47] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Aug 30 15:12:47 volumio-miro go-librespot[1748]: time="2025-08-30T15:12:47+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF"
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: Error: Application ID was not specified!
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...]
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -m|--manufacturer: Manufacturer of the device
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -n|--deviceName: Device name
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -l|--model: Device's model name
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -s|--serialNumber: Device's serial number
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -o|--outputDevice: ALSA PCM device to play audio to
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -p|--port: Port to run the local configuration HTTP server on
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3]
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control
Aug 30 15:12:47 volumio-miro qobuz-connect[4401]: -h|--help: Print this help
Aug 30 15:12:47 volumio-miro systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE
Aug 30 15:12:47 volumio-miro systemd[1]: qobuz-connect.service: Failed with result 'exit-code'.
Aug 30 15:12:47 volumio-miro systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Aug 30 15:12:47 volumio-miro sudo[4224]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:47 volumio-miro sudo[4309]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:47 volumio-miro systemd[1]: volumio.service: Failed with result 'exit-code'.
Aug 30 15:12:47 volumio-miro systemd[1]: Started dynamicswap service.
Aug 30 15:12:47 volumio-miro systemd[1]: dynamicswap.service: Succeeded.
Aug 30 15:12:47 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:47 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:47 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:47 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:47 volumio-miro systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Aug 30 15:12:47 volumio-miro systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Aug 30 15:12:47 volumio-miro systemd[1]: Started dynamicswap service.
Aug 30 15:12:47 volumio-miro systemd[1]: Stopped Volumio Backend Module.
Aug 30 15:12:47 volumio-miro systemd[1]: Started Volumio Backend Module.
Aug 30 15:12:47 volumio-miro systemd[1]: dynamicswap.service: Succeeded.
Aug 30 15:12:48 volumio-miro mpd[4405]: Aug 30 15:12 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 30 15:12:48 volumio-miro systemd[1]: Started Music Player Daemon.
Aug 30 15:12:48 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:48 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:48 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:48 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:49 volumio-miro volumio[4449]: info: -------------------------------------------
Aug 30 15:12:49 volumio-miro volumio[4449]: info: ----- Volumio3 ----
Aug 30 15:12:49 volumio-miro volumio[4449]: info: -------------------------------------------
Aug 30 15:12:49 volumio-miro volumio[4449]: info: ----- System startup ----
Aug 30 15:12:49 volumio-miro volumio[4449]: info: -------------------------------------------
Aug 30 15:12:49 volumio-miro volumio[4449]: info: MYVOLUMIO Environment detected
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Plugin folders cleanup
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning into folder /volumio/app/plugins/
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category audio_interface
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category miscellanea
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category music_service
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category plugins.json
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category system_controller
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category user_interface
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning into folder /data/plugins/
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category audio_interface
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category music_service
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category system_controller
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Scanning category system_hardware
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Plugin folders cleanup completed
Aug 30 15:12:49 volumio-miro volumio[4449]: info: -------------------------------------------
Aug 30 15:12:49 volumio-miro volumio[4449]: info: ----- Core plugins startup ----
Aug 30 15:12:49 volumio-miro volumio[4449]: info: -------------------------------------------
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Loading plugins from folder /volumio/app/plugins/
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Adding plugin upnp to MyMusic Plugins
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Adding plugin airplay_emulation to MyMusic Plugins
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Adding plugin upnp_browser to MyMusic Plugins
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Loading plugins from folder /data/plugins/
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Loading plugin "system"...
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Loading plugin "ampswitch"...
Aug 30 15:12:49 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:49 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:49 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:49 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:49 volumio-miro volumio[4449]: info: Applying required configuration parameters for plugin ampswitch
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "appearance"...
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "network"...
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Refreshing Cached IP Addresses
Aug 30 15:12:50 volumio-miro sudo[4478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 30 15:12:50 volumio-miro sudo[4478]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:50 volumio-miro sudo[4480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "services"...
Aug 30 15:12:50 volumio-miro sudo[4480]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "alsa_controller"...
Aug 30 15:12:50 volumio-miro sudo[4478]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:50 volumio-miro sudo[4480]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:50 volumio-miro sudo[4498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Aug 30 15:12:50 volumio-miro sudo[4498]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:50 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "wizard"...
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "networkfs"...
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Starting Udev Watcher for removable devices
Aug 30 15:12:50 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:50 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:50 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:50 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Ignoring mount for partition: BOOT
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Ignoring mount for partition: volumio
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Ignoring mount for partition: volumio_data
Aug 30 15:12:50 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "volumio_command_line_client"...
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "upnp"...
Aug 30 15:12:50 volumio-miro volumio[4449]: info: [1756559570913] Starting Upmpd Daemon
Aug 30 15:12:50 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "my_music"...
Aug 30 15:12:50 volumio-miro volumio[4449]: info: Loading plugin "mpd"...
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Loading plugin "upnp_browser"...
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Loading plugin "alarm-clock"...
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Loading plugin "airplay_emulation"...
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Starting Shairport Sync
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Loading plugin "last_100"...
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Loading plugin "webradio"...
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Loading plugin "i2s_dacs"...
Aug 30 15:12:51 volumio-miro volumio[4449]: info: I2S DAC not set, start Auto-detection
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Loading plugin "volumiodiscovery"...
Aug 30 15:12:51 volumio-miro volumio[4449]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Aug 30 15:12:51 volumio-miro node[4449]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Aug 30 15:12:51 volumio-miro volumio[4449]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 30 15:12:51 volumio-miro node[4449]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 30 15:12:51 volumio-miro volumio[4449]: *** WARNING *** For more information see
Aug 30 15:12:51 volumio-miro node[4449]: *** WARNING *** For more information see
Aug 30 15:12:51 volumio-miro volumio[4449]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Aug 30 15:12:51 volumio-miro node[4449]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Aug 30 15:12:51 volumio-miro volumio[4449]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 30 15:12:51 volumio-miro node[4449]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 30 15:12:51 volumio-miro volumio[4449]: *** WARNING *** For more information see
Aug 30 15:12:51 volumio-miro node[4449]: *** WARNING *** For more information see
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Applying required configuration parameters for plugin volumiodiscovery
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Discovery: Started advertising with name: Volumio Miro
Aug 30 15:12:51 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 30 15:12:51 volumio-miro volumio[4449]: info: Loading plugin "spop"...
Aug 30 15:12:51 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:51 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:51 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:51 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:52 volumio-miro sudo[4498]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Loading plugin "outputs"...
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Loading plugin "albumart"...
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Plugin example_plugin is not enabled
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Loading plugin "inputs"...
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Loading plugin "updater_comm"...
Aug 30 15:12:52 volumio-miro volumio-remote-updater[553]: [2025-08-30 15:12:52] [connect] Successful connection
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Plugin mpdemulation is not enabled
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Loading plugin "rest_api"...
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Loading plugin "websocket"...
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Starting Socket.io Server version 2.3.0
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Loading plugin "fusiondsp"...
Aug 30 15:12:52 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:52 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:52 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:52 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:52 volumio-miro systemd[1]: qobuz-connect.service: Service RestartSec=5s expired, scheduling restart.
Aug 30 15:12:52 volumio-miro systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 1.
Aug 30 15:12:52 volumio-miro systemd[1]: Stopped Volumio Qobuz Connect Service.
Aug 30 15:12:52 volumio-miro systemd[1]: Started Volumio Qobuz Connect Service.
Aug 30 15:12:52 volumio-miro volumio[4449]: Forking 3 albumart workers
Aug 30 15:12:52 volumio-miro volumio[4449]: info: Applying required configuration parameters for plugin fusiondsp
Aug 30 15:12:53 volumio-miro volumio[4449]: info: Loading plugin "audiophonics_evo_sabre"...
Aug 30 15:12:53 volumio-miro volumio[4449]: info: Applying required configuration parameters for plugin audiophonics_evo_sabre
Aug 30 15:12:53 volumio-miro volumio[4449]: info: Loading plugin "onkyo_control"...
Aug 30 15:12:53 volumio-miro volumio[4449]: info: Applying required configuration parameters for plugin onkyo_control
Aug 30 15:12:53 volumio-miro volumio[4449]: info: Loading i18n strings for locale pl
Aug 30 15:12:53 volumio-miro volumio[4449]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored.
Aug 30 15:12:53 volumio-miro volumio[4449]: Updating browse sources language
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 15:12:53 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:53 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:53 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:53 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:53 volumio-miro volumio[4449]: Starting albumart workers
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::initPlayerControls
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 30 15:12:53 volumio-miro volumio[4449]: Express server listening on port 3000
Aug 30 15:12:53 volumio-miro volumio[4449]: [Metrics] WebUI: 5s 143.79ms
Aug 30 15:12:53 volumio-miro volumio[4449]: Starting albumart workers
Aug 30 15:12:53 volumio-miro volumio[4449]: Starting albumart workers
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreStateMachine::resetVolumioState
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreStateMachine::getcurrentVolume
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioRetrievevolume
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreStateMachine::pushState
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioPushState
Aug 30 15:12:53 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:54 volumio-miro volumio[4449]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Aug 30 15:12:54 volumio-miro volumio[4449]: info: Completed loading Core Plugins
Aug 30 15:12:54 volumio-miro volumio[4449]: info: Preparing to generate the ALSA configuration file
Aug 30 15:12:54 volumio-miro volumio[4449]: info: Volumio Network Manager: Network status updated: 3
Aug 30 15:12:54 volumio-miro volumio[4449]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Aug 30 15:12:54 volumio-miro volumio[4449]: info: Reading ALSA contributions from plugins.
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.110 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.113 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.110 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 4
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.113 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.113 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.110 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.110 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.113 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Aug 30 15:12:54 volumio-miro volumio-remote-updater[553]: [2025-08-30 15:12:54] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1756559572 101
Aug 30 15:12:54 volumio-miro volumio[4449]: 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: 10
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.110 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Aug 30 15:12:54 volumio-miro volumio[4449]: info: No valid Plugin REST Endpoint
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: 20250830 15:12:54.379 [4541.4541] ERROR SampleApp: api request was not successful
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: Error: Application ID was not specified!
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...]
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -m|--manufacturer: Manufacturer of the device
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -n|--deviceName: Device name
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -l|--model: Device's model name
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -s|--serialNumber: Device's serial number
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -o|--outputDevice: ALSA PCM device to play audio to
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -p|--port: Port to run the local configuration HTTP server on
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3]
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control
Aug 30 15:12:54 volumio-miro qobuz-connect[4541]: -h|--help: Print this help
Aug 30 15:12:54 volumio-miro systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE
Aug 30 15:12:54 volumio-miro systemd[1]: qobuz-connect.service: Failed with result 'exit-code'.
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.113 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.110 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 192.168.68.113 from 192.168.68.103 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14
Aug 30 15:12:54 volumio-miro volumio[4449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15
Aug 30 15:12:54 volumio-miro volumio[4449]: info: Reloading queue from file
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CoreStateMachine::setRepeat null single undefined
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CoreStateMachine::pushState
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioPushState
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CoreStateMachine::setRandom null
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CoreStateMachine::pushState
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioPushState
Aug 30 15:12:54 volumio-miro volumio[4449]: info: Setting Device type: Tinkerboard
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioGetState
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:54 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 30 15:12:54 volumio-miro volumio[4449]: info: Listing playlists
Aug 30 15:12:54 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:54 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:54 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:54 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:55 volumio-miro volumio[4449]: info: Discovery: adding beeb6fb6-e4a3-4bbf-b656-f0a88814bb80
Aug 30 15:12:55 volumio-miro volumio[4449]: info: Discovery: Found device Volumio Miro
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioGetState
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:55 volumio-miro volumio[4449]: info: Discovery: this is already registered, beeb6fb6-e4a3-4bbf-b656-f0a88814bb80
Aug 30 15:12:55 volumio-miro volumio[4449]: info: Discovery: Found device Volumio Miro
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioGetState
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:55 volumio-miro volumio[4449]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 16
Aug 30 15:12:55 volumio-miro volumio[4449]: info: Asound.conf file written
Aug 30 15:12:55 volumio-miro sudo[4598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Aug 30 15:12:55 volumio-miro sudo[4598]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:55 volumio-miro sudo[4598]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:55 volumio-miro volumio[4449]: info: Output device has changed, restarting MPD
Aug 30 15:12:55 volumio-miro volumio[4449]: info: Output device has changed, restarting Shairport Sync
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:55 volumio-miro sudo[4610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 30 15:12:55 volumio-miro sudo[4613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 30 15:12:55 volumio-miro sudo[4610]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:55 volumio-miro sudo[4610]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:55 volumio-miro sudo[4613]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:55 volumio-miro volumio[4449]: info: ___________ START PLUGINS ___________
Aug 30 15:12:55 volumio-miro systemd[1]: Stopping Music Player Daemon...
Aug 30 15:12:55 volumio-miro volumio[4449]: info: ControllerMpd::onStart: Initializing MPD
Aug 30 15:12:55 volumio-miro kernel: rockchip-pinctrl pinctrl: pin 0 is unrouted
Aug 30 15:12:55 volumio-miro volumio[4449]: info: Creating MPD Configuration file
Aug 30 15:12:55 volumio-miro go-librespot[1748]: time="2025-08-30T15:12:55+02:00" level=trace msg="sent dealer ping"
Aug 30 15:12:55 volumio-miro systemd[1]: mpd.service: Succeeded.
Aug 30 15:12:55 volumio-miro systemd[1]: Stopped Music Player Daemon.
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 30 15:12:55 volumio-miro volumio[4449]: info: [1756559575864] CoreMusicLibrary::Adding element Serwery Mediów
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 15:12:55 volumio-miro sudo[4635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 30 15:12:55 volumio-miro systemd[1]: Starting Music Player Daemon...
Aug 30 15:12:55 volumio-miro go-librespot[1748]: time="2025-08-30T15:12:55+02:00" level=trace msg="received dealer pong"
Aug 30 15:12:55 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:55 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:55 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:55 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:55 volumio-miro sudo[4635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:55 volumio-miro sudo[4637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 30 15:12:55 volumio-miro sudo[4635]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:55 volumio-miro sudo[4637]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:55 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 30 15:12:56 volumio-miro volumio[4449]: info: [1756559576005] CoreMusicLibrary::Adding element Last_100
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 30 15:12:56 volumio-miro volumio[4449]: info: [1756559576009] CoreMusicLibrary::Adding element Webradio
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 15:12:56 volumio-miro systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Aug 30 15:12:56 volumio-miro systemd[1]: mpd.service: Succeeded.
Aug 30 15:12:56 volumio-miro systemd[1]: Stopped Music Player Daemon.
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 30 15:12:56 volumio-miro systemd[1]: Starting Music Player Daemon...
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Initializing BBC Radios
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Creating Spotify config file
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro sudo[4658]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 30 15:12:56 volumio-miro sudo[4658]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:56 volumio-miro sudo[4658]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Loading i18n strings for locale pl
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored.
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: FusionDsp - mixtype--------------------- None
Aug 30 15:12:56 volumio-miro volumio[4449]: info: EVO SABRE : Starting Plugin
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Loading i18n strings for locale pl
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored.
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Volumio Calling Home
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Preparing to generate the ALSA configuration file
Aug 30 15:12:56 volumio-miro volumio[4449]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Reading ALSA contributions from plugins.
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioGetState
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::volumioGetState
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CorePlayQueue::getTrack 0
Aug 30 15:12:56 volumio-miro volumio[4449]: info: [ASDebug] CurState: stop PrevState: na
Aug 30 15:12:56 volumio-miro volumio[4449]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Aug 30 15:12:56 volumio-miro volumio[4449]: info: [ASDebug] CurState: stop PrevState: na
Aug 30 15:12:56 volumio-miro volumio[4449]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Volumio called home
Aug 30 15:12:56 volumio-miro volumio[4449]: info: MPD Permissions set
Aug 30 15:12:56 volumio-miro volumio[4449]: info: MPD Permissions set
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Listing playlists
Aug 30 15:12:56 volumio-miro sudo[4684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Aug 30 15:12:56 volumio-miro volumio[4449]: info: Spotify config file written
Aug 30 15:12:56 volumio-miro sudo[4684]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:56 volumio-miro systemd[1]: Reloading.
Aug 30 15:12:56 volumio-miro volumio[4449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17
Aug 30 15:12:56 volumio-miro volumio[4449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro sudo[4691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:56 volumio-miro sudo[4691]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Aug 30 15:12:56 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:56 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:56 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:56 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:56 volumio-miro volumio[4449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 15:12:56 volumio-miro volumio[4449]: info: No need to fix Spotify hosts
Aug 30 15:12:57 volumio-miro volumio[4449]: info: [ASDebug] Pulsing GPIO for 500ms
Aug 30 15:12:57 volumio-miro volumio[4449]: info: [ASDebug] Togle GPIO: ON
Aug 30 15:12:57 volumio-miro volumio[4449]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 15:12:57 volumio-miro volumio[4449]: Error: EPERM: operation not permitted, write
Aug 30 15:12:57 volumio-miro volumio[4449]: at Object.writeSync (fs.js:737:3)
Aug 30 15:12:57 volumio-miro volumio[4449]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8)
Aug 30 15:12:57 volumio-miro volumio[4449]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:209:23)
Aug 30 15:12:57 volumio-miro volumio[4449]: at AmpSwitchController.pulse (/data/plugins/system_controller/ampswitch/index.js:231:8)
Aug 30 15:12:57 volumio-miro volumio[4449]: at Timeout._onTimeout (/data/plugins/system_controller/ampswitch/index.js:195:39)
Aug 30 15:12:57 volumio-miro volumio[4449]: at listOnTimeout (internal/timers.js:557:17)
Aug 30 15:12:57 volumio-miro volumio[4449]: at processTimers (internal/timers.js:500:7) {
Aug 30 15:12:57 volumio-miro volumio[4449]: errno: -1,
Aug 30 15:12:57 volumio-miro volumio[4449]: syscall: 'write',
Aug 30 15:12:57 volumio-miro volumio[4449]: code: 'EPERM'
Aug 30 15:12:57 volumio-miro volumio[4449]: }
Aug 30 15:12:57 volumio-miro volumio[4449]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 15:12:57 volumio-miro 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.
Aug 30 15:12:57 volumio-miro lircd[1980]: lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:57 volumio-miro lircd[1980]: lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:57 volumio-miro lircd-0.10.1[1980]: Error: could not get file information for /dev/lirc0
Aug 30 15:12:57 volumio-miro lircd-0.10.1[1980]: default_init(): No such file or directory
Aug 30 15:12:58 volumio-miro sudo[4684]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:58 volumio-miro systemd[1]: Stopping go-librespot Daemon...
Aug 30 15:12:58 volumio-miro systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Aug 30 15:12:58 volumio-miro systemd[1]: go-librespot-daemon.service: Succeeded.
Aug 30 15:12:58 volumio-miro systemd[1]: Stopped go-librespot Daemon.
Aug 30 15:12:58 volumio-miro systemd[1]: Started go-librespot Daemon.
Aug 30 15:12:58 volumio-miro go-librespot[4733]: go-librespot daemon starting...
Aug 30 15:12:58 volumio-miro sudo[4691]: pam_unix(sudo:session): session closed for user root
Aug 30 15:12:58 volumio-miro go-librespot[4733]: time="2025-08-30T15:12:58+02:00" level=info msg="running go-librespot 0.3.2"
Aug 30 15:12:58 volumio-miro go-librespot[4733]: time="2025-08-30T15:12:58+02:00" level=debug msg="app state loaded"
Aug 30 15:12:58 volumio-miro go-librespot[4733]: time="2025-08-30T15:12:58+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Aug 30 15:12:58 volumio-miro sudo[4745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 15:11
Aug 30 15:12:58 volumio-miro sudo[4745]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:55:15 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_DEVICENAME="Asus Tinkerboard"
VOLUMIO_HASH="2f3686ade78abf3b92c180a0c5b20c6b"