-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2026-02-08 11:54:12 CET. -- Feb 08 11:53:06 volumio-miro systemd-timedated[1354]: Changed local time to Sun Feb 8 11:53:06 2026 Feb 08 11:53:06 volumio-miro sudo[1348]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:06 volumio-miro volumio-time-update[557]: volumio-time-update-util: System time updated successfully. Feb 08 11:53:06 volumio-miro systemd[1]: Started Volumio Time Update Utility. Feb 08 11:53:06 volumio-miro systemd[1]: Reached target Multi-User System. Feb 08 11:53:06 volumio-miro systemd[1]: Reached target Graphical Interface. Feb 08 11:53:06 volumio-miro systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 08 11:53:06 volumio-miro systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 08 11:53:06 volumio-miro systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 08 11:53:06 volumio-miro systemd[1]: Startup finished in 15.936s (kernel) + 17.874s (userspace) = 33.810s. Feb 08 11:53:06 volumio-miro volumio[1208]: info: Loading plugin "network"... Feb 08 11:53:06 volumio-miro volumio[1208]: info: Refreshing Cached IP Addresses Feb 08 11:53:06 volumio-miro sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 11:53:06 volumio-miro sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 11:53:06 volumio-miro volumio[1208]: info: Loading plugin "services"... Feb 08 11:53:06 volumio-miro sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:06 volumio-miro volumio[1208]: info: Loading plugin "alsa_controller"... Feb 08 11:53:06 volumio-miro sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:06 volumio-miro sudo[1363]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:06 volumio-miro sudo[1376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 08 11:53:06 volumio-miro sudo[1376]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:06 volumio-miro sudo[1365]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:06 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 11:53:06 volumio-miro volumio[1208]: info: Loading plugin "wizard"... Feb 08 11:53:06 volumio-miro volumio[1208]: info: Loading plugin "networkfs"... Feb 08 11:53:06 volumio-miro volumio[1208]: info: Starting Udev Watcher for removable devices Feb 08 11:53:06 volumio-miro volumio[1208]: info: Ignoring mount for partition: BOOT Feb 08 11:53:06 volumio-miro volumio[1208]: info: Ignoring mount for partition: volumio Feb 08 11:53:06 volumio-miro volumio[1208]: info: Ignoring mount for partition: volumio_data Feb 08 11:53:06 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 11:53:06 volumio-miro volumio[1208]: info: Loading plugin "volumio_command_line_client"... Feb 08 11:53:06 volumio-miro volumio[1208]: info: Loading plugin "upnp"... Feb 08 11:53:06 volumio-miro volumio[1208]: info: [1770547986826] Starting Upmpd Daemon Feb 08 11:53:06 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 11:53:06 volumio-miro volumio[1208]: info: Loading plugin "my_music"... Feb 08 11:53:06 volumio-miro volumio[1208]: info: Loading plugin "mpd"... Feb 08 11:53:07 volumio-miro volumio[1208]: info: Loading plugin "upnp_browser"... Feb 08 11:53:07 volumio-miro volumio[1208]: info: Starting UPNP Browser Feb 08 11:53:07 volumio-miro volumio[1208]: info: Loading plugin "alarm-clock"... Feb 08 11:53:07 volumio-miro volumio[1208]: info: Loading plugin "airplay_emulation"... Feb 08 11:53:07 volumio-miro volumio[1208]: info: Starting Shairport Sync Feb 08 11:53:07 volumio-miro volumio[1208]: info: Loading plugin "last_100"... Feb 08 11:53:07 volumio-miro volumio[1208]: info: Loading plugin "webradio"... Feb 08 11:53:07 volumio-miro volumio[1208]: info: Loading plugin "i2s_dacs"... Feb 08 11:53:07 volumio-miro volumio[1208]: info: I2S DAC not set, start Auto-detection Feb 08 11:53:07 volumio-miro volumio[1208]: info: Loading plugin "volumiodiscovery"... Feb 08 11:53:07 volumio-miro volumio[1208]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 11:53:07 volumio-miro volumio[1208]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 11:53:07 volumio-miro volumio[1208]: *** WARNING *** For more information see Feb 08 11:53:07 volumio-miro volumio[1208]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 11:53:07 volumio-miro volumio[1208]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 11:53:07 volumio-miro node[1208]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 11:53:07 volumio-miro volumio[1208]: *** WARNING *** For more information see Feb 08 11:53:07 volumio-miro node[1208]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 11:53:07 volumio-miro node[1208]: *** WARNING *** For more information see Feb 08 11:53:07 volumio-miro node[1208]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 11:53:07 volumio-miro node[1208]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 11:53:07 volumio-miro node[1208]: *** WARNING *** For more information see Feb 08 11:53:07 volumio-miro volumio[1208]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 08 11:53:07 volumio-miro volumio[1208]: info: Discovery: Started advertising with name: Volumio Miro Feb 08 11:53:07 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 11:53:07 volumio-miro volumio[1208]: info: Loading plugin "spop"... Feb 08 11:53:08 volumio-miro sudo[1376]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:08 volumio-miro volumio[1208]: info: Loading plugin "outputs"... Feb 08 11:53:08 volumio-miro volumio[1208]: info: Loading plugin "albumart"... Feb 08 11:53:08 volumio-miro volumio[1208]: info: Plugin example_plugin is not enabled Feb 08 11:53:08 volumio-miro volumio[1208]: info: Loading plugin "inputs"... Feb 08 11:53:08 volumio-miro volumio[1208]: info: Loading plugin "updater_comm"... Feb 08 11:53:08 volumio-miro volumio[1208]: info: Plugin mpdemulation is not enabled Feb 08 11:53:08 volumio-miro volumio[1208]: info: Loading plugin "rest_api"... Feb 08 11:53:08 volumio-miro volumio[1208]: info: Loading plugin "websocket"... Feb 08 11:53:08 volumio-miro volumio[1208]: info: Starting Socket.io Server version 2.3.0 Feb 08 11:53:08 volumio-miro volumio[1208]: info: Loading plugin "fusiondsp"... Feb 08 11:53:08 volumio-miro volumio[1208]: Forking 3 albumart workers Feb 08 11:53:09 volumio-miro volumio[1208]: info: Applying required configuration parameters for plugin fusiondsp Feb 08 11:53:09 volumio-miro volumio[1208]: info: Loading plugin "audiophonics_evo_sabre"... Feb 08 11:53:09 volumio-miro volumio[1208]: info: Applying required configuration parameters for plugin audiophonics_evo_sabre Feb 08 11:53:09 volumio-miro volumio[1208]: Starting albumart workers Feb 08 11:53:09 volumio-miro volumio[1208]: info: Loading plugin "onkyo_control"... Feb 08 11:53:09 volumio-miro volumio[1208]: Starting albumart workers Feb 08 11:53:09 volumio-miro volumio[1208]: Starting albumart workers Feb 08 11:53:10 volumio-miro volumio[1208]: info: Applying required configuration parameters for plugin onkyo_control Feb 08 11:53:10 volumio-miro volumio[1208]: info: Loading plugin "Systeminfo"... Feb 08 11:53:10 volumio-miro volumio[1208]: info: Loading i18n strings for locale pl Feb 08 11:53:10 volumio-miro volumio[1208]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored. Feb 08 11:53:10 volumio-miro volumio[1208]: Updating browse sources language Feb 08 11:53:10 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::initPlayerControls Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: Express server listening on port 3000 Feb 08 11:53:11 volumio-miro volumio[1208]: [Metrics] WebUI: 7s 548.16ms Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreStateMachine::resetVolumioState Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreStateMachine::getcurrentVolume Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 08 11:53:11 volumio-miro volumio[1208]: info: Completed loading Core Plugins Feb 08 11:53:11 volumio-miro volumio[1208]: info: Preparing to generate the ALSA configuration file Feb 08 11:53:11 volumio-miro volumio[1208]: info: Volumio Network Manager: Network status updated: 3 Feb 08 11:53:11 volumio-miro volumio[1208]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 08 11:53:11 volumio-miro volumio[1208]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 08 11:53:11 volumio-miro volumio[1208]: info: Reading ALSA contributions from plugins. Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreStateMachine::pushState Feb 08 11:53:11 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioPushState Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreStateMachine::updateTrackBlock Feb 08 11:53:11 volumio-miro volumio[1208]: info: CorePlayQueue::getTrackBlock Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 11:53:11 volumio-miro volumio[1208]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Feb 08 11:53:11 volumio-miro volumio[1208]: info: Reloading queue from file Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreStateMachine::pushState Feb 08 11:53:11 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioPushState Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreStateMachine::setRepeat null single undefined Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreStateMachine::pushState Feb 08 11:53:11 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioPushState Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreStateMachine::setRandom null Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreStateMachine::pushState Feb 08 11:53:11 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioPushState Feb 08 11:53:11 volumio-miro volumio[1208]: info: Setting Device type: Tinkerboard Feb 08 11:53:11 volumio-miro volumio[1208]: info: Asound.conf file unchanged, so no further update is needed Feb 08 11:53:11 volumio-miro volumio[1208]: info: Output device has changed, restarting MPD Feb 08 11:53:11 volumio-miro volumio[1208]: info: Output device has changed, restarting Shairport Sync Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:11 volumio-miro sudo[1522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 11:53:11 volumio-miro sudo[1522]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:11 volumio-miro sudo[1525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 11:53:11 volumio-miro sudo[1522]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:11 volumio-miro sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:11 volumio-miro volumio[1208]: info: ___________ START PLUGINS ___________ Feb 08 11:53:11 volumio-miro systemd[1]: Listening on mpd.socket. Feb 08 11:53:11 volumio-miro systemd[1]: Starting Music Player Daemon... Feb 08 11:53:11 volumio-miro volumio[1208]: error: Plugin ampswitch failed to start! Error: EINVAL: invalid argument, write Feb 08 11:53:11 volumio-miro kernel: rockchip-pinctrl pinctrl: pin 0 is unrouted Feb 08 11:53:11 volumio-miro volumio[1208]: info: ControllerMpd::onStart: Initializing MPD Feb 08 11:53:11 volumio-miro volumio[1208]: info: Creating MPD Configuration file Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 11:53:11 volumio-miro volumio[1208]: info: [1770547991663] CoreMusicLibrary::Adding element Serwery Mediów Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 11:53:11 volumio-miro volumio[1208]: info: UPNP Browser: Client initialized successfully Feb 08 11:53:11 volumio-miro sudo[1552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 11:53:11 volumio-miro sudo[1555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:11 volumio-miro sudo[1552]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:11 volumio-miro sudo[1555]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:11 volumio-miro sudo[1547]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 11:53:11 volumio-miro sudo[1552]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:11 volumio-miro sudo[1547]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:11 volumio-miro sudo[1547]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 11:53:11 volumio-miro volumio[1208]: info: [1770547991770] CoreMusicLibrary::Adding element Last_100 Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 11:53:11 volumio-miro volumio[1208]: info: [1770547991772] CoreMusicLibrary::Adding element Webradio Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 11:53:11 volumio-miro volumio[1208]: info: Initializing BBC Radios Feb 08 11:53:11 volumio-miro systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 08 11:53:11 volumio-miro systemd[1]: mpd.service: Succeeded. Feb 08 11:53:11 volumio-miro systemd[1]: Stopped Music Player Daemon. Feb 08 11:53:11 volumio-miro systemd[1]: Starting Music Player Daemon... Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: Creating Spotify config file Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro sudo[1583]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 11:53:11 volumio-miro sudo[1583]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:11 volumio-miro sudo[1583]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 08 11:53:11 volumio-miro sudo[1583]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:11 volumio-miro volumio[1208]: info: Loading i18n strings for locale pl Feb 08 11:53:11 volumio-miro volumio[1208]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored. Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 08 11:53:11 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:11 volumio-miro volumio[1208]: info: FusionDsp - mixtype--------------------- Software Feb 08 11:53:11 volumio-miro volumio[1208]: info: EVO SABRE : Starting Plugin Feb 08 11:53:11 volumio-miro volumio[1208]: info: Loading i18n strings for locale pl Feb 08 11:53:11 volumio-miro volumio[1208]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored. Feb 08 11:53:11 volumio-miro volumio[1208]: info: Volumio Calling Home Feb 08 11:53:12 volumio-miro volumio[1208]: info: Preparing to generate the ALSA configuration file Feb 08 11:53:12 volumio-miro volumio[1208]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 08 11:53:12 volumio-miro volumio[1208]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 08 11:53:12 volumio-miro volumio[1208]: info: Reading ALSA contributions from plugins. Feb 08 11:53:12 volumio-miro volumio[1208]: info: ONKYO-CONTROL: *********** ONKYO PLUGIN STARTED ******** Feb 08 11:53:12 volumio-miro volumio[1208]: info: MPD Permissions set Feb 08 11:53:12 volumio-miro volumio[1208]: info: Volumio called home Feb 08 11:53:12 volumio-miro volumio[1208]: info: Spotify config file written Feb 08 11:53:12 volumio-miro sudo[1613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro sudo[1613]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 08 11:53:12 volumio-miro systemd[1]: Reloading. Feb 08 11:53:12 volumio-miro sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: No need to fix Spotify hosts Feb 08 11:53:12 volumio-miro sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: Starting Shairport Sync Feb 08 11:53:12 volumio-miro volumio[1208]: info: Starting Shairport Sync Feb 08 11:53:12 volumio-miro volumio[1208]: info: Starting Shairport Sync Feb 08 11:53:12 volumio-miro volumio[1208]: info: Asound.conf file unchanged, so no further update is needed Feb 08 11:53:12 volumio-miro volumio[1208]: info: Output device has changed, restarting MPD Feb 08 11:53:12 volumio-miro sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 08 11:53:12 volumio-miro sudo[1661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 08 11:53:12 volumio-miro volumio[1208]: info: Output device has changed, restarting Shairport Sync Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:12 volumio-miro sudo[1663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 08 11:53:12 volumio-miro sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 11:53:12 volumio-miro sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:12 volumio-miro sudo[1678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 11:53:12 volumio-miro sudo[1661]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:12 volumio-miro sudo[1663]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:12 volumio-miro sudo[1678]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 08 11:53:12 volumio-miro sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:12 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:12 volumio-miro volumio[1208]: info: Starting Shairport Sync Feb 08 11:53:12 volumio-miro sudo[1671]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:12 volumio-miro volumio[1208]: info: MPD Permissions set Feb 08 11:53:12 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. Feb 08 11:53:12 volumio-miro sudo[1718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 08 11:53:12 volumio-miro sudo[1718]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:13 volumio-miro systemd[1]: serial-getty@ttyS3.service: Current command vanished from the unit file, execution of the command list won't be resumed. Feb 08 11:53:13 volumio-miro sudo[1613]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:13 volumio-miro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 08 11:53:13 volumio-miro systemd[1]: Started go-librespot Daemon. Feb 08 11:53:13 volumio-miro sudo[1617]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:13 volumio-miro systemd[1]: shairport-sync.service: Succeeded. Feb 08 11:53:13 volumio-miro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 08 11:53:13 volumio-miro volumio[1208]: info: EVO SABRE : systemd cmd daemon-reload : success Feb 08 11:53:13 volumio-miro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 08 11:53:13 volumio-miro sudo[1661]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:13 volumio-miro sudo[1718]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:13 volumio-miro sudo[1659]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:13 volumio-miro sudo[1663]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:13 volumio-miro go-librespot[1736]: go-librespot daemon starting... Feb 08 11:53:13 volumio-miro systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 08 11:53:13 volumio-miro systemd[1]: mpd.service: Succeeded. Feb 08 11:53:13 volumio-miro systemd[1]: Stopped Music Player Daemon. Feb 08 11:53:13 volumio-miro volumio[1208]: info: Shairport-Sync Started Feb 08 11:53:13 volumio-miro volumio[1208]: Error adding Membership: Error: addMembership EINVAL Feb 08 11:53:13 volumio-miro volumio[1208]: info: Shairport-Sync Started Feb 08 11:53:13 volumio-miro volumio[1208]: info: Shairport-Sync Started Feb 08 11:53:13 volumio-miro sudo[1747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart evo_oled2.service Feb 08 11:53:13 volumio-miro volumio[1208]: info: Shairport-Sync Started Feb 08 11:53:13 volumio-miro systemd[1]: Starting Music Player Daemon... Feb 08 11:53:13 volumio-miro sudo[1747]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:13 volumio-miro sudo[1762]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 11:53:13 volumio-miro systemd[1]: Started OLED Display Service for EVO SABRE. Feb 08 11:53:13 volumio-miro sudo[1747]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:13 volumio-miro sudo[1762]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:13 volumio-miro sudo[1762]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 08 11:53:13 volumio-miro sudo[1762]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:13 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:13+01:00" level=info msg="running go-librespot 0.4.0" Feb 08 11:53:13 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:13+01:00" level=debug msg="app state loaded" Feb 08 11:53:13 volumio-miro volumio[1208]: info: EVO SABRE : systemd cmd restart evo_oled2.service : success Feb 08 11:53:13 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:13+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 08 11:53:13 volumio-miro sudo[1808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart evo_remote.service Feb 08 11:53:13 volumio-miro sudo[1808]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:13 volumio-miro systemd[1]: Starting lircd(8) initialization helper tool... Feb 08 11:53:14 volumio-miro volumio[1208]: info: camilladsp service started and running in background, instance 1 Feb 08 11:53:14 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:14 volumio-miro volumio[1208]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 96000 176400 192000 <-AAAAAAAAAAAAA Feb 08 11:53:14 volumio-miro volumio[1208]: info: FusionDsp loaded Feb 08 11:53:14 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:14 volumio-miro volumio[1208]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 08 11:53:14 volumio-miro volumio[1208]: info: Adding Signal Path Element [object Object] Feb 08 11:53:14 volumio-miro volumio[1208]: info: Adding fusiondspeq DSP Signal Path Element Feb 08 11:53:14 volumio-miro volumio[1208]: info: FusionDsp - ---- installed callbackRead Feb 08 11:53:14 volumio-miro volumio[1208]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 08 11:53:14 volumio-miro volumio[1208]: info: FusionDsp - crossfeed bauer Feb 08 11:53:14 volumio-miro sudo[1841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 08 11:53:14 volumio-miro sudo[1841]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:14 volumio-miro systemd[1]: Started FusionDsp Daemon. Feb 08 11:53:14 volumio-miro sudo[1841]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:14 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:14+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 08 11:53:14 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:14+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 08 11:53:14 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:14+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 08 11:53:14 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:14+01:00" level=info msg="zeroconf server listening on port 36128" Feb 08 11:53:14 volumio-miro lircd-setup[1816]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Feb 08 11:53:14 volumio-miro lircd-setup[1816]: parser = configparser.SafeConfigParser() Feb 08 11:53:14 volumio-miro systemd[1]: lircd-setup.service: Succeeded. Feb 08 11:53:14 volumio-miro systemd[1]: Started lircd(8) initialization helper tool. Feb 08 11:53:14 volumio-miro systemd[1]: Started evo_remote.service. Feb 08 11:53:14 volumio-miro sudo[1808]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:14 volumio-miro systemd[1]: evo_oled2.service: Main process exited, code=exited, status=77/NOPERM Feb 08 11:53:14 volumio-miro systemd[1]: evo_oled2.service: Failed with result 'exit-code'. Feb 08 11:53:14 volumio-miro lircd-0.10.1[1871]: Info: lircd: Opening log, level: Info Feb 08 11:53:14 volumio-miro lircd-0.10.1[1871]: Notice: Version: lircd 0.10.1 Feb 08 11:53:14 volumio-miro volumio[1208]: info: EVO SABRE : systemd cmd restart evo_remote.service : success Feb 08 11:53:14 volumio-miro lircd-0.10.1[1871]: Notice: System info: Linux volumio-miro 4.4.71+ #23 SMP Sun Sep 20 12:23:26 CEST 2020 armv7l GNU/Linux Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Info: Initial device: /dev/lirc0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Warning: Cannot access device: /dev/lirc0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Info: Initial device: /dev/lirc0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Warning: Cannot access device: /dev/lirc0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: driver: default Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: output: /var/run/lirc/lircd Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: nodaemon: 1 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: logfile: syslog Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: immediate-init: 0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: permission: 666 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: driver-options: Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: listen: 0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: connect: (null) Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: userelease: 0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: effective_user: (null) Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: release_suffix: _EVUP Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: allow_simulate: 0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: repeat_max: 600 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: configfile: /data/plugins/system_hardware/audiophonics_evo_sabre/apps/lirc/lircd.conf Feb 08 11:53:15 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Info: lircd: Opening log, level: Info Feb 08 11:53:15 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Warning: Running as root Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Options: dynamic_codes: (null) Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Current driver: default Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Driver API version: 3 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Driver version: 0.10.0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Feb 08 11:53:15 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Info: Using remote: ApEvo. Feb 08 11:53:15 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Notice: lircd(default) ready, using /var/run/lirc/lircd Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Info: lircd: Opening log, level: Info Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Warning: Running as root Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Info: Using remote: ApEvo. Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: lircd(default) ready, using /var/run/lirc/lircd Feb 08 11:53:15 volumio-miro sudo[1878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart evo_irexec.service Feb 08 11:53:15 volumio-miro sudo[1878]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:15 volumio-miro systemd[1]: Starting lircd(8) initialization helper tool... Feb 08 11:53:15 volumio-miro lircd-setup[1884]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Feb 08 11:53:15 volumio-miro lircd-setup[1884]: parser = configparser.SafeConfigParser() Feb 08 11:53:15 volumio-miro systemd[1]: lircd-setup.service: Succeeded. Feb 08 11:53:15 volumio-miro systemd[1]: Started lircd(8) initialization helper tool. Feb 08 11:53:15 volumio-miro systemd[1]: Started evo_irexec.service. Feb 08 11:53:15 volumio-miro sudo[1878]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:15 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Notice: accepted new client on /var/run/lirc/lircd Feb 08 11:53:15 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Info: Cannot configure the rc device for /dev/lirc0 Feb 08 11:53:15 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:15 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:15 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Warning: Failed to initialize hardware Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Notice: accepted new client on /var/run/lirc/lircd Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Info: Cannot configure the rc device for /dev/lirc0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:15 volumio-miro lircd-0.10.1[1871]: Warning: Failed to initialize hardware Feb 08 11:53:15 volumio-miro volumio[1208]: info: EVO SABRE : systemd cmd restart evo_irexec.service : success Feb 08 11:53:15 volumio-miro mpd[1812]: Feb 08 11:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 11:53:15 volumio-miro systemd[1]: Started Music Player Daemon. Feb 08 11:53:15 volumio-miro sudo[1555]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:15 volumio-miro sudo[1525]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:15 volumio-miro sudo[1678]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:15 volumio-miro volumio[1208]: info: Completed starting Core Plugins Feb 08 11:53:15 volumio-miro volumio[1208]: info: ------------------------------------------- Feb 08 11:53:15 volumio-miro volumio[1208]: info: ----- MyVolumio plugins startup ---- Feb 08 11:53:15 volumio-miro volumio[1208]: info: ------------------------------------------- Feb 08 11:53:15 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 08 11:53:16 volumio-miro volumio[1208]: error: MPD error: The expression evaluated to a falsy value: Feb 08 11:53:16 volumio-miro volumio[1208]: assert.ok(self.idling) Feb 08 11:53:16 volumio-miro volumio[1208]: error: The expression evaluated to a falsy value: Feb 08 11:53:16 volumio-miro volumio[1208]: assert.ok(self.idling) Feb 08 11:53:16 volumio-miro volumio[1208]: info: MPD running with PID1812 Feb 08 11:53:16 volumio-miro volumio[1208]: ,establishing connection Feb 08 11:53:16 volumio-miro volumio[1208]: error: MPD error: The expression evaluated to a falsy value: Feb 08 11:53:16 volumio-miro volumio[1208]: assert.ok(self.idling) Feb 08 11:53:16 volumio-miro volumio[1208]: error: The expression evaluated to a falsy value: Feb 08 11:53:16 volumio-miro volumio[1208]: assert.ok(self.idling) Feb 08 11:53:16 volumio-miro volumio[1208]: error: MPD error: The expression evaluated to a falsy value: Feb 08 11:53:16 volumio-miro volumio[1208]: assert.ok(self.idling) Feb 08 11:53:16 volumio-miro volumio[1208]: error: The expression evaluated to a falsy value: Feb 08 11:53:16 volumio-miro volumio[1208]: assert.ok(self.idling) Feb 08 11:53:16 volumio-miro volumio[1208]: error: updateQueue error: null Feb 08 11:53:16 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:16+01:00" level=debug msg="obtained new client token: AAB7SUhn9xy/tVcPC/uKfF5elxD6AlGDLfh09t6Th+8d4ANtTLR6KZE8W6rvSk8Udl8XMogflQyag/Oo47MqYzWhiLTKrTBu0dhfhO5AgySbhGW3MHZgEKmm6qPQjx+w0XYwwYFMcuLT8NldqhUgr5vRTMRZVxvCV+OmPHl1KOUCQjPrEmRtH4EceFh0qxTkhGoDkCtSxmdWgJZy8C6YVuRYkSZOw0a1rIQ0YWNvlSWO4g5xY7Ti" Feb 08 11:53:16 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:16 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:16 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:16 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:16 volumio-miro volumio[1208]: info: go-librespot daemon successfully initialized Feb 08 11:53:16 volumio-miro sudo[1966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 11:53:16 volumio-miro sudo[1961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 11:53:17 volumio-miro sudo[1970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 08 11:53:17 volumio-miro sudo[1966]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:17 volumio-miro sudo[1961]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:17 volumio-miro sudo[1966]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:17 volumio-miro sudo[1961]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:17 volumio-miro sudo[1970]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:17 volumio-miro systemd[1]: Started UPnP Renderer front-end to MPD. Feb 08 11:53:17 volumio-miro sudo[1970]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:17 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:17 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:17 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:17 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:17 volumio-miro volumio[1208]: info: Upmpdcli Daemon Started Feb 08 11:53:17 volumio-miro volumio[1991]: Generating RSA private key, 4096 bit long modulus (2 primes) Feb 08 11:53:18 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:18 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:18 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:18 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:19 volumio-miro volumio-remote-updater[566]: [2026-02-08 11:53:19] [connect] Successful connection Feb 08 11:53:19 volumio-miro volumio-remote-updater[566]: [2026-02-08 11:53:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770547999 101 Feb 08 11:53:19 volumio-miro volumio[1208]: 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: 2 Feb 08 11:53:19 volumio-miro sudo[2019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Feb 08 11:53:19 volumio-miro sudo[2021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Feb 08 11:53:19 volumio-miro sudo[2021]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:19 volumio-miro sudo[2019]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:19 volumio-miro systemd[1]: Started MPD Monitor Service. Feb 08 11:53:19 volumio-miro sudo[2019]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:19 volumio-miro mpd_monitor.sh[2033]: MPD Monitor Service: Starting MPD Monitor Service Feb 08 11:53:19 volumio-miro sudo[2021]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:19 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:19 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:19 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:19 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:19 volumio-miro sudo[2035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Feb 08 11:53:19 volumio-miro volumio[1208]: info: Successfully started MPD Monitor Feb 08 11:53:19 volumio-miro volumio[1208]: info: Successfully started MPD Monitor Feb 08 11:53:19 volumio-miro sudo[2035]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:19 volumio-miro volumio[1208]: info: Initializing connection to go-librespot Websocket Feb 08 11:53:19 volumio-miro systemd[1]: Stopping MPD Monitor Service... Feb 08 11:53:19 volumio-miro systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Feb 08 11:53:19 volumio-miro systemd[1]: mpd_monitor.service: Succeeded. Feb 08 11:53:19 volumio-miro systemd[1]: Stopped MPD Monitor Service. Feb 08 11:53:19 volumio-miro systemd[1]: Started MPD Monitor Service. Feb 08 11:53:19 volumio-miro sudo[2035]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:19 volumio-miro mpd_monitor.sh[2049]: MPD Monitor Service: Starting MPD Monitor Service Feb 08 11:53:19 volumio-miro volumio[1208]: info: Successfully started MPD Monitor Feb 08 11:53:19 volumio-miro systemd[1]: systemd-fsckd.service: Succeeded. Feb 08 11:53:20 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:20 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:20 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:20 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:20 volumio-miro volumio[1208]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 08 11:53:21 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:21 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:21 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:21 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:21 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:21+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 08 11:53:21 volumio-miro volumio[1208]: info: Discovery: adding beeb6fb6-e4a3-4bbf-b656-f0a88814bb80 Feb 08 11:53:21 volumio-miro volumio[1208]: info: Discovery: Found device Volumio Miro Feb 08 11:53:21 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:21 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:21 volumio-miro volumio[1208]: info: Discovery: this is already registered, beeb6fb6-e4a3-4bbf-b656-f0a88814bb80 Feb 08 11:53:21 volumio-miro volumio[1208]: info: Discovery: Found device Volumio Miro Feb 08 11:53:21 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:21 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:21 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:21+01:00" level=debug msg="completed keyexchange" Feb 08 11:53:21 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:21+01:00" level=debug msg="completed challenge" Feb 08 11:53:21 volumio-miro volumio[1208]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 08 11:53:21 volumio-miro volumio[1208]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 08 11:53:21 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:21+01:00" level=info msg="authenticated AP" username="21*********************ki" Feb 08 11:53:22 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:22 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:22 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:22 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:22 volumio-miro volumio[1208]: 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: 5 Feb 08 11:53:23 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 11:53:23 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 11:53:23 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:23 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:23 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 11:53:23 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:23 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:23 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 11:53:23 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:23 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:23 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:23 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:24 volumio-miro volumio[1208]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Feb 08 11:53:24 volumio-miro volumio[1208]: SPOTIFY: BQAxztZwqEcU7EAB-q2mcy_oKsMmW-dOyDRO5HtJPTY9FjUaW8TnbydY_cQ2TtEEmMUiCcbkI9XrKXeAETl-fssiYTr8KydJxdSbXhUms3PBmjxxeUcRWiPcaQaafe8fmCWq5FDqEZ1giIlAcjBF8TXH5DpeI2GvRHUOtswPPfr3OGHXMjvoFaMsqLRPoU_UMkbmYPY63V4PZAT8QVU7Z2AUvQeP-lfPCLtalCqAl8_KXbpPfOzNgMZFmCRW1tRJGNeLXgYyeUmWkwqQr_J6qzN_nYKCC8LD5Tq2CqWfMQaVDOqfxSsIH7Nj Feb 08 11:53:24 volumio-miro volumio[1208]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Feb 08 11:53:24 volumio-miro volumio[1208]: info: New Spotify access token = BQAxztZwqEcU7EAB-q2mcy_oKsMmW-dOyDRO5HtJPTY9FjUaW8TnbydY_cQ2TtEEmMUiCcbkI9XrKXeAETl-fssiYTr8KydJxdSbXhUms3PBmjxxeUcRWiPcaQaafe8fmCWq5FDqEZ1giIlAcjBF8TXH5DpeI2GvRHUOtswPPfr3OGHXMjvoFaMsqLRPoU_UMkbmYPY63V4PZAT8QVU7Z2AUvQeP-lfPCLtalCqAl8_KXbpPfOzNgMZFmCRW1tRJGNeLXgYyeUmWkwqQr_J6qzN_nYKCC8LD5Tq2CqWfMQaVDOqfxSsIH7Nj Feb 08 11:53:24 volumio-miro volumio[1208]: info: Spotify credentials grant success - running version from March 24, 2019 Feb 08 11:53:24 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:24 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:24 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:24 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:24 volumio-miro volumio[1208]: 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: 5 Feb 08 11:53:25 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:25 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:25 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:25+01:00" level=debug msg="new websocket client" Feb 08 11:53:25 volumio-miro volumio[1208]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 08 11:53:25 volumio-miro volumio[1208]: info: Connection to go-librespot Websocket established Feb 08 11:53:25 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:25 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:25 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:25 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:25 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:25 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:25 volumio-miro volumio[1208]: info: FusionDsp - {"Reload":{"result":"Ok"}} Feb 08 11:53:25 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:25 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:25 volumio-miro volumio[1208]: info: ONKYO-CONTROL: New state: {"status":"stop","position":0,"title":"Avril 14th","artist":"Aphex Twin","album":"Drukqs","albumart":"https://i.scdn.co/image/ab67616d0000b2732e261a0b1b19d0ff95e346b3","uri":"spotify:track:1uaGSDFsLdReQgg8p7Obwh","trackType":"spotify","codec":"ogg","seek":0,"duration":125,"samplerate":"320 kbps","bitdepth":"16 bit","random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":"100","dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","updatedb":false,"volatile":false,"service":"spop"} connection: {"reconnect":true,"verify_commands":false,"port":60128,"host":"192.168.68.126","model":"TX-RZ3400"} Feb 08 11:53:25 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 08 11:53:25 volumio-miro volumio[1208]: info: Listing playlists Feb 08 11:53:25 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 11:53:25 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:25 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:25 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 11:53:26 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:26 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:26 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:26 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:26 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:26+01:00" level=info msg="authenticated Login5" username="21*********************ki" Feb 08 11:53:26 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:26+01:00" level=debug msg="initializing zeroconf session" username="21*********************ki" Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 08 11:53:26 volumio-miro volumio[1208]: info: Adding plugin bluetooth to MyMusic Plugins Feb 08 11:53:26 volumio-miro volumio[1208]: info: Adding plugin multiroom to MyMusic Plugins Feb 08 11:53:26 volumio-miro volumio[1208]: info: Adding plugin metavolumio to MyMusic Plugins Feb 08 11:53:26 volumio-miro volumio[1208]: info: Adding plugin cd_controller to MyMusic Plugins Feb 08 11:53:26 volumio-miro volumio[1208]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 08 11:53:26 volumio-miro volumio[1208]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 08 11:53:26 volumio-miro volumio[1208]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 08 11:53:26 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 08 11:53:27 volumio-miro volumio[1991]: ..........................................................................................................++++ Feb 08 11:53:27 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:27 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:27 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:27 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=debug msg="dealer connection opened" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=trace msg="starting accesspoint recv loop" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=trace msg="starting dealer recv loop" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=trace msg="received accesspoint ping" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=debug msg="received connection id: NDc1YWZjZmQtMTBj...OEIxOEM5MDdBNw==" Feb 08 11:53:27 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:27+01:00" level=trace msg="received accesspoint pong ack" Feb 08 11:53:28 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:28+01:00" level=debug msg="put connect state because NEW_DEVICE" Feb 08 11:53:28 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:28 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:28 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:28 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:28 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 08 11:53:28 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 08 11:53:28 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:28 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:28 volumio-miro volumio[1208]: info: Starting MyVolumio Remote Streaming Endpoints Feb 08 11:53:28 volumio-miro volumio[1208]: info: MyVolumio login type: Token Feb 08 11:53:28 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 08 11:53:28 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 08 11:53:29 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:29 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:29 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:29 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:30 volumio-miro volumio[1208]: info: Starting Streaming Service Transparent Proxy Feb 08 11:53:30 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 08 11:53:30 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 08 11:53:30 volumio-miro volumio[1208]: info: Streaming services startup Feb 08 11:53:30 volumio-miro volumio[1208]: info: Starting Streaming Daemon Feb 08 11:53:30 volumio-miro sudo[2101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 08 11:53:30 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 08 11:53:30 volumio-miro sudo[2101]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:30 volumio-miro sudo[2101]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:30 volumio-miro volumio[1208]: info: Getting Spotify volume Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 11:53:30 volumio-miro volumio[1208]: info: Received Get System Info Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:30 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:30 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:30 volumio-miro volumio[1208]: error: Cannot start Volumio Streaming Daemon Feb 08 11:53:30 volumio-miro volumio[1208]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 08 11:53:30 volumio-miro volumio[1208]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 08 11:53:30 volumio-miro volumio[1208]: info: Spotify volume: 100 Feb 08 11:53:30 volumio-miro volumio[1208]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:30 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:30 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:30 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:30 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:30 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:30 volumio-miro volumio[1208]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 11:53:30 volumio-miro volumio[1208]: SPOTIFY: SPOTIFY VOLUME 100 Feb 08 11:53:30 volumio-miro volumio[1208]: SPOTIFY: VOLUMIO VOLUME 100 Feb 08 11:53:30 volumio-miro volumio[1208]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 08 11:53:30 volumio-miro volumio[1208]: SPOTIFY: User informations: {"country":"PL","display_name":"Mirek Piechota","email":"janstarzec@interia.pl","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/217a5xjhew5fxodltwy7iemki"},"followers":{"href":null,"total":2},"href":"https://api.spotify.com/v1/users/217a5xjhew5fxodltwy7iemki","id":"217a5xjhew5fxodltwy7iemki","images":[{"height":300,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=1004010236378080&height=300&width=300&ext=1773122647&hash=AT9ts6axTlTXGHBw5YwCZ_uJ","width":300},{"height":64,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=1004010236378080&height=50&width=50&ext=1773122647&hash=AT9VJE-5fupCCDiU-l2uj9L_","width":64}],"product":"premium","type":"user","uri":"spotify:user:217a5xjhew5fxodltwy7iemki"} Feb 08 11:53:30 volumio-miro volumio[1208]: info: Spotify Successfully logged in Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 11:53:30 volumio-miro volumio[1208]: info: [1770548010425] CoreMusicLibrary::Adding element Spotify Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 11:53:30 volumio-miro volumio[1208]: Cannot find translation for source Spotify Feb 08 11:53:30 volumio-miro volumio[1991]: .......................................++++ Feb 08 11:53:30 volumio-miro volumio[1991]: e is 65537 (0x010001) Feb 08 11:53:30 volumio-miro volumio[1991]: writing RSA key Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Feb 08 11:53:30 volumio-miro volumio[1208]: info: MyVolumio login type: Token Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 11:53:30 volumio-miro volumio[1208]: info: Received Get System Info Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:30 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:30 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:30 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:30 volumio-miro volumio[1208]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 08 11:53:31 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Feb 08 11:53:31 volumio-miro volumio[1208]: info: MyVolumio login type: Token Feb 08 11:53:31 volumio-miro volumio[1208]: STREAMING PROXY: Starting server on port 3245 Feb 08 11:53:31 volumio-miro volumio[1208]: Node JS runtime: 14 Feb 08 11:53:31 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:31 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:31 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:31 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:31 volumio-miro volumio[1208]: info: MyVolumio token set successfully Feb 08 11:53:31 volumio-miro volumio[1208]: info: MYVOLUMIO: Adding device Feb 08 11:53:31 volumio-miro volumio[1208]: info: MYVOLUMIO: Evaluating Server Feb 08 11:53:32 volumio-miro volumio[1208]: info: MyVolumio Plan changed: premium Feb 08 11:53:32 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Feb 08 11:53:32 volumio-miro volumio[1208]: info: Removing browser output: myVolumio user plan is not superstar Feb 08 11:53:32 volumio-miro volumio[1208]: info: Removing audio output: Feb 08 11:53:32 volumio-miro volumio[1208]: info: MYVOLUMIO: Adding device Feb 08 11:53:32 volumio-miro volumio[1208]: info: MYVOLUMIO: Evaluating Server Feb 08 11:53:32 volumio-miro volumio[1208]: info: Remote config written successfully Feb 08 11:53:32 volumio-miro volumio[1208]: info: Starting Tunnel 1 Feb 08 11:53:32 volumio-miro volumio[1208]: info: Starting Tunnel Connection Checker Feb 08 11:53:32 volumio-miro volumio[1208]: info: Completed starting MyVolumio Plugin Feb 08 11:53:32 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:32 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:32 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:32 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:32 volumio-miro volumio[1208]: info: MYVolumio Device enabled Feb 08 11:53:32 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Feb 08 11:53:32 volumio-miro volumio[1208]: info: MyVolumio status changed Feb 08 11:53:32 volumio-miro volumio[1208]: info: Streaming services startup Feb 08 11:53:32 volumio-miro volumio[1208]: info: Starting Streaming Daemon Feb 08 11:53:32 volumio-miro volumio[1208]: info: Setting Geolocation for MyVolumio to eu10 Feb 08 11:53:32 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:32 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:32 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:32 volumio-miro sudo[2181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 08 11:53:32 volumio-miro sudo[2181]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:32 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Feb 08 11:53:32 volumio-miro sudo[2181]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:32 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Feb 08 11:53:32 volumio-miro volumio[1208]: info: [1770548012750] Starting BluetoothController Feb 08 11:53:32 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Feb 08 11:53:33 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:33 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:33 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:33 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Feb 08 11:53:34 volumio-miro sudo[2191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Feb 08 11:53:34 volumio-miro sudo[2191]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:34 volumio-miro sudo[2191]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:34 volumio-miro volumio[1208]: info: MRS: MultiRoom plugin initialized Feb 08 11:53:34 volumio-miro volumio[1208]: info: MRS: STOPPING SNAPCLIENT Feb 08 11:53:34 volumio-miro volumio[1208]: info: MRS: Snap server stop Feb 08 11:53:34 volumio-miro volumio[1208]: info: MRS: STOPPING volumioStreaming Feb 08 11:53:34 volumio-miro sudo[2214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Feb 08 11:53:34 volumio-miro sudo[2217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Feb 08 11:53:34 volumio-miro sudo[2214]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:34 volumio-miro sudo[2220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Feb 08 11:53:34 volumio-miro sudo[2217]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:34 volumio-miro sudo[2220]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:34 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:34 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:34 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:34 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Feb 08 11:53:34 volumio-miro sudo[2232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Feb 08 11:53:34 volumio-miro sudo[2214]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:34 volumio-miro sudo[2232]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Feb 08 11:53:34 volumio-miro sudo[2232]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:34 volumio-miro sudo[2217]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:34 volumio-miro sudo[2220]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Feb 08 11:53:34 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Feb 08 11:53:34 volumio-miro volumio[1208]: info: Preparing to generate the ALSA configuration file Feb 08 11:53:34 volumio-miro volumio[1208]: info: Updating MyVolumio device info Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:34 volumio-miro volumio[1208]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 08 11:53:34 volumio-miro volumio[1208]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 08 11:53:34 volumio-miro volumio[1208]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 08 11:53:34 volumio-miro volumio[1208]: info: Reading ALSA contributions from plugins. Feb 08 11:53:34 volumio-miro volumio[1208]: info: Setting Geolocation for MyVolumio to eu4 Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 11:53:34 volumio-miro volumio[1208]: info: Received Get System Info Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:34 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:34 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 11:53:34 volumio-miro volumio[1208]: info: Received Get System Info Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:34 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:34 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:34 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:34 volumio-miro volumio[1208]: info: MRS: Removed streaming files Feb 08 11:53:34 volumio-miro volumio[1208]: info: MRS: volumioStreaming STOPPED Feb 08 11:53:34 volumio-miro volumio[1208]: info: MRS: SNAPSERVER STOPPED Feb 08 11:53:34 volumio-miro volumio[1208]: info: MRS: SNAPCLIENT STOPPED Feb 08 11:53:34 volumio-miro volumio[1208]: error: Cannot start Volumio Streaming Daemon Feb 08 11:53:34 volumio-miro volumio[1208]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 08 11:53:34 volumio-miro volumio[1208]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 08 11:53:34 volumio-miro volumio[1208]: info: Asound.conf file written Feb 08 11:53:34 volumio-miro sudo[2254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 08 11:53:34 volumio-miro sudo[2254]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:34 volumio-miro sudo[2254]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:34 volumio-miro volumio[1208]: info: Output device has changed, restarting MPD Feb 08 11:53:35 volumio-miro volumio[1208]: info: Output device has changed, restarting Shairport Sync Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:35 volumio-miro sudo[2266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 11:53:35 volumio-miro sudo[2268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 11:53:35 volumio-miro sudo[2266]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:35 volumio-miro sudo[2266]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:35 volumio-miro sudo[2268]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:35 volumio-miro volumio[1208]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro systemd[1]: Stopping Music Player Daemon... Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Feb 08 11:53:35 volumio-miro volumio[1208]: info: MRS: Pushing multiroomSync output for this device Feb 08 11:53:35 volumio-miro volumio[1208]: info: MRS: Pushing multiroomSync output Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding audio output: Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding audio output: Feb 08 11:53:35 volumio-miro volumio[1208]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 08 11:53:35 volumio-miro sudo[2289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Miro Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding METAVOLUMIO REST API Endpoints Feb 08 11:53:35 volumio-miro sudo[2289]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Feb 08 11:53:35 volumio-miro volumio[1208]: info: Preparing CD Folders Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding CD REST API Endpoints Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Feb 08 11:53:35 volumio-miro volumio[1208]: info: Starting UDEV Watcher for CD Feb 08 11:53:35 volumio-miro volumio[1208]: info: Detecting CD presence with UDEV Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding inputs REST Endpoints Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Feb 08 11:53:35 volumio-miro volumio[1208]: info: Scanning Audio Inputs Feb 08 11:53:35 volumio-miro systemd[1]: mpd.service: Succeeded. Feb 08 11:53:35 volumio-miro systemd[1]: Stopped Music Player Daemon. Feb 08 11:53:35 volumio-miro volumio[1208]: info: Checking against Known Cards name Feb 08 11:53:35 volumio-miro volumio[1208]: info: Checking against Known Cards name Feb 08 11:53:35 volumio-miro systemd[1]: Starting Music Player Daemon... Feb 08 11:53:35 volumio-miro volumio[1208]: info: Checking against Known Cards name Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding Server instance for streaming Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Feb 08 11:53:35 volumio-miro volumio[1208]: error: Hi Res Audio Failed Login: Missing Login Data Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding HIGHRESAUDIO REST API Endpoints Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Feb 08 11:53:35 volumio-miro volumio[1208]: info: Refreshing TIDAL token Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Feb 08 11:53:35 volumio-miro volumio[1208]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Feb 08 11:53:35 volumio-miro volumio[1208]: info: QobuzConnect: Starting Qobuz Connect socket and service Feb 08 11:53:35 volumio-miro sudo[2303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 11:53:35 volumio-miro sudo[2303]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:35 volumio-miro sudo[2301]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 11:53:35 volumio-miro volumio[1208]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Feb 08 11:53:35 volumio-miro volumio[1208]: info: Stopping AccessToken refresher cron for QOBUZ Feb 08 11:53:35 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:35 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:35 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:35 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:35 volumio-miro sudo[2312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 08 11:53:35 volumio-miro sudo[2301]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:35 volumio-miro sudo[2303]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:35 volumio-miro sudo[2312]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:35 volumio-miro sudo[2301]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:35 volumio-miro volumio[1208]: info: AccessToken refresher cron started for QOBUZ Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding QOBUZ REST API Endpoints Feb 08 11:53:35 volumio-miro volumio[1208]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Feb 08 11:53:35 volumio-miro sudo[2312]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:35 volumio-miro volumio[1208]: info: Successfully Added MyVolumio device Feb 08 11:53:35 volumio-miro sudo[2289]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:35 volumio-miro volumio[1208]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Feb 08 11:53:35 volumio-miro volumio[1208]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Feb 08 11:53:35 volumio-miro volumio[1208]: info: MPD Permissions set Feb 08 11:53:35 volumio-miro sudo[2335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 08 11:53:35 volumio-miro volumio[1208]: info: Bluetooth name changed to Volumio Miro Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro sudo[2335]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 08 11:53:35 volumio-miro systemd[1]: Started Volumio Qobuz Connect Service. Feb 08 11:53:35 volumio-miro sudo[2335]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: Starting Shairport Sync Feb 08 11:53:35 volumio-miro sudo[2356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 08 11:53:35 volumio-miro sudo[2356]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:35 volumio-miro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 08 11:53:35 volumio-miro systemd[1]: shairport-sync.service: Succeeded. Feb 08 11:53:35 volumio-miro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 08 11:53:35 volumio-miro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 08 11:53:35 volumio-miro sudo[2356]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:35 volumio-miro volumio[1208]: info: Executing endpoint qc_getconfig Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 08 11:53:35 volumio-miro qobuz-connect[2350]: 20260208 11:53:35.720 [2350.2350] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 08 11:53:35 volumio-miro volumio[1208]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 08 11:53:35 volumio-miro volumio[1208]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 08 11:53:35 volumio-miro volumio[1208]: info: Shairport-Sync Started Feb 08 11:53:35 volumio-miro volumio[1208]: info: Updating MyVolumio device info Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:35 volumio-miro qobuz-connect[2350]: 20260208 11:53:35.805 [2350.2350] INFO VolumeManager: [0x81416920]: Setting new playback volume: 75 Feb 08 11:53:35 volumio-miro qobuz-connect[2350]: 20260208 11:53:35.805 [2350.2350] INFO VolumeManager: [0x81416920]: Setting new mute state: 0 Feb 08 11:53:35 volumio-miro qobuz-connect[2350]: 20260208 11:53:35.805 [2350.2350] INFO QobuzConnect: [0x814172f0]: Client initialized! Feb 08 11:53:35 volumio-miro qobuz-connect[2350]: 20260208 11:53:35.805 [2350.2350] INFO SampleApp: Starting Avahi advertising, name: Volumio Miro, service name: _qobuz-connect._tcp Feb 08 11:53:35 volumio-miro qobuz-connect[2350]: 20260208 11:53:35.816 [2350.2350] INFO LocalConfigManager: [0x81416200]: Starting Local Configuration server Feb 08 11:53:35 volumio-miro qobuz-connect[2350]: 20260208 11:53:35.816 [2350.2350] INFO SampleApp: Starting Local configuration server Feb 08 11:53:35 volumio-miro qobuz-connect[2350]: 20260208 11:53:35.816 [2350.2350] INFO SampleApp: Connected to UNIX socket client 0x8140bed8 Feb 08 11:53:35 volumio-miro qobuz-connect[2350]: 20260208 11:53:35.870 [2350.2350] INFO SampleApp: Playback volume changed: 75 Feb 08 11:53:35 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:35 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:36 volumio-miro systemd[1]: systemd-timedated.service: Succeeded. Feb 08 11:53:36 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:36 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:36 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:36 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:36 volumio-miro mpd[2343]: Feb 08 11:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 11:53:36 volumio-miro systemd[1]: Started Music Player Daemon. Feb 08 11:53:36 volumio-miro sudo[2268]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:36 volumio-miro volumio[1208]: error: updateQueue error: null Feb 08 11:53:37 volumio-miro sudo[2398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Feb 08 11:53:37 volumio-miro sudo[2398]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:37 volumio-miro systemd[1]: Started MyVolumio SSH Tunnel. Feb 08 11:53:37 volumio-miro sudo[2398]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:37 volumio-miro volumio[1208]: info: Remote SSH Started Feb 08 11:53:37 volumio-miro autossh[2406]: port set to 0, monitoring disabled Feb 08 11:53:37 volumio-miro autossh[2406]: starting ssh (count 1) Feb 08 11:53:37 volumio-miro autossh[2406]: ssh child pid is 2411 Feb 08 11:53:37 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:37 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:37 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:37 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:38 volumio-miro sudo[2413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Feb 08 11:53:38 volumio-miro sudo[2413]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:38 volumio-miro systemd[1]: Started Volumio Bluetooth Module. Feb 08 11:53:38 volumio-miro sudo[2413]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:38 volumio-miro sudo[2421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Feb 08 11:53:38 volumio-miro volumio[1208]: info: Volumio BT Module successfully started Feb 08 11:53:38 volumio-miro sudo[2421]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:38 volumio-miro volumiobt[2419]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Feb 08 11:53:38 volumio-miro sudo[2421]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:38 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:38 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:38 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:38 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:38 volumio-miro volumio[1208]: info: TidalConnect service stoped! Feb 08 11:53:38 volumio-miro volumio[1208]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 08 11:53:38 volumio-miro volumio[1208]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 08 11:53:38 volumio-miro sudo[2442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 08 11:53:38 volumio-miro sudo[2442]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:38 volumio-miro systemd[1]: Started Volumio Tidal Connect Service. Feb 08 11:53:38 volumio-miro volumiossh-tunnel[2404]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Feb 08 11:53:38 volumio-miro sudo[2442]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:38 volumio-miro volumiossh-tunnel[2404]: Warning: remote port forwarding failed for listen port 8091 Feb 08 11:53:38 volumio-miro volumio[1208]: info: Executing endpoint tc_getconfig Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 08 11:53:38 volumio-miro vtcs[2448]: STARTING TidalConnect services, version: 1.5.2.56 Feb 08 11:53:38 volumio-miro vtcs[2448]: STARTED TidalConnect services. Feb 08 11:53:38 volumio-miro volumio[1208]: info: Executing endpoint tc_connect Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 08 11:53:38 volumio-miro volumio[1208]: info: Connecting to TidalConnect Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreCommandRouter::servicePushState Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreStateMachine::pushState Feb 08 11:53:38 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioPushState Feb 08 11:53:38 volumio-miro volumio[1208]: info: MRS: Pushing multiroomSync output update for this device Feb 08 11:53:38 volumio-miro volumio[1208]: info: MRS: Pushing multiroomSync output Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:38 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:38 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:38 volumio-miro volumio[1208]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received tidalconnect Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreCommandRouter::servicePushState Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreStateMachine::pushState Feb 08 11:53:38 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioPushState Feb 08 11:53:38 volumio-miro volumio[1208]: info: MRS: Pushing multiroomSync output update for this device Feb 08 11:53:38 volumio-miro volumio[1208]: info: MRS: Pushing multiroomSync output Feb 08 11:53:38 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:38 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:38 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:38 volumio-miro volumio[1208]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received tidalconnect Feb 08 11:53:39 volumio-miro volumio[1208]: info: ONKYO-CONTROL: New state: {"status":"stop","position":0,"title":"Avril 14th","artist":"Aphex Twin","album":"Drukqs","albumart":"https://i.scdn.co/image/ab67616d0000b2732e261a0b1b19d0ff95e346b3","uri":"spotify:track:1uaGSDFsLdReQgg8p7Obwh","trackType":"spotify","codec":"ogg","seek":0,"duration":125,"samplerate":"320 kbps","bitdepth":"16 bit","random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":"100","dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","updatedb":false,"volatile":false,"service":"spop"} connection: {"reconnect":true,"verify_commands":false,"port":60128,"host":"192.168.68.126","model":"TX-RZ3400"} Feb 08 11:53:39 volumio-miro volumio[1208]: info: ONKYO-CONTROL: New state: {"status":"stop","position":0,"title":"Avril 14th","artist":"Aphex Twin","album":"Drukqs","albumart":"https://i.scdn.co/image/ab67616d0000b2732e261a0b1b19d0ff95e346b3","uri":"spotify:track:1uaGSDFsLdReQgg8p7Obwh","trackType":"spotify","codec":"ogg","seek":0,"duration":125,"samplerate":"320 kbps","bitdepth":"16 bit","random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":"100","dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","updatedb":false,"volatile":false,"service":"spop"} connection: {"reconnect":true,"verify_commands":false,"port":60128,"host":"192.168.68.126","model":"TX-RZ3400"} Feb 08 11:53:39 volumio-miro volumio[1208]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 11:53:39 volumio-miro volumio[1208]: SPOTIFY: SPOTIFY VOLUME 100 Feb 08 11:53:39 volumio-miro volumio[1208]: SPOTIFY: VOLUMIO VOLUME 100 Feb 08 11:53:39 volumio-miro volumio[1208]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 08 11:53:39 volumio-miro volumio[1208]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 11:53:39 volumio-miro volumio[1208]: SPOTIFY: SPOTIFY VOLUME 100 Feb 08 11:53:39 volumio-miro volumio[1208]: SPOTIFY: VOLUMIO VOLUME 100 Feb 08 11:53:39 volumio-miro volumio[1208]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 08 11:53:39 volumio-miro sudo[2470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Feb 08 11:53:39 volumio-miro sudo[2470]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:39 volumio-miro volumiobt[2419]: pulseaudio: no process found Feb 08 11:53:39 volumio-miro sudo[2470]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:39 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:39 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:39 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:39 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:39 volumio-miro dbus-daemon[554]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.25' (uid=1000 pid=2481 comm="/usr/bin/pulseaudio --high-priority=true ") Feb 08 11:53:39 volumio-miro systemd[1]: Starting RealtimeKit Scheduling Policy Service... Feb 08 11:53:39 volumio-miro kernel: IPVS: Creating netns size=1496 id=2 Feb 08 11:53:39 volumio-miro kernel: IPVS: ftp: loaded support on port[0] = 21 Feb 08 11:53:39 volumio-miro volumio[1208]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 08 11:53:39 volumio-miro dbus-daemon[554]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Feb 08 11:53:39 volumio-miro systemd[1]: Started RealtimeKit Scheduling Policy Service. Feb 08 11:53:39 volumio-miro rtkit-daemon[2482]: Successfully called chroot. Feb 08 11:53:39 volumio-miro rtkit-daemon[2482]: Successfully dropped privileges. Feb 08 11:53:39 volumio-miro rtkit-daemon[2482]: Successfully limited resources. Feb 08 11:53:39 volumio-miro rtkit-daemon[2482]: Running. Feb 08 11:53:39 volumio-miro rtkit-daemon[2482]: Watchdog thread running. Feb 08 11:53:39 volumio-miro rtkit-daemon[2482]: Canary thread running. Feb 08 11:53:39 volumio-miro dbus-daemon[554]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.26' (uid=0 pid=2482 comm="/usr/lib/rtkit/rtkit-daemon ") Feb 08 11:53:39 volumio-miro systemd[1]: Starting Authorization Manager... Feb 08 11:53:39 volumio-miro volumio[1208]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 08 11:53:39 volumio-miro polkitd[2486]: started daemon version 0.105 using authority implementation `local' version `0.105' Feb 08 11:53:39 volumio-miro dbus-daemon[554]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Feb 08 11:53:39 volumio-miro systemd[1]: Started Authorization Manager. Feb 08 11:53:39 volumio-miro sudo[2494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Feb 08 11:53:39 volumio-miro sudo[2494]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:39 volumio-miro systemd[1]: Stopping MPD Monitor Service... Feb 08 11:53:39 volumio-miro systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Feb 08 11:53:39 volumio-miro systemd[1]: mpd_monitor.service: Succeeded. Feb 08 11:53:39 volumio-miro systemd[1]: Stopped MPD Monitor Service. Feb 08 11:53:39 volumio-miro volumio[1208]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 08 11:53:39 volumio-miro systemd[1]: Started MPD Monitor Service. Feb 08 11:53:39 volumio-miro sudo[2494]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:39 volumio-miro volumio[1208]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 08 11:53:39 volumio-miro mpd_monitor.sh[2500]: MPD Monitor Service: Starting MPD Monitor Service Feb 08 11:53:39 volumio-miro volumio[1208]: info: Successfully started MPD Monitor Feb 08 11:53:39 volumio-miro pulseaudio[2481]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 08 11:53:39 volumio-miro pulseaudio[2481]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 08 11:53:39 volumio-miro volumiobt[2419]: Applying permissions Feb 08 11:53:39 volumio-miro volumiobt[2419]: Setting BT discoverable and pairable Feb 08 11:53:39 volumio-miro bluetoothd[604]: Endpoint registered: sender=:1.46 path=/MediaEndpoint/A2DPSource Feb 08 11:53:39 volumio-miro bluetoothd[604]: Endpoint registered: sender=:1.46 path=/MediaEndpoint/A2DPSink Feb 08 11:53:39 volumio-miro pulseaudio[2481]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Feb 08 11:53:40 volumio-miro volumiobt[2419]: [96B blob data] Feb 08 11:53:40 volumio-miro volumiobt[2419]: [77B blob data] Feb 08 11:53:40 volumio-miro volumiobt[2419]: [77B blob data] Feb 08 11:53:40 volumio-miro volumiobt[2419]: [33B blob data] Feb 08 11:53:40 volumio-miro volumiobt[2419]: [65B blob data] Feb 08 11:53:40 volumio-miro volumiobt[2419]: [103B blob data] Feb 08 11:53:40 volumio-miro volumiobt[2419]: [bluetoothctl]> -e power on Feb 08 11:53:40 volumio-miro volumiobt[2419]: Invalid command in menu main: -e Feb 08 11:53:40 volumio-miro volumiobt[2419]: Feb 08 11:53:40 volumio-miro volumiobt[2419]: Use "help" for a list of available commands in a menu. Feb 08 11:53:40 volumio-miro volumiobt[2419]: Use "menu " if you want to enter any submenu. Feb 08 11:53:40 volumio-miro volumiobt[2419]: Use "back" if you want to return to menu main. Feb 08 11:53:40 volumio-miro volumiobt[2419]: [bluetoothctl]> agent on Feb 08 11:53:40 volumio-miro volumiobt[2419]: Agent is already registered Feb 08 11:53:40 volumio-miro volumiobt[2419]: [bluetoothctl]> discoverable on Feb 08 11:53:40 volumio-miro volumiobt[2419]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Feb 08 11:53:40 volumio-miro volumiobt[2419]: [bluetoothctl]> pairable on Feb 08 11:53:40 volumio-miro volumiobt[2419]: [bluetoothctl]> agent NoInputNoOutput Feb 08 11:53:40 volumio-miro volumiobt[2419]: Agent is already registered Feb 08 11:53:40 volumio-miro volumiobt[2419]: [bluetoothctl]> default-agent Feb 08 11:53:40 volumio-miro volumiobt[2419]: [bluetoothctl]> quit Feb 08 11:53:40 volumio-miro volumiobt[2419]: [65B blob data] Feb 08 11:53:40 volumio-miro volumio[1208]: info: MRS: Getting audio outputs on start Feb 08 11:53:40 volumio-miro volumio[1208]: info: MRS: Requesting all other devices output Feb 08 11:53:40 volumio-miro volumio[1208]: info: Successfully Added MyVolumio device Feb 08 11:53:40 volumio-miro volumio[1208]: info: Successfully Updated MyVolumio device Feb 08 11:53:40 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:40 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:40 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:40 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:41 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:41 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:41 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:41 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:41 volumio-miro volumio[1208]: info: TidalConnect service started! Feb 08 11:53:41 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 11:53:41 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:41 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 08 11:53:42 volumio-miro volumio-remote-updater[566]: No test mode Feb 08 11:53:42 volumio-miro volumio-remote-updater[566]: No alpha test mode Feb 08 11:53:42 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 08 11:53:42 volumio-miro volumio[1208]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 08 11:53:42 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 08 11:53:42 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:42 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:42 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:42 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:42 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 11:53:42 volumio-miro volumio[1208]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 08 11:53:42 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 08 11:53:42 volumio-miro volumio[1208]: info: Received Get System Version Feb 08 11:53:42 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 11:53:42 volumio-miro volumio[1208]: info: Received Get System Info Feb 08 11:53:42 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:42 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:42 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:42 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:42 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:42 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:43 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:43 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:43 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:43 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:43 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 11:53:44 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:44 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:44 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:44 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:44 volumio-miro volumio[1208]: info: MRS: Found cast device: Onkyo-TX-RZ3400-182e0856e2764fe8aa07c3598a981577 Feb 08 11:53:44 volumio-miro volumio[1208]: info: Adding audio output: Feb 08 11:53:44 volumio-miro volumio[1208]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 08 11:53:44 volumio-miro volumio[1208]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Feb 08 11:53:44 volumio-miro volumio[1208]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 08 11:53:44 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:44 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:44 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:44 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:45 volumio-miro volumio[1208]: info: Access Token successfully retrieved Feb 08 11:53:45 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:45 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:45 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:45 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:45 volumio-miro volumio[1208]: info: Successfully retrieved User Session From TIDAL Feb 08 11:53:45 volumio-miro volumio[1208]: info: Successfully Updated MyVolumio device Feb 08 11:53:45 volumio-miro volumio[1208]: info: Successfully retrieved User Subscription From TIDAL Feb 08 11:53:45 volumio-miro volumio[1208]: info: Adding TIDAL to Browse Sources Feb 08 11:53:45 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 11:53:45 volumio-miro volumio[1208]: info: [1770548025673] CoreMusicLibrary::Adding element TIDAL Feb 08 11:53:45 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 11:53:45 volumio-miro volumio[1208]: Cannot find translation for source Spotify Feb 08 11:53:45 volumio-miro volumio[1208]: Cannot find translation for source TIDAL Feb 08 11:53:45 volumio-miro volumio[1208]: info: Adding TIDAL REST API Endpoints Feb 08 11:53:45 volumio-miro volumio[1208]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Feb 08 11:53:45 volumio-miro volumio[1208]: [Metrics] CommandRouter: 41s 552.27ms Feb 08 11:53:45 volumio-miro volumio[1208]: info: CoreCommandRouter::volumiosetStartupVolume Feb 08 11:53:45 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:45 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 11:53:45 volumio-miro volumio[1208]: info: CoreCommandRouter::Close All Modals sent Feb 08 11:53:45 volumio-miro volumio[1208]: info: CoreCommandRouter::Close All Modals sent Feb 08 11:53:45 volumio-miro volumio[1208]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 08 11:53:45 volumio-miro volumio[1208]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 08 11:53:45 volumio-miro volumio[1208]: info: camilladsp stopping service pid 1829... Feb 08 11:53:45 volumio-miro volumio[1208]: info: camilladsp service terminated, instance 1 Feb 08 11:53:45 volumio-miro volumio[1208]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 08 11:53:45 volumio-miro volumio[1208]: info: FusionDsp - crossfeed bauer Feb 08 11:53:45 volumio-miro volumio[1208]: info: camilladsp service started and running in background, instance 1 Feb 08 11:53:46 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:46 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:46 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:46 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:46 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 08 11:53:46 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 08 11:53:46 volumio-miro volumio[1208]: No protocol specified Feb 08 11:53:46 volumio-miro volumio[1208]: xcb_connection_has_error() returned true Feb 08 11:53:46 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 08 11:53:47 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:47 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:47 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:47 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:48 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.102:3000 from 192.168.68.118 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Feb 08 11:53:48 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.104:3000 from 192.168.68.118 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.102:3000 from 192.168.68.118 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 12 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 08 11:53:48 volumio-miro sudo[2547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 08 11:53:48 volumio-miro sudo[2547]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro sudo[2553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 08 11:53:48 volumio-miro sudo[2547]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:48 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:48 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:48 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:48 volumio-miro sudo[2553]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro sudo[2563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 08 11:53:48 volumio-miro sudo[2567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 08 11:53:48 volumio-miro sudo[2574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 11:53:48 volumio-miro sudo[2553]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro sudo[2563]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro sudo[2574]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro sudo[2567]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro sudo[2584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 11:53:48 volumio-miro sudo[2563]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro sudo[2567]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro sudo[2574]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro sudo[2584]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro sudo[2584]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.104:3000 from 192.168.68.118 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.104:3000 from 192.168.68.118 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 12 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 08 11:53:48 volumio-miro sudo[2621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 08 11:53:48 volumio-miro sudo[2621]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro sudo[2627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 08 11:53:48 volumio-miro sudo[2627]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro sudo[2621]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro sudo[2636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 08 11:53:48 volumio-miro sudo[2627]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro sudo[2636]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro sudo[2651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 11:53:48 volumio-miro sudo[2642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 08 11:53:48 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.102:3000 from 192.168.68.118 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 12 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetBrowseSources Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 11:53:48 volumio-miro sudo[2636]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro sudo[2642]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro sudo[2651]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:48 volumio-miro sudo[2651]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro sudo[2660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 11:53:48 volumio-miro sudo[2642]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro sudo[2660]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro sudo[2660]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:48 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.104:3000 from 192.168.68.118 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 12 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:48 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:48 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:48 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:49 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:49 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:49 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:49 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:49 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:49 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:49 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.104:3000 from 192.168.68.118 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 12 Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:49 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:50 volumio-miro sudo[2695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 11:53:50 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:50 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:50 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:50 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:50 volumio-miro sudo[2695]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:50 volumio-miro sudo[2695]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:50 volumio-miro sudo[2701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 11:53:50 volumio-miro sudo[2701]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:50 volumio-miro sudo[2701]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:50 volumio-miro volumiologrotate[556]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Feb 08 11:53:50 volumio-miro volumiologrotate[556]: ls: cannot access 'MIRO': No such file or directory Feb 08 11:53:50 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.104 from 192.168.68.118 UA: Mozilla/5.0 (Linux; Android 16; 24030PN60G Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 08 11:53:50 volumio-miro sudo[2759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 11:53:50 volumio-miro sudo[2759]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:50 volumio-miro sudo[2762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 11:53:50 volumio-miro sudo[2759]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:50 volumio-miro sudo[2762]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 08 11:53:50 volumio-miro sudo[2762]: pam_unix(sudo:session): session closed for user root Feb 08 11:53:50 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.104 from 192.168.68.118 UA: Mozilla/5.0 (Linux; Android 16; 24030PN60G Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Feb 08 11:53:50 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:50 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:50 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 08 11:53:50 volumio-miro volumio[1208]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 08 11:53:50 volumio-miro volumio[1208]: info: Listing playlists Feb 08 11:53:50 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 11:53:50 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:50 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:50 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 11:53:51 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:51 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:51 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:51 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:52 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:52 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:52 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:52 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:52 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 11:53:52 volumio-miro volumio[1208]: info: Received Get System Info Feb 08 11:53:52 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:52 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:52 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:52 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:52 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:52 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:52 volumio-miro volumio[1208]: info: BOOT COMPLETED Feb 08 11:53:53 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:53 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:53 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:53 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:53 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 11:53:53 volumio-miro volumio[1208]: info: Received Get System Info Feb 08 11:53:53 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:53 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:53 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:53 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:53 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:53 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:53 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 11:53:53 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 08 11:53:54 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:54 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:54 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:54 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:55 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:55 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:55 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:55 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:56 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:56 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:56 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:56 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:57 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:57 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:57 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:57 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:57 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:57+01:00" level=trace msg="sent dealer ping" Feb 08 11:53:57 volumio-miro go-librespot[1736]: time="2026-02-08T11:53:57+01:00" level=trace msg="received dealer pong" Feb 08 11:53:58 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:58 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:58 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:58 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:58 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:53:58 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:53:58 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:53:58 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:53:58 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:53:58 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:53:58 volumio-miro volumio[1208]: verbose: New Socket.io Connection to 192.168.68.104:3000 from 192.168.68.118 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 14 Feb 08 11:53:58 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 11:53:58 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 11:53:59 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:59 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:59 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:53:59 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:53:59 volumio-miro volumio[1208]: info: MRS: Found cast device: Onkyo-TX-RZ3400-182e0856e2764fe8aa07c3598a981577 Feb 08 11:54:00 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:00 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:00 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:00 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:01 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:01 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:01 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:01 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:02 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:02 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:02 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:02 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:03 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:03 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:03 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:03 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:04 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:04 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:04 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:04 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:05 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:05 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:05 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:05 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:06 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:06 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:06 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:06 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:07 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:07 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:07 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:07 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:08 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:08 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:08 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:08 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:09 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:09 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:09 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:09 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:10 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:10 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:10 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:10 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:10 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 11:54:10 volumio-miro volumio[1208]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 08 11:54:10 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 08 11:54:10 volumio-miro volumio[1208]: info: Received Get System Version Feb 08 11:54:10 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 11:54:10 volumio-miro volumio[1208]: info: Received Get System Info Feb 08 11:54:10 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 11:54:10 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 11:54:10 volumio-miro volumio[1208]: info: Discovery: Getting this device information Feb 08 11:54:10 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:54:10 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:54:10 volumio-miro volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 11:54:11 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:11 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:11 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:11 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:11 volumio-miro volumio[1208]: info: Enabling plugin ampswitch Feb 08 11:54:11 volumio-miro volumio[1208]: info: Loading plugin "ampswitch"... Feb 08 11:54:11 volumio-miro volumio[1208]: info: Applying required configuration parameters for plugin ampswitch Feb 08 11:54:11 volumio-miro volumio[1208]: info: PLUGIN START: ampswitch Feb 08 11:54:11 volumio-miro kernel: rockchip-pinctrl pinctrl: pin 0 is unrouted Feb 08 11:54:11 volumio-miro volumio[1208]: info: Done. Feb 08 11:54:11 volumio-miro volumio[1208]: info: CoreCommandRouter::volumioGetState Feb 08 11:54:11 volumio-miro volumio[1208]: info: CorePlayQueue::getTrack 0 Feb 08 11:54:11 volumio-miro volumio[1208]: info: [ASDebug] CurState: stop PrevState: na Feb 08 11:54:11 volumio-miro volumio[1208]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Feb 08 11:54:11 volumio-miro volumio[1208]: info: [ASDebug] CurState: stop PrevState: na Feb 08 11:54:11 volumio-miro volumio[1208]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Feb 08 11:54:12 volumio-miro volumio[1208]: info: [ASDebug] Pulsing GPIO for 500ms Feb 08 11:54:12 volumio-miro lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:12 volumio-miro lircd[1871]: lircd-0.10.1[1871]: Error: could not get file information for /dev/lirc0 Feb 08 11:54:12 volumio-miro lircd[1871]: lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:12 volumio-miro volumio[1208]: info: [ASDebug] Togle GPIO: ON Feb 08 11:54:12 volumio-miro lircd-0.10.1[1871]: default_init(): No such file or directory Feb 08 11:54:12 volumio-miro volumio[1208]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 11:54:12 volumio-miro volumio[1208]: Error: EPERM: operation not permitted, write Feb 08 11:54:12 volumio-miro volumio[1208]: at Object.writeSync (fs.js:737:3) Feb 08 11:54:12 volumio-miro volumio[1208]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) Feb 08 11:54:12 volumio-miro volumio[1208]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:209:23) Feb 08 11:54:12 volumio-miro volumio[1208]: at AmpSwitchController.pulse (/data/plugins/system_controller/ampswitch/index.js:231:8) Feb 08 11:54:12 volumio-miro volumio[1208]: at Timeout._onTimeout (/data/plugins/system_controller/ampswitch/index.js:195:39) Feb 08 11:54:12 volumio-miro volumio[1208]: at listOnTimeout (internal/timers.js:557:17) Feb 08 11:54:12 volumio-miro volumio[1208]: at processTimers (internal/timers.js:500:7) { Feb 08 11:54:12 volumio-miro volumio[1208]: errno: -1, Feb 08 11:54:12 volumio-miro volumio[1208]: syscall: 'write', Feb 08 11:54:12 volumio-miro volumio[1208]: code: 'EPERM' Feb 08 11:54:12 volumio-miro volumio[1208]: } Feb 08 11:54:12 volumio-miro volumio[1208]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 11:54:12 volumio-miro sudo[2831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-08 11:53 Feb 08 11:54:12 volumio-miro sudo[2831]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:03:54 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="35e446ff98e90abcfcab1bb2733dfd3a"