-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sun 2024-11-24 14:17:29 CET. -- Nov 24 14:17:18 volumio-lenny systemd-timedated[1061]: Changed local time to Sun Nov 24 14:17:18 2024 Nov 24 14:17:18 volumio-lenny sudo[1058]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:18 volumio-lenny volumio-time-update[487]: volumio-time-update-util: System time updated successfully. Nov 24 14:17:18 volumio-lenny systemd[1]: Starting Daily apt download activities... Nov 24 14:17:18 volumio-lenny systemd[1]: Starting Daily man-db regeneration... Nov 24 14:17:18 volumio-lenny systemd[1]: Started Volumio Time Update Utility. Nov 24 14:17:18 volumio-lenny winbindd[1057]: [2024/11/24 14:17:18.149298, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 24 14:17:18 volumio-lenny winbindd[1057]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 24 14:17:18 volumio-lenny winbindd[1057]: [2024/11/24 14:17:18.187617, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 24 14:17:18 volumio-lenny winbindd[1057]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 24 14:17:18 volumio-lenny systemd[1]: Started Samba Winbind Daemon. Nov 24 14:17:18 volumio-lenny systemd[1]: Starting Samba SMB Daemon... Nov 24 14:17:18 volumio-lenny systemd[1]: man-db.service: Succeeded. Nov 24 14:17:18 volumio-lenny systemd[1]: Started Daily man-db regeneration. Nov 24 14:17:18 volumio-lenny volumio[1027]: info: MYVOLUMIO Environment detected Nov 24 14:17:18 volumio-lenny systemd[1]: systemd-fsckd.service: Succeeded. Nov 24 14:17:18 volumio-lenny systemd[1]: apt-daily.service: Succeeded. Nov 24 14:17:18 volumio-lenny systemd[1]: Started Daily apt download activities. Nov 24 14:17:18 volumio-lenny winbindd[1057]: [2024/11/24 14:17:18.769353, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Nov 24 14:17:18 volumio-lenny winbindd[1057]: res_names->count = 3, expected 4 Nov 24 14:17:18 volumio-lenny smbd[1069]: [2024/11/24 14:17:18.799769, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 24 14:17:18 volumio-lenny smbd[1069]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Plugin folders cleanup Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning into folder /volumio/app/plugins/ Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning category audio_interface Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning category miscellanea Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning category music_service Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning category plugins.json Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning category system_controller Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning category user_interface Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning into folder /data/plugins/ Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning category audio_interface Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning category system_hardware Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Scanning category user_interface Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Plugin folders cleanup completed Nov 24 14:17:18 volumio-lenny volumio[1027]: info: ------------------------------------------- Nov 24 14:17:18 volumio-lenny volumio[1027]: info: ----- Core plugins startup ---- Nov 24 14:17:18 volumio-lenny volumio[1027]: info: ------------------------------------------- Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Loading plugins from folder /volumio/app/plugins/ Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Adding plugin upnp to MyMusic Plugins Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Loading plugins from folder /data/plugins/ Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Loading plugin "system"... Nov 24 14:17:18 volumio-lenny systemd[1]: Starting Daily apt upgrade and clean activities... Nov 24 14:17:18 volumio-lenny systemd[1]: Started Samba SMB Daemon. Nov 24 14:17:18 volumio-lenny systemd[1]: Reached target Multi-User System. Nov 24 14:17:18 volumio-lenny systemd[1]: Reached target Graphical Interface. Nov 24 14:17:18 volumio-lenny systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 24 14:17:18 volumio-lenny volumio[1027]: info: Loading plugin "appearance"... Nov 24 14:17:18 volumio-lenny systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 24 14:17:18 volumio-lenny systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 24 14:17:19 volumio-lenny systemd[1]: apt-daily-upgrade.service: Succeeded. Nov 24 14:17:19 volumio-lenny systemd[1]: Started Daily apt upgrade and clean activities. Nov 24 14:17:19 volumio-lenny systemd[1]: Startup finished in 15.922s (kernel) + 35.414s (userspace) = 51.337s. Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Loading plugin "network"... Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Refreshing Cached IP Addresses Nov 24 14:17:20 volumio-lenny sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 24 14:17:20 volumio-lenny sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:20 volumio-lenny sudo[1121]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:20 volumio-lenny sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 24 14:17:20 volumio-lenny sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Loading plugin "services"... Nov 24 14:17:20 volumio-lenny sudo[1123]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Loading plugin "alsa_controller"... Nov 24 14:17:20 volumio-lenny sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 24 14:17:20 volumio-lenny sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:20 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Loading plugin "wizard"... Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Loading plugin "networkfs"... Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Starting Udev Watcher for removable devices Nov 24 14:17:20 volumio-lenny sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Lenny,password=Tamino2013#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.16/Kinder_Hoerspiel /mnt/NAS/NAS Nov 24 14:17:20 volumio-lenny sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Ignoring mount for partition: boot Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Ignoring mount for partition: volumio Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Ignoring mount for partition: volumio_data Nov 24 14:17:20 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Loading plugin "volumio_command_line_client"... Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Loading plugin "upnp"... Nov 24 14:17:20 volumio-lenny volumio[1027]: info: [1732454240767] Starting Upmpd Daemon Nov 24 14:17:20 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Loading plugin "my_music"... Nov 24 14:17:20 volumio-lenny volumio[1027]: info: Loading plugin "mpd"... Nov 24 14:17:20 volumio-lenny kernel: Key type cifs.spnego registered Nov 24 14:17:20 volumio-lenny kernel: Key type cifs.idmap registered Nov 24 14:17:20 volumio-lenny 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. Nov 24 14:17:20 volumio-lenny kernel: CIFS: Attempting to mount //192.168.10.16/Kinder_Hoerspiel Nov 24 14:17:21 volumio-lenny volumio[1027]: info: Loading plugin "upnp_browser"... Nov 24 14:17:21 volumio-lenny sudo[1147]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:21 volumio-lenny volumio[1027]: info: Loading plugin "alarm-clock"... Nov 24 14:17:21 volumio-lenny volumio[1027]: info: Loading plugin "airplay_emulation"... Nov 24 14:17:21 volumio-lenny volumio[1027]: info: Starting Shairport Sync Nov 24 14:17:21 volumio-lenny volumio[1027]: info: Loading plugin "last_100"... Nov 24 14:17:21 volumio-lenny volumio[1027]: info: Loading plugin "webradio"... Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Loading plugin "i2s_dacs"... Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Loading plugin "volumiodiscovery"... Nov 24 14:17:22 volumio-lenny volumio[1027]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 24 14:17:22 volumio-lenny volumio[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 24 14:17:22 volumio-lenny volumio[1027]: *** WARNING *** For more information see Nov 24 14:17:22 volumio-lenny volumio[1027]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 24 14:17:22 volumio-lenny volumio[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 24 14:17:22 volumio-lenny volumio[1027]: *** WARNING *** For more information see Nov 24 14:17:22 volumio-lenny node[1027]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 24 14:17:22 volumio-lenny node[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 24 14:17:22 volumio-lenny node[1027]: *** WARNING *** For more information see Nov 24 14:17:22 volumio-lenny node[1027]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 24 14:17:22 volumio-lenny node[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 24 14:17:22 volumio-lenny node[1027]: *** WARNING *** For more information see Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Discovery: Started advertising with name: Volumio-Lenny Nov 24 14:17:22 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Loading plugin "outputs"... Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Loading plugin "albumart"... Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Plugin example_plugin is not enabled Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Loading plugin "inputs"... Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Loading plugin "updater_comm"... Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Plugin mpdemulation is not enabled Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Loading plugin "rest_api"... Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Loading plugin "websocket"... Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Starting Socket.io Server version 2.3.0 Nov 24 14:17:22 volumio-lenny volumio[1027]: info: Loading plugin "fusiondsp"... Nov 24 14:17:22 volumio-lenny volumio[1027]: Forking 3 albumart workers Nov 24 14:17:23 volumio-lenny volumio[1027]: info: Applying required configuration parameters for plugin fusiondsp Nov 24 14:17:23 volumio-lenny volumio[1027]: info: Loading plugin "ir_controller"... Nov 24 14:17:23 volumio-lenny volumio[1027]: Starting albumart workers Nov 24 14:17:23 volumio-lenny volumio[1027]: Starting albumart workers Nov 24 14:17:23 volumio-lenny volumio[1027]: Starting albumart workers Nov 24 14:17:23 volumio-lenny volumio[1027]: info: Applying required configuration parameters for plugin ir_controller Nov 24 14:17:24 volumio-lenny volumio[1027]: info: Loading plugin "touch_display"... Nov 24 14:17:24 volumio-lenny sudo[1132]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:24 volumio-lenny volumio[1027]: info: Applying required configuration parameters for plugin touch_display Nov 24 14:17:24 volumio-lenny volumio[1027]: info: Loading i18n strings for locale de Nov 24 14:17:24 volumio-lenny volumio[1027]: Updating browse sources language Nov 24 14:17:24 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::initPlayerControls Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: Express server listening on port 3000 Nov 24 14:17:25 volumio-lenny volumio[1027]: [Metrics] WebUI: 8s 879.85ms Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreStateMachine::resetVolumioState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreStateMachine::getcurrentVolume Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioRetrievevolume Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Volumio Network Manager: Network status updated: 2 Nov 24 14:17:25 volumio-lenny volumio-remote-updater[494]: [2024-11-24 14:17:25] [connect] Successful connection Nov 24 14:17:25 volumio-lenny volumio[1027]: verbose: New Socket.io Connection to 192.168.10.33:3000 from 192.168.10.37 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Nov 24 14:17:25 volumio-lenny volumio[1027]: verbose: New Socket.io Connection to 192.168.10.33:3000 from 192.168.10.35 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Nov 24 14:17:25 volumio-lenny volumio[1027]: verbose: New Socket.io Connection to 192.168.10.33:3000 from 192.168.10.37 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreStateMachine::pushState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioPushState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreStateMachine::updateTrackBlock Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrackBlock Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioRetrievevolume Nov 24 14:17:25 volumio-lenny volumio[1027]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Reloading queue from file Nov 24 14:17:25 volumio-lenny volumio-remote-updater[494]: [2024-11-24 14:17:25] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732454245 101 Nov 24 14:17:25 volumio-lenny volumio[1027]: 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: 5 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Setting Device type: Raspberry PI Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreStateMachine::setRepeat false single undefined Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreStateMachine::pushState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioPushState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreStateMachine::setRandom true Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreStateMachine::pushState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioPushState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Completed loading Core Plugins Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Preparing to generate the ALSA configuration file Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreStateMachine::pushState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioPushState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 24 14:17:25 volumio-lenny volumio[1027]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Reading ALSA contributions from plugins. Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Discovery: adding 3c3e0c4d-1643-4e18-9749-e19e9dd82e5f Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Discovery: Found device Volumio-lilly Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Discovery: Connecting to remote: 192.168.10.37 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Discovery: Connected to remote: 192.168.10.37 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Discovery: adding 70411930-f22f-4939-9c5f-b590b2dbdb4d Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Discovery: Found device Volumio-Lenny Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Asound.conf file unchanged, so no further update is needed Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Output device has changed, restarting MPD Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Output device has changed, restarting Shairport Sync Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 14:17:25 volumio-lenny sudo[1251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 24 14:17:25 volumio-lenny sudo[1251]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:25 volumio-lenny sudo[1251]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:25 volumio-lenny sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 24 14:17:25 volumio-lenny sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:25 volumio-lenny systemd[1]: Stopping Music Player Daemon... Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: ___________ START PLUGINS ___________ Nov 24 14:17:25 volumio-lenny volumio[1027]: info: ControllerMpd::onStart: Initializing MPD Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Creating MPD Configuration file Nov 24 14:17:25 volumio-lenny sh[683]: timed out Nov 24 14:17:25 volumio-lenny dhcpcd[726]: timed out Nov 24 14:17:25 volumio-lenny sh[683]: dhcpcd exited Nov 24 14:17:25 volumio-lenny dhcpcd[726]: dhcpcd exited Nov 24 14:17:25 volumio-lenny sh[683]: ifup: failed to bring up eth0 Nov 24 14:17:25 volumio-lenny systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Nov 24 14:17:25 volumio-lenny systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 24 14:17:25 volumio-lenny volumio[1027]: info: [1732454245794] CoreMusicLibrary::Adding element Medienserver Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 14:17:25 volumio-lenny sudo[1263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 24 14:17:25 volumio-lenny sudo[1263]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:25 volumio-lenny sudo[1261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 24 14:17:25 volumio-lenny sudo[1261]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:25 volumio-lenny sudo[1261]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 14:17:25 volumio-lenny systemd[1]: mpd.service: Succeeded. Nov 24 14:17:25 volumio-lenny systemd[1]: Stopped Music Player Daemon. Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 24 14:17:25 volumio-lenny volumio[1027]: info: [1732454245938] CoreMusicLibrary::Adding element Last_100 Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 24 14:17:25 volumio-lenny volumio[1027]: info: [1732454245942] CoreMusicLibrary::Adding element Webradio Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 14:17:25 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 14:17:25 volumio-lenny volumio[1027]: info: Initializing BBC Radios Nov 24 14:17:25 volumio-lenny systemd[1]: Starting Music Player Daemon... Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Loading i18n strings for locale de Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: FusionDsp - mixtype--------------------- Software Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Loading i18n strings for locale de Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Loading i18n strings for locale de Nov 24 14:17:26 volumio-lenny sudo[1270]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 24 14:17:26 volumio-lenny sudo[1270]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:26 volumio-lenny sudo[1270]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Volumio Calling Home Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Preparing to generate the ALSA configuration file Nov 24 14:17:26 volumio-lenny sudo[1291]: 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 Nov 24 14:17:26 volumio-lenny sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:26 volumio-lenny sudo[1291]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:26 volumio-lenny sudo[1294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Nov 24 14:17:26 volumio-lenny sudo[1294]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:26 volumio-lenny systemd[1]: Reloading. Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Discovery: adding f548f9b2-cbf8-4e59-a6f4-c0ac70cc272d Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Discovery: Found device Volumio-Wohnzimmer Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Discovery: Connecting to remote: 192.168.10.35 Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Discovery: adding 871602d5-6896-446d-9335-ad1f29e99f14 Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Discovery: Found device Volumio-Lilly Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Discovery: Connecting to remote: 192.168.10.31 Nov 24 14:17:26 volumio-lenny volumio[1027]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 24 14:17:26 volumio-lenny volumio[1027]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Reading ALSA contributions from plugins. Nov 24 14:17:26 volumio-lenny volumio[1027]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Nov 24 14:17:26 volumio-lenny volumio[1027]: info: MPD Permissions set Nov 24 14:17:26 volumio-lenny volumio[1027]: info: MPD Permissions set Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Discovery: Connected to remote: 192.168.10.35 Nov 24 14:17:26 volumio-lenny volumio[1027]: info: Volumio called home Nov 24 14:17:26 volumio-lenny volumio[1027]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:26 volumio-lenny 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. Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 14:17:26 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Discovery: Connected to remote: 192.168.10.31 Nov 24 14:17:27 volumio-lenny volumio[1027]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Nov 24 14:17:27 volumio-lenny volumio[1027]: verbose: New Socket.io Connection to 192.168.10.33:3000 from 192.168.10.37 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Starting Shairport Sync Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Starting Shairport Sync Nov 24 14:17:27 volumio-lenny sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 24 14:17:27 volumio-lenny sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Starting Shairport Sync Nov 24 14:17:27 volumio-lenny sudo[1323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 24 14:17:27 volumio-lenny sudo[1323]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 24 14:17:27 volumio-lenny sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny volumio[1027]: info: ir_controller: LIRC correctly updated. Nov 24 14:17:27 volumio-lenny volumio[1027]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Asound.conf file unchanged, so no further update is needed Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Output device has changed, restarting MPD Nov 24 14:17:27 volumio-lenny sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 24 14:17:27 volumio-lenny sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny sudo[1329]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Output device has changed, restarting Shairport Sync Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 14:17:27 volumio-lenny sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 24 14:17:27 volumio-lenny sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny systemd[1]: systemd-hostnamed.service: Succeeded. Nov 24 14:17:27 volumio-lenny sudo[1294]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 24 14:17:27 volumio-lenny volumio[1027]: info: ir_controller: Raspberry Pi revision code: a020d3 Nov 24 14:17:27 volumio-lenny systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 24 14:17:27 volumio-lenny systemd[1]: shairport-sync.service: Succeeded. Nov 24 14:17:27 volumio-lenny systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 24 14:17:27 volumio-lenny systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 24 14:17:27 volumio-lenny systemd[1]: mpd.service: Succeeded. Nov 24 14:17:27 volumio-lenny systemd[1]: Stopped Music Player Daemon. Nov 24 14:17:27 volumio-lenny volumio[1027]: info: MPD Permissions set Nov 24 14:17:27 volumio-lenny volumio[1027]: info: touch_display: systemctl daemon-reload succeeded. Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:27 volumio-lenny systemd[1]: Starting Music Player Daemon... Nov 24 14:17:27 volumio-lenny volumio[1027]: verbose: New Socket.io Connection to 192.168.10.33:3000 from 192.168.10.31 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Nov 24 14:17:27 volumio-lenny sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Nov 24 14:17:27 volumio-lenny sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 24 14:17:27 volumio-lenny sudo[1321]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:27 volumio-lenny sudo[1318]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Shairport-Sync Started Nov 24 14:17:27 volumio-lenny sudo[1323]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:27 volumio-lenny volumio[1027]: Error adding Membership: Error: addMembership EINVAL Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny sudo[1349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1 Nov 24 14:17:27 volumio-lenny sudo[1349]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny sudo[1349]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:27 volumio-lenny systemd[1]: Started Volumio Kiosk. Nov 24 14:17:27 volumio-lenny sudo[1344]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Shairport-Sync Started Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Shairport-Sync Started Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Nov 24 14:17:27 volumio-lenny volumio[1027]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Nov 24 14:17:27 volumio-lenny volumio[1027]: info: touch_display: Volumio Kiosk started Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:27 volumio-lenny sudo[1342]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 24 14:17:27 volumio-lenny sudo[1342]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny sudo[1342]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Starting Shairport Sync Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 24 14:17:27 volumio-lenny volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 24 14:17:27 volumio-lenny sudo[1380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 24 14:17:27 volumio-lenny sudo[1380]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 24 14:17:27 volumio-lenny systemd[1]: shairport-sync.service: Succeeded. Nov 24 14:17:27 volumio-lenny systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 24 14:17:27 volumio-lenny systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 24 14:17:27 volumio-lenny volumio[1027]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Nov 24 14:17:27 volumio-lenny sudo[1380]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:27 volumio-lenny sudo[1392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=up Nov 24 14:17:27 volumio-lenny sudo[1392]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:27 volumio-lenny volumio[1027]: info: Shairport-Sync Started Nov 24 14:17:28 volumio-lenny volumio[1027]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Nov 24 14:17:28 volumio-lenny startx[1357]: X.Org X Server 1.20.4 Nov 24 14:17:28 volumio-lenny startx[1357]: X Protocol Version 11, Revision 0 Nov 24 14:17:28 volumio-lenny startx[1357]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Nov 24 14:17:28 volumio-lenny startx[1357]: Current Operating System: Linux volumio-lenny 6.6.56-v7+ #1803 SMP Thu Oct 10 14:08:55 BST 2024 armv7l Nov 24 14:17:28 volumio-lenny startx[1357]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=55b3d78d-09df-45a0-9528-d2821acfcb46 imgfile=/volumio_current.sqsh bootpart=UUID=ED43-3DA1 datapart=UUID=107aa7bf-a072-4a69-b3e3-3b9c1b955701 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Nov 24 14:17:28 volumio-lenny startx[1357]: Build Date: 04 April 2023 07:50:56AM Nov 24 14:17:28 volumio-lenny startx[1357]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Nov 24 14:17:28 volumio-lenny startx[1357]: Current version of pixman: 0.36.0 Nov 24 14:17:28 volumio-lenny startx[1357]: Before reporting problems, check http://wiki.x.org Nov 24 14:17:28 volumio-lenny startx[1357]: to make sure that you have the latest version. Nov 24 14:17:28 volumio-lenny startx[1357]: Markers: (--) probed, (**) from config file, (==) default setting, Nov 24 14:17:28 volumio-lenny startx[1357]: (++) from command line, (!!) notice, (II) informational, Nov 24 14:17:28 volumio-lenny startx[1357]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Nov 24 14:17:28 volumio-lenny startx[1357]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Nov 24 14:17:28 2024 Nov 24 14:17:28 volumio-lenny sudo[1392]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:28 volumio-lenny kernel: Registered IR keymap rc-rc6-mce Nov 24 14:17:28 volumio-lenny startx[1357]: (==) Using config directory: "/etc/X11/xorg.conf.d" Nov 24 14:17:28 volumio-lenny startx[1357]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Nov 24 14:17:28 volumio-lenny kernel: IR RC6 protocol handler initialized Nov 24 14:17:28 volumio-lenny kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0 Nov 24 14:17:28 volumio-lenny kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter Nov 24 14:17:28 volumio-lenny kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0/input10 Nov 24 14:17:28 volumio-lenny volumio[1027]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 24 14:17:28 volumio-lenny volumio[1027]: info: camilladsp service started and running in background, instance 1 Nov 24 14:17:28 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 14:17:28 volumio-lenny volumio[1027]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 24 14:17:28 volumio-lenny volumio[1027]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 24 14:17:28 volumio-lenny volumio[1027]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 24 14:17:28 volumio-lenny volumio[1027]: info: FusionDsp loaded Nov 24 14:17:28 volumio-lenny volumio[1027]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 14:17:28 volumio-lenny sudo[1420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 24 14:17:28 volumio-lenny sudo[1420]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 14:17:28 volumio-lenny volumio[1027]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 24 14:17:28 volumio-lenny volumio[1027]: info: Adding Signal Path Element [object Object] Nov 24 14:17:28 volumio-lenny volumio[1027]: info: Adding fusiondspeq DSP Signal Path Element Nov 24 14:17:28 volumio-lenny sudo[1420]: pam_unix(sudo:session): session closed for user root Nov 24 14:17:28 volumio-lenny volumio[1027]: info: FusionDsp - ---- installed callbackRead Nov 24 14:17:28 volumio-lenny volumio[1027]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 14:17:28 volumio-lenny volumio[1027]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 24 14:17:28 volumio-lenny volumio[1027]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 24 14:17:28 volumio-lenny volumio[1027]: at onErrorNT (internal/child_process.js:465:16) Nov 24 14:17:28 volumio-lenny volumio[1027]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Nov 24 14:17:28 volumio-lenny volumio[1027]: errno: -2, Nov 24 14:17:28 volumio-lenny volumio[1027]: code: 'ENOENT', Nov 24 14:17:28 volumio-lenny volumio[1027]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 24 14:17:28 volumio-lenny volumio[1027]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 24 14:17:28 volumio-lenny volumio[1027]: spawnargs: [ Nov 24 14:17:28 volumio-lenny volumio[1027]: '-p', Nov 24 14:17:28 volumio-lenny volumio[1027]: 9876, Nov 24 14:17:28 volumio-lenny volumio[1027]: '-o', Nov 24 14:17:28 volumio-lenny volumio[1027]: '/tmp/camilladsp.log', Nov 24 14:17:28 volumio-lenny volumio[1027]: '-l', Nov 24 14:17:28 volumio-lenny volumio[1027]: 'warn', Nov 24 14:17:28 volumio-lenny volumio[1027]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 24 14:17:28 volumio-lenny volumio[1027]: ] Nov 24 14:17:28 volumio-lenny volumio[1027]: } Nov 24 14:17:28 volumio-lenny volumio[1027]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 14:17:28 volumio-lenny systemd-udevd[1348]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Nov 24 14:17:28 volumio-lenny systemd-logind[484]: Watching system buttons on /dev/input/event9 (gpio_ir_recv) Nov 24 14:17:29 volumio-lenny sudo[1433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-24 14:16 Nov 24 14:17:29 volumio-lenny sudo[1433]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"