-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-06-22 10:31:44 CEST. -- Jun 22 10:31:27 pibox-volumio systemd-timedated[1070]: Changed local time to Sun Jun 22 10:31:27 2025 Jun 22 10:31:27 pibox-volumio volumio[941]: info: Loading plugin "services"... Jun 22 10:31:27 pibox-volumio volumio[941]: info: Loading plugin "alsa_controller"... Jun 22 10:31:27 pibox-volumio sudo[1074]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:27 pibox-volumio sudo[1068]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:27 pibox-volumio volumio-time-update[669]: volumio-time-update-util: System time updated successfully. Jun 22 10:31:27 pibox-volumio systemd[1]: Started Volumio Time Update Utility. Jun 22 10:31:27 pibox-volumio systemd[1]: Starting Daily apt download activities... Jun 22 10:31:27 pibox-volumio systemd[1]: Reached target Multi-User System. Jun 22 10:31:27 pibox-volumio systemd[1]: Reached target Graphical Interface. Jun 22 10:31:27 pibox-volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 22 10:31:27 pibox-volumio systemd[1]: Starting Daily man-db regeneration... Jun 22 10:31:27 pibox-volumio ntpd[1001]: Soliciting pool server 195.201.19.162 Jun 22 10:31:27 pibox-volumio ntpd[1001]: Soliciting pool server 116.203.244.102 Jun 22 10:31:27 pibox-volumio ntpd[1001]: Soliciting pool server 82.165.53.158 Jun 22 10:31:27 pibox-volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 22 10:31:27 pibox-volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 22 10:31:27 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 10:31:27 pibox-volumio volumio[941]: info: Loading plugin "wizard"... Jun 22 10:31:27 pibox-volumio volumio[941]: info: Loading plugin "networkfs"... Jun 22 10:31:27 pibox-volumio volumio[941]: info: Starting Udev Watcher for removable devices Jun 22 10:31:27 pibox-volumio sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=thomas,password=Wu95iabM-nasbox,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.111/music /mnt/NAS/NASBox Jun 22 10:31:27 pibox-volumio sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:27 pibox-volumio volumio[941]: info: Ignoring mount for partition: boot Jun 22 10:31:27 pibox-volumio volumio[941]: info: Ignoring mount for partition: volumio Jun 22 10:31:27 pibox-volumio volumio[941]: info: Ignoring mount for partition: volumio_data Jun 22 10:31:27 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 10:31:27 pibox-volumio volumio[941]: info: Loading plugin "volumio_command_line_client"... Jun 22 10:31:28 pibox-volumio ntpd[1001]: Soliciting pool server 130.61.133.198 Jun 22 10:31:28 pibox-volumio ntpd[1001]: Soliciting pool server 5.75.152.43 Jun 22 10:31:28 pibox-volumio volumio[941]: info: Loading plugin "upnp"... Jun 22 10:31:28 pibox-volumio volumio[941]: info: [1750581088330] Starting Upmpd Daemon Jun 22 10:31:28 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 10:31:28 pibox-volumio volumio[941]: info: Loading plugin "my_music"... Jun 22 10:31:28 pibox-volumio volumio[941]: info: Loading plugin "mpd"... Jun 22 10:31:28 pibox-volumio volumio-remote-updater[655]: [2025-06-22 10:31:28] [connect] Successful connection Jun 22 10:31:28 pibox-volumio systemd[1]: man-db.service: Succeeded. Jun 22 10:31:28 pibox-volumio systemd[1]: Started Daily man-db regeneration. Jun 22 10:31:28 pibox-volumio kernel: Key type cifs.spnego registered Jun 22 10:31:28 pibox-volumio kernel: Key type cifs.idmap registered Jun 22 10:31:28 pibox-volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Jun 22 10:31:28 pibox-volumio kernel: CIFS: Attempting to mount //192.168.1.111/music Jun 22 10:31:29 pibox-volumio ntpd[1001]: Soliciting pool server 185.13.148.71 Jun 22 10:31:29 pibox-volumio ntpd[1001]: Soliciting pool server 2001:678:b28::123 Jun 22 10:31:29 pibox-volumio volumio[941]: info: Loading plugin "upnp_browser"... Jun 22 10:31:29 pibox-volumio kernel: cryptd: max_cpu_qlen set to 1000 Jun 22 10:31:29 pibox-volumio sudo[1108]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:30 pibox-volumio volumio[941]: info: Loading plugin "alarm-clock"... Jun 22 10:31:30 pibox-volumio volumio[941]: info: Loading plugin "airplay_emulation"... Jun 22 10:31:30 pibox-volumio volumio[941]: info: Starting Shairport Sync Jun 22 10:31:30 pibox-volumio volumio[941]: info: Loading plugin "last_100"... Jun 22 10:31:30 pibox-volumio volumio[941]: info: Loading plugin "webradio"... Jun 22 10:31:30 pibox-volumio volumio[941]: info: Loading plugin "i2s_dacs"... Jun 22 10:31:30 pibox-volumio volumio[941]: info: Loading plugin "volumiodiscovery"... Jun 22 10:31:30 pibox-volumio volumio[941]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 22 10:31:30 pibox-volumio node[941]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 22 10:31:30 pibox-volumio volumio[941]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 10:31:30 pibox-volumio node[941]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 10:31:30 pibox-volumio volumio[941]: *** WARNING *** For more information see Jun 22 10:31:30 pibox-volumio node[941]: *** WARNING *** For more information see Jun 22 10:31:30 pibox-volumio volumio[941]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 22 10:31:30 pibox-volumio node[941]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 22 10:31:30 pibox-volumio volumio[941]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 10:31:30 pibox-volumio node[941]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 10:31:30 pibox-volumio volumio[941]: *** WARNING *** For more information see Jun 22 10:31:30 pibox-volumio node[941]: *** WARNING *** For more information see Jun 22 10:31:30 pibox-volumio volumio[941]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 22 10:31:30 pibox-volumio volumio[941]: info: Discovery: Started advertising with name: PiBox Volumio Jun 22 10:31:31 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 10:31:31 pibox-volumio volumio[941]: info: Loading plugin "autostart"... Jun 22 10:31:31 pibox-volumio volumio[941]: info: Applying required configuration parameters for plugin autostart Jun 22 10:31:31 pibox-volumio volumio[941]: info: AutoStart - onVolumioStart - read config.json Jun 22 10:31:31 pibox-volumio volumio[941]: info: Loading plugin "gpio-buttons"... Jun 22 10:31:32 pibox-volumio systemd[1]: apt-daily.service: Succeeded. Jun 22 10:31:32 pibox-volumio systemd[1]: Started Daily apt download activities. Jun 22 10:31:32 pibox-volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jun 22 10:31:32 pibox-volumio volumio[941]: info: GPIO-Buttons initialized Jun 22 10:31:32 pibox-volumio volumio[941]: info: Loading plugin "now_playing"... Jun 22 10:31:33 pibox-volumio ntpd[1001]: receive: Unexpected origin timestamp 0xec023de5.1b82a9b6 does not match aorg 0000000000.00000000 from server@116.203.244.102 xmt 0xec023de5.c8b2e366 Jun 22 10:31:33 pibox-volumio ntpd[1001]: receive: Unexpected origin timestamp 0xec023de5.1b85f8a7 does not match aorg 0000000000.00000000 from server@94.16.122.152 xmt 0xec023de5.c8ea0fe6 Jun 22 10:31:33 pibox-volumio ntpd[1001]: receive: Unexpected origin timestamp 0xec023de5.1b78a9b8 does not match aorg 0000000000.00000000 from server@5.75.152.43 xmt 0xec023de5.c89803f4 Jun 22 10:31:33 pibox-volumio ntpd[1001]: receive: Unexpected origin timestamp 0xec023de5.1b88fff8 does not match aorg 0000000000.00000000 from server@168.119.211.223 xmt 0xec023de5.c927c791 Jun 22 10:31:33 pibox-volumio ntpd[1001]: receive: Unexpected origin timestamp 0xec023de5.1b8d5a9e does not match aorg 0000000000.00000000 from server@185.252.140.125 xmt 0xec023de5.c9002b90 Jun 22 10:31:33 pibox-volumio ntpd[1001]: receive: Unexpected origin timestamp 0xec023de5.1b845a96 does not match aorg 0000000000.00000000 from server@185.252.140.126 xmt 0xec023de5.c91f750e Jun 22 10:31:34 pibox-volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jun 22 10:31:34 pibox-volumio systemd[1]: Started Daily apt upgrade and clean activities. Jun 22 10:31:34 pibox-volumio systemd[1]: Startup finished in 14.699s (kernel) + 25.317s (userspace) = 40.016s. Jun 22 10:31:36 pibox-volumio volumio[941]: info: Loading plugin "outputs"... Jun 22 10:31:36 pibox-volumio volumio[941]: info: Loading plugin "albumart"... Jun 22 10:31:36 pibox-volumio volumio[941]: info: Plugin example_plugin is not enabled Jun 22 10:31:36 pibox-volumio volumio[941]: info: Loading plugin "inputs"... Jun 22 10:31:36 pibox-volumio volumio[941]: info: Loading plugin "updater_comm"... Jun 22 10:31:36 pibox-volumio volumio[941]: info: Plugin mpdemulation is not enabled Jun 22 10:31:36 pibox-volumio volumio[941]: info: Loading plugin "rest_api"... Jun 22 10:31:36 pibox-volumio volumio[941]: info: Loading plugin "websocket"... Jun 22 10:31:36 pibox-volumio volumio[941]: info: Starting Socket.io Server version 2.3.0 Jun 22 10:31:36 pibox-volumio volumio[941]: info: Loading plugin "fusiondsp"... Jun 22 10:31:36 pibox-volumio volumio[941]: Forking 3 albumart workers Jun 22 10:31:37 pibox-volumio volumio[941]: info: Applying required configuration parameters for plugin fusiondsp Jun 22 10:31:37 pibox-volumio volumio[941]: info: Loading plugin "backup_restore"... Jun 22 10:31:37 pibox-volumio volumio[941]: Starting albumart workers Jun 22 10:31:37 pibox-volumio volumio[941]: Starting albumart workers Jun 22 10:31:38 pibox-volumio volumio[941]: Starting albumart workers Jun 22 10:31:38 pibox-volumio volumio[941]: info: Applying required configuration parameters for plugin backup_restore Jun 22 10:31:38 pibox-volumio volumio[941]: info: Loading plugin "ir_controller"... Jun 22 10:31:38 pibox-volumio volumio[941]: info: Applying required configuration parameters for plugin ir_controller Jun 22 10:31:39 pibox-volumio volumio[941]: info: Loading plugin "touch_display"... Jun 22 10:31:39 pibox-volumio volumio[941]: info: Applying required configuration parameters for plugin touch_display Jun 22 10:31:40 pibox-volumio volumio[941]: info: Loading i18n strings for locale de Jun 22 10:31:40 pibox-volumio volumio[941]: Updating browse sources language Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::initPlayerControls Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: Express server listening on port 3000 Jun 22 10:31:40 pibox-volumio volumio[941]: [Metrics] WebUI: 17s 293.05ms Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreStateMachine::resetVolumioState Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreStateMachine::getcurrentVolume Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioRetrievevolume Jun 22 10:31:40 pibox-volumio sudo[1312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 22 10:31:40 pibox-volumio sudo[1312]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:40 pibox-volumio sudo[1312]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:40 pibox-volumio sudo[1314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 22 10:31:40 pibox-volumio sudo[1314]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:40 pibox-volumio sudo[1314]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:40 pibox-volumio volumio[941]: info: Volumio Network Manager: Network status updated: 1 Jun 22 10:31:40 pibox-volumio volumio[941]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 22 10:31:40 pibox-volumio volumio[941]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jun 22 10:31:40 pibox-volumio volumio[941]: info: VolumeController:: Volume=20 Mute =false Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreStateMachine::pushState Jun 22 10:31:40 pibox-volumio volumio[941]: info: CorePlayQueue::getTrack 0 Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioPushState Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreStateMachine::updateTrackBlock Jun 22 10:31:40 pibox-volumio volumio[941]: info: CorePlayQueue::getTrackBlock Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioRetrievevolume Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 10:31:40 pibox-volumio volumio[941]: info: Reloading queue from file Jun 22 10:31:40 pibox-volumio volumio[941]: info: Setting Device type: Raspberry PI Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreStateMachine::setRepeat null single undefined Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreStateMachine::pushState Jun 22 10:31:40 pibox-volumio volumio[941]: info: CorePlayQueue::getTrack 0 Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioPushState Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreStateMachine::setRandom null Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreStateMachine::pushState Jun 22 10:31:40 pibox-volumio volumio[941]: info: CorePlayQueue::getTrack 0 Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioPushState Jun 22 10:31:40 pibox-volumio volumio[941]: info: Completed loading Core Plugins Jun 22 10:31:40 pibox-volumio volumio[941]: info: Preparing to generate the ALSA configuration file Jun 22 10:31:40 pibox-volumio volumio[941]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 22 10:31:40 pibox-volumio volumio[941]: info: Reading ALSA contributions from plugins. Jun 22 10:31:40 pibox-volumio sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 22 10:31:40 pibox-volumio sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:40 pibox-volumio volumio[941]: info: VolumeController:: Volume=20 Mute =false Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreStateMachine::pushState Jun 22 10:31:40 pibox-volumio volumio[941]: info: CorePlayQueue::getTrack 0 Jun 22 10:31:40 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioPushState Jun 22 10:31:41 pibox-volumio volumio[941]: info: Discovery: adding 3cff9780-dc7e-4e18-a0b9-fe9c201ff72b Jun 22 10:31:41 pibox-volumio volumio[941]: info: Discovery: Found device PiBox Volumio Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioGetState Jun 22 10:31:41 pibox-volumio volumio[941]: info: CorePlayQueue::getTrack 0 Jun 22 10:31:41 pibox-volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 22 10:31:41 pibox-volumio sudo[1326]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:41 pibox-volumio volumio[941]: info: Upmpdcli Daemon Started Jun 22 10:31:41 pibox-volumio volumio[941]: info: Asound.conf file unchanged, so no further update is needed Jun 22 10:31:41 pibox-volumio volumio[941]: info: Output device has changed, restarting MPD Jun 22 10:31:41 pibox-volumio volumio[941]: info: Output device has changed, restarting Shairport Sync Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 10:31:41 pibox-volumio sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 10:31:41 pibox-volumio sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:41 pibox-volumio sudo[1331]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:41 pibox-volumio sudo[1333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 10:31:41 pibox-volumio sudo[1333]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:41 pibox-volumio systemd[1]: Stopping Music Player Daemon... Jun 22 10:31:41 pibox-volumio volumio[941]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 22 10:31:41 pibox-volumio volumio[941]: info: ___________ START PLUGINS ___________ Jun 22 10:31:41 pibox-volumio volumio[941]: info: ControllerMpd::onStart: Initializing MPD Jun 22 10:31:41 pibox-volumio volumio[941]: info: Creating MPD Configuration file Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 10:31:41 pibox-volumio volumio[941]: info: [1750581101222] CoreMusicLibrary::Adding element Medienserver Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 10:31:41 pibox-volumio sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 10:31:41 pibox-volumio sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:41 pibox-volumio sudo[1342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 10:31:41 pibox-volumio sudo[1342]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:41 pibox-volumio sudo[1340]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 10:31:41 pibox-volumio volumio[941]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 10:31:41 pibox-volumio volumio[941]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 22 10:31:41 pibox-volumio systemd[1]: mpd.service: Succeeded. Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 10:31:41 pibox-volumio volumio[941]: info: [1750581101369] CoreMusicLibrary::Adding element Last_100 Jun 22 10:31:41 pibox-volumio systemd[1]: Stopped Music Player Daemon. Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 10:31:41 pibox-volumio volumio[941]: info: [1750581101378] CoreMusicLibrary::Adding element Webradio Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 10:31:41 pibox-volumio volumio[941]: info: Initializing BBC Radios Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 10:31:41 pibox-volumio volumio[941]: info: AutoStart - onStart Jun 22 10:31:41 pibox-volumio systemd[1]: Starting Music Player Daemon... Jun 22 10:31:41 pibox-volumio volumio[941]: info: GPIO-Buttons: Reading config and creating triggers... Jun 22 10:31:41 pibox-volumio volumio[941]: info: [now-playing] ConfigUpdater: config is up to date. Jun 22 10:31:41 pibox-volumio volumio[941]: info: Loading i18n strings for locale de Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:41 pibox-volumio volumio[941]: info: FusionDsp - mixtype--------------------- Hardware Jun 22 10:31:41 pibox-volumio volumio[941]: info: Loading i18n strings for locale de Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 10:31:41 pibox-volumio volumio[941]: info: Loading i18n strings for locale de Jun 22 10:31:41 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 10:31:41 pibox-volumio volumio[941]: info: Volumio Calling Home Jun 22 10:31:41 pibox-volumio sudo[1351]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 22 10:31:41 pibox-volumio sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:41 pibox-volumio sudo[1351]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 22 10:31:41 pibox-volumio sudo[1351]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:41 pibox-volumio volumio[941]: info: GPIO-Buttons started Jun 22 10:31:41 pibox-volumio volumio[941]: info: Preparing to generate the ALSA configuration file Jun 22 10:31:41 pibox-volumio sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Jun 22 10:31:41 pibox-volumio sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:41 pibox-volumio sudo[1375]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:41 pibox-volumio sudo[1378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jun 22 10:31:41 pibox-volumio sudo[1378]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:41 pibox-volumio sudo[1380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jun 22 10:31:41 pibox-volumio sudo[1380]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:41 pibox-volumio sudo[1384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jun 22 10:31:41 pibox-volumio sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:42 pibox-volumio sudo[1378]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:42 pibox-volumio systemd[1]: Reloading. Jun 22 10:31:42 pibox-volumio volumio[941]: info: [now-playing] App is listening on port 4004. Jun 22 10:31:42 pibox-volumio volumio[941]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jun 22 10:31:42 pibox-volumio volumio[941]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 22 10:31:42 pibox-volumio volumio[941]: info: Reading ALSA contributions from plugins. Jun 22 10:31:42 pibox-volumio volumio[941]: info: touch_display: Backlight interface detected. Jun 22 10:31:42 pibox-volumio volumio[941]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jun 22 10:31:42 pibox-volumio volumio[941]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Jun 22 10:31:42 pibox-volumio volumio[941]: info: MPD Permissions set Jun 22 10:31:42 pibox-volumio volumio[941]: info: MPD Permissions set Jun 22 10:31:42 pibox-volumio volumio[941]: info: Volumio called home Jun 22 10:31:42 pibox-volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jun 22 10:31:42 pibox-volumio volumio[941]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:42 pibox-volumio volumio[941]: info: touch_display: Raspberry Pi Foundation touch screen detected. Jun 22 10:31:42 pibox-volumio sudo[1408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jun 22 10:31:42 pibox-volumio sudo[1408]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:43 pibox-volumio sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jun 22 10:31:43 pibox-volumio volumio[941]: info: Starting Shairport Sync Jun 22 10:31:43 pibox-volumio sudo[1413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/10-0045/brightness Jun 22 10:31:43 pibox-volumio sudo[1413]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:43 pibox-volumio sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:43 pibox-volumio sudo[1413]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:43 pibox-volumio volumio[941]: info: Starting Shairport Sync Jun 22 10:31:43 pibox-volumio sudo[1408]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:43 pibox-volumio sudo[1410]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:43 pibox-volumio volumio[941]: info: Starting Shairport Sync Jun 22 10:31:43 pibox-volumio sudo[1416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 10:31:43 pibox-volumio sudo[1416]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:43 pibox-volumio sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 10:31:43 pibox-volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:43 pibox-volumio volumio[941]: info: CoreCommandRouter::volumioGetState Jun 22 10:31:43 pibox-volumio volumio[941]: info: CorePlayQueue::getTrack 0 Jun 22 10:31:43 pibox-volumio sudo[1424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 10:31:43 pibox-volumio sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:43 pibox-volumio volumio[941]: info: ir_controller: LIRC correctly updated. Jun 22 10:31:43 pibox-volumio volumio[941]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Jun 22 10:31:43 pibox-volumio systemd[1]: Reloading. Jun 22 10:31:43 pibox-volumio sudo[1380]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:43 pibox-volumio volumio[941]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jun 22 10:31:43 pibox-volumio volumio[941]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jun 22 10:31:43 pibox-volumio volumio[941]: info: touch_display: File permissions for backlight brightness control set. Jun 22 10:31:43 pibox-volumio volumio[941]: info: Asound.conf file unchanged, so no further update is needed Jun 22 10:31:43 pibox-volumio volumio[941]: info: Output device has changed, restarting MPD Jun 22 10:31:43 pibox-volumio volumio[941]: info: Output device has changed, restarting Shairport Sync Jun 22 10:31:43 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:43 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 10:31:43 pibox-volumio sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 10:31:43 pibox-volumio sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:43 pibox-volumio sudo[1433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 10:31:43 pibox-volumio sudo[1433]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:43 pibox-volumio sudo[1430]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:43 pibox-volumio volumio[941]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 22 10:31:43 pibox-volumio volumio[941]: info: ir_controller: Raspberry Pi revision code: a02082 Jun 22 10:31:43 pibox-volumio volumio[941]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jun 22 10:31:43 pibox-volumio volumio[941]: info: MPD Permissions set Jun 22 10:31:43 pibox-volumio volumio[941]: info: camilladsp service started and running in background, instance 1 Jun 22 10:31:43 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 10:31:43 pibox-volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jun 22 10:31:43 pibox-volumio volumio[941]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 22 10:31:43 pibox-volumio volumio[941]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 22 10:31:43 pibox-volumio volumio[941]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 22 10:31:43 pibox-volumio volumio[941]: info: FusionDsp loaded Jun 22 10:31:43 pibox-volumio volumio[941]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 10:31:43 pibox-volumio sudo[1466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 22 10:31:43 pibox-volumio sudo[1466]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:43 pibox-volumio volumio[941]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 22 10:31:43 pibox-volumio volumio[941]: info: Adding Signal Path Element [object Object] Jun 22 10:31:43 pibox-volumio volumio[941]: info: Adding fusiondspeq DSP Signal Path Element Jun 22 10:31:43 pibox-volumio volumio[941]: info: FusionDsp - ---- installed callbackRead Jun 22 10:31:43 pibox-volumio volumio[941]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 10:31:43 pibox-volumio volumio[941]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 22 10:31:43 pibox-volumio volumio[941]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 22 10:31:43 pibox-volumio volumio[941]: at onErrorNT (internal/child_process.js:465:16) Jun 22 10:31:43 pibox-volumio volumio[941]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 22 10:31:43 pibox-volumio volumio[941]: at runNextTicks (internal/process/task_queues.js:62:3) Jun 22 10:31:43 pibox-volumio volumio[941]: at listOnTimeout (internal/timers.js:523:9) Jun 22 10:31:43 pibox-volumio volumio[941]: at processTimers (internal/timers.js:497:7) { Jun 22 10:31:43 pibox-volumio volumio[941]: errno: -2, Jun 22 10:31:43 pibox-volumio volumio[941]: code: 'ENOENT', Jun 22 10:31:43 pibox-volumio volumio[941]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 22 10:31:43 pibox-volumio volumio[941]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 22 10:31:43 pibox-volumio volumio[941]: spawnargs: [ Jun 22 10:31:43 pibox-volumio volumio[941]: '-p', Jun 22 10:31:43 pibox-volumio volumio[941]: 9876, Jun 22 10:31:43 pibox-volumio volumio[941]: '-o', Jun 22 10:31:43 pibox-volumio volumio[941]: '/tmp/camilladsp.log', Jun 22 10:31:43 pibox-volumio volumio[941]: '-l', Jun 22 10:31:43 pibox-volumio volumio[941]: 'warn', Jun 22 10:31:43 pibox-volumio volumio[941]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 22 10:31:43 pibox-volumio volumio[941]: ] Jun 22 10:31:43 pibox-volumio volumio[941]: } Jun 22 10:31:43 pibox-volumio volumio[941]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 10:31:43 pibox-volumio mpd[1370]: Jun 22 10:31 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 22 10:31:44 pibox-volumio systemd[1]: Started Music Player Daemon. Jun 22 10:31:44 pibox-volumio systemd[1]: systemd-fsckd.service: Succeeded. Jun 22 10:31:44 pibox-volumio sudo[1342]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:44 pibox-volumio sudo[1333]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:44 pibox-volumio sudo[1384]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:44 pibox-volumio systemd[1]: Started FusionDsp Daemon. Jun 22 10:31:44 pibox-volumio systemd[1]: Stopping Music Player Daemon... Jun 22 10:31:44 pibox-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 22 10:31:44 pibox-volumio systemd[1]: shairport-sync.service: Succeeded. Jun 22 10:31:44 pibox-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 22 10:31:44 pibox-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 10:31:44 pibox-volumio sudo[1466]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:44 pibox-volumio sudo[1421]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:44 pibox-volumio sudo[1424]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:44 pibox-volumio sudo[1481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-22 10:30 Jun 22 10:31:44 pibox-volumio sudo[1481]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 10:31:44 pibox-volumio sudo[1416]: pam_unix(sudo:session): session closed for user root Jun 22 10:31:44 pibox-volumio volumio-remote-updater[655]: [2025-06-22 10:31:44] [connect] Successful connection Jun 22 10:31:44 pibox-volumio systemd[1]: mpd.service: Succeeded. Jun 22 10:31:44 pibox-volumio systemd[1]: Stopped Music Player Daemon. Jun 22 10:31:44 pibox-volumio systemd[1]: Starting Music Player Daemon... PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"