-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2024-11-20 18:57:58 CET. -- Nov 20 18:57:23 volumio systemd-timedated[1003]: Changed local time to Wed Nov 20 18:57:23 2024 Nov 20 18:57:23 volumio sudo[1001]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:23 volumio volumio-time-update[627]: volumio-time-update-util: System time updated successfully. Nov 20 18:57:23 volumio systemd[1]: Started Volumio Time Update Utility. Nov 20 18:57:24 volumio nmbd[753]: [2024/11/20 18:57:24.437447, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 20 18:57:24 volumio systemd[1]: Started Samba NMB Daemon. Nov 20 18:57:24 volumio kernel: hwmon hwmon1: Undervoltage detected! Nov 20 18:57:24 volumio nmbd[753]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 20 18:57:24 volumio systemd[1]: Starting Samba Winbind Daemon... Nov 20 18:57:25 volumio winbindd[1008]: [2024/11/20 18:57:25.175175, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 20 18:57:25 volumio winbindd[1008]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 20 18:57:25 volumio volumio[979]: info: ------------------------------------------- Nov 20 18:57:25 volumio volumio[979]: info: ----- Volumio3 ---- Nov 20 18:57:25 volumio volumio[979]: info: ------------------------------------------- Nov 20 18:57:25 volumio volumio[979]: info: ----- System startup ---- Nov 20 18:57:25 volumio volumio[979]: info: ------------------------------------------- Nov 20 18:57:25 volumio winbindd[1008]: [2024/11/20 18:57:25.219260, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 20 18:57:25 volumio systemd[1]: Started Samba Winbind Daemon. Nov 20 18:57:25 volumio winbindd[1008]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 20 18:57:25 volumio systemd[1]: Starting Samba SMB Daemon... Nov 20 18:57:26 volumio smbd[1022]: [2024/11/20 18:57:26.120352, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 20 18:57:26 volumio systemd[1]: Started Samba SMB Daemon. Nov 20 18:57:26 volumio smbd[1022]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 20 18:57:26 volumio systemd[1]: Reached target Multi-User System. Nov 20 18:57:26 volumio systemd[1]: Reached target Graphical Interface. Nov 20 18:57:26 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 20 18:57:26 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 20 18:57:26 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 20 18:57:26 volumio systemd[1]: Startup finished in 16.281s (kernel) + 29.141s (userspace) = 45.422s. Nov 20 18:57:26 volumio volumio[979]: info: MYVOLUMIO Environment detected Nov 20 18:57:27 volumio volumio[979]: info: Plugin folders cleanup Nov 20 18:57:27 volumio volumio[979]: info: Scanning into folder /volumio/app/plugins/ Nov 20 18:57:27 volumio volumio[979]: info: Scanning category audio_interface Nov 20 18:57:27 volumio volumio[979]: info: Scanning category miscellanea Nov 20 18:57:27 volumio volumio[979]: info: Scanning category music_service Nov 20 18:57:27 volumio volumio[979]: info: Scanning category plugins.json Nov 20 18:57:27 volumio volumio[979]: info: Scanning category system_controller Nov 20 18:57:27 volumio volumio[979]: info: Scanning category user_interface Nov 20 18:57:27 volumio volumio[979]: info: Scanning into folder /data/plugins/ Nov 20 18:57:27 volumio volumio[979]: info: Scanning category audio_interface Nov 20 18:57:27 volumio volumio[979]: info: Plugin folders cleanup completed Nov 20 18:57:27 volumio volumio[979]: info: ------------------------------------------- Nov 20 18:57:27 volumio volumio[979]: info: ----- Core plugins startup ---- Nov 20 18:57:27 volumio volumio[979]: info: ------------------------------------------- Nov 20 18:57:27 volumio volumio[979]: info: Loading plugins from folder /volumio/app/plugins/ Nov 20 18:57:27 volumio volumio[979]: info: Adding plugin upnp to MyMusic Plugins Nov 20 18:57:27 volumio volumio[979]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 20 18:57:27 volumio volumio[979]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 20 18:57:27 volumio volumio[979]: info: Loading plugins from folder /data/plugins/ Nov 20 18:57:27 volumio volumio[979]: info: Loading plugin "system"... Nov 20 18:57:27 volumio volumio[979]: info: No id defined. Creating one Nov 20 18:57:27 volumio volumio[979]: info: Loading plugin "appearance"... Nov 20 18:57:28 volumio kernel: hwmon hwmon1: Voltage normalised Nov 20 18:57:28 volumio volumio[979]: info: Loading plugin "network"... Nov 20 18:57:28 volumio volumio[979]: info: Refreshing Cached IP Addresses Nov 20 18:57:28 volumio sudo[1038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 20 18:57:28 volumio sudo[1038]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:28 volumio sudo[1038]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:28 volumio sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 20 18:57:28 volumio sudo[1040]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:28 volumio volumio[979]: info: Loading plugin "services"... Nov 20 18:57:28 volumio sudo[1040]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:28 volumio volumio[979]: info: Loading plugin "alsa_controller"... Nov 20 18:57:28 volumio sudo[1049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 20 18:57:28 volumio sudo[1049]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:29 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 20 18:57:29 volumio volumio[979]: info: Loading plugin "wizard"... Nov 20 18:57:29 volumio volumio[979]: info: Loading plugin "networkfs"... Nov 20 18:57:29 volumio volumio[979]: info: Starting Udev Watcher for removable devices Nov 20 18:57:29 volumio sudo[1066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Media,password=Musiclove1,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.43/music /mnt/NAS/Hardy Nov 20 18:57:29 volumio sudo[1066]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:29 volumio volumio[979]: info: Ignoring mount for partition: boot Nov 20 18:57:29 volumio volumio[979]: info: Ignoring mount for partition: volumio Nov 20 18:57:29 volumio volumio[979]: info: Ignoring mount for partition: volumio_data Nov 20 18:57:29 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 20 18:57:29 volumio volumio[979]: info: Loading plugin "volumio_command_line_client"... Nov 20 18:57:29 volumio volumio[979]: info: Loading plugin "upnp"... Nov 20 18:57:29 volumio volumio-remote-updater[635]: [2024-11-20 18:57:29] [connect] Successful connection Nov 20 18:57:29 volumio volumio[979]: info: [1732125449262] Starting Upmpd Daemon Nov 20 18:57:29 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 20 18:57:29 volumio volumio[979]: info: Loading plugin "my_music"... Nov 20 18:57:29 volumio volumio[979]: info: Loading plugin "mpd"... Nov 20 18:57:29 volumio kernel: Key type cifs.spnego registered Nov 20 18:57:29 volumio kernel: Key type cifs.idmap registered Nov 20 18:57:29 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. Nov 20 18:57:29 volumio kernel: CIFS: Attempting to mount //192.168.178.43/music Nov 20 18:57:29 volumio sudo[1049]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:29 volumio sudo[1066]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:29 volumio volumio[979]: info: Loading plugin "upnp_browser"... Nov 20 18:57:30 volumio volumio[979]: info: Loading plugin "alarm-clock"... Nov 20 18:57:30 volumio volumio[979]: info: Loading plugin "airplay_emulation"... Nov 20 18:57:30 volumio volumio[979]: info: Starting Shairport Sync Nov 20 18:57:30 volumio volumio[979]: info: Loading plugin "last_100"... Nov 20 18:57:30 volumio volumio[979]: info: Loading plugin "webradio"... Nov 20 18:57:30 volumio volumio[979]: info: Loading plugin "i2s_dacs"... Nov 20 18:57:30 volumio volumio[979]: info: I2S DAC not set, start Auto-detection Nov 20 18:57:30 volumio volumio[979]: info: Loading plugin "volumiodiscovery"... Nov 20 18:57:30 volumio volumio[979]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 20 18:57:30 volumio volumio[979]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 20 18:57:30 volumio volumio[979]: *** WARNING *** For more information see Nov 20 18:57:30 volumio volumio[979]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 20 18:57:30 volumio volumio[979]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 20 18:57:30 volumio volumio[979]: *** WARNING *** For more information see Nov 20 18:57:30 volumio node[979]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 20 18:57:30 volumio node[979]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 20 18:57:30 volumio node[979]: *** WARNING *** For more information see Nov 20 18:57:30 volumio node[979]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 20 18:57:30 volumio node[979]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 20 18:57:30 volumio node[979]: *** WARNING *** For more information see Nov 20 18:57:30 volumio volumio[979]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 20 18:57:31 volumio volumio[979]: info: Discovery: Started advertising with name: Volumio Nov 20 18:57:31 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 20 18:57:31 volumio volumio[979]: info: Loading plugin "outputs"... Nov 20 18:57:31 volumio volumio[979]: info: Loading plugin "albumart"... Nov 20 18:57:31 volumio volumio[979]: info: Plugin example_plugin is not enabled Nov 20 18:57:31 volumio volumio[979]: info: Loading plugin "inputs"... Nov 20 18:57:31 volumio volumio[979]: info: Loading plugin "updater_comm"... Nov 20 18:57:31 volumio volumio[979]: info: Plugin mpdemulation is not enabled Nov 20 18:57:31 volumio volumio[979]: info: Loading plugin "rest_api"... Nov 20 18:57:31 volumio volumio[979]: info: Loading plugin "websocket"... Nov 20 18:57:31 volumio volumio[979]: info: Starting Socket.io Server version 2.3.0 Nov 20 18:57:31 volumio volumio[979]: info: Loading plugin "fusiondsp"... Nov 20 18:57:31 volumio volumio[979]: Forking 3 albumart workers Nov 20 18:57:32 volumio volumio[979]: info: Applying required configuration parameters for plugin fusiondsp Nov 20 18:57:32 volumio systemd[1]: systemd-fsckd.service: Succeeded. Nov 20 18:57:32 volumio volumio[979]: info: Loading i18n strings for locale de Nov 20 18:57:32 volumio volumio[979]: Updating browse sources language Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 18:57:32 volumio volumio[979]: Starting albumart workers Nov 20 18:57:32 volumio volumio[979]: Starting albumart workers Nov 20 18:57:32 volumio volumio[979]: Starting albumart workers Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::initPlayerControls Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 20 18:57:32 volumio volumio[979]: Express server listening on port 3000 Nov 20 18:57:32 volumio volumio[979]: [Metrics] WebUI: 9s 606.46ms Nov 20 18:57:32 volumio volumio[979]: info: CoreStateMachine::resetVolumioState Nov 20 18:57:32 volumio volumio[979]: info: CoreStateMachine::getcurrentVolume Nov 20 18:57:32 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:33 volumio volumio[979]: info: Volumio Network Manager: Network status updated: 2 Nov 20 18:57:33 volumio volumio-remote-updater[635]: [2024-11-20 18:57:33] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732125449 101 Nov 20 18:57:33 volumio volumio[979]: 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: 1 Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Nov 20 18:57:33 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:33 volumio volumio[979]: info: VolumeController:: Volume=100 Mute =false Nov 20 18:57:33 volumio volumio[979]: info: CoreStateMachine::pushState Nov 20 18:57:33 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 20 18:57:33 volumio volumio[979]: info: CoreStateMachine::updateTrackBlock Nov 20 18:57:33 volumio volumio[979]: info: CorePlayQueue::getTrackBlock Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Nov 20 18:57:33 volumio volumio[979]: info: Reloading queue from file Nov 20 18:57:33 volumio volumio[979]: info: Setting Device type: Raspberry PI Nov 20 18:57:33 volumio volumio[979]: info: CoreStateMachine::setRepeat null single undefined Nov 20 18:57:33 volumio volumio[979]: info: CoreStateMachine::pushState Nov 20 18:57:33 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 20 18:57:33 volumio volumio[979]: info: CoreStateMachine::setRandom null Nov 20 18:57:33 volumio volumio[979]: info: CoreStateMachine::pushState Nov 20 18:57:33 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 20 18:57:33 volumio volumio[979]: info: Listing playlists Nov 20 18:57:33 volumio volumio[979]: info: Listing playlists Nov 20 18:57:33 volumio volumio[979]: info: Completed loading Core Plugins Nov 20 18:57:33 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Nov 20 18:57:33 volumio volumio[979]: info: Discovery: adding f894648e-c8ed-4d08-be24-5d4e8b32e9a6 Nov 20 18:57:33 volumio volumio[979]: info: Discovery: Found device Volumio Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Nov 20 18:57:33 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:33 volumio volumio[979]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 20 18:57:33 volumio volumio[979]: info: Reading ALSA contributions from plugins. Nov 20 18:57:33 volumio volumio[979]: info: VolumeController:: Volume=100 Mute =false Nov 20 18:57:33 volumio volumio[979]: info: CoreStateMachine::pushState Nov 20 18:57:33 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 20 18:57:33 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Nov 20 18:57:33 volumio volumio[979]: info: Output device has changed, restarting MPD Nov 20 18:57:33 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:33 volumio sudo[1158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 20 18:57:33 volumio sudo[1158]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:33 volumio sudo[1158]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:33 volumio sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 20 18:57:33 volumio sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:33 volumio systemd[1]: Stopping Music Player Daemon... Nov 20 18:57:33 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 20 18:57:33 volumio volumio[979]: info: ___________ START PLUGINS ___________ Nov 20 18:57:33 volumio volumio[979]: info: Setting Hotspot Unique name on first start: Volumio-9C2D7 Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam Nov 20 18:57:33 volumio volumio[979]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::Reload Ui Nov 20 18:57:33 volumio volumio[979]: info: ControllerMpd::onStart: Initializing MPD Nov 20 18:57:33 volumio volumio[979]: info: Creating MPD Configuration file Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 20 18:57:33 volumio volumio[979]: info: [1732125453847] CoreMusicLibrary::Adding element Medienserver Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 18:57:33 volumio sudo[1167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 20 18:57:33 volumio sudo[1167]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:33 volumio sudo[1167]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:33 volumio sudo[1169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 20 18:57:33 volumio sudo[1169]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:33 volumio systemd[1]: mpd.service: Succeeded. Nov 20 18:57:33 volumio systemd[1]: Stopped Music Player Daemon. Nov 20 18:57:33 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 20 18:57:34 volumio systemd[1]: Starting Music Player Daemon... Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 20 18:57:34 volumio volumio[979]: info: [1732125454007] CoreMusicLibrary::Adding element Last_100 Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 20 18:57:34 volumio volumio[979]: info: [1732125454012] CoreMusicLibrary::Adding element Webradio Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 20 18:57:34 volumio volumio[979]: info: Initializing BBC Radios Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: Loading i18n strings for locale de Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: FusionDsp - mixtype--------------------- Hardware Nov 20 18:57:34 volumio volumio[979]: info: Volumio Calling Home Nov 20 18:57:34 volumio sudo[1175]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 20 18:57:34 volumio sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:34 volumio sudo[1175]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:34 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Nov 20 18:57:34 volumio volumio[979]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 20 18:57:34 volumio volumio[979]: info: Reading ALSA contributions from plugins. Nov 20 18:57:34 volumio volumio[979]: info: MPD Permissions set Nov 20 18:57:34 volumio volumio[979]: info: MPD Permissions set Nov 20 18:57:34 volumio volumio[979]: info: Volumio called home Nov 20 18:57:34 volumio volumio[979]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio kernel: hwmon hwmon1: Undervoltage detected! Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:35 volumio sh[510]: timed out Nov 20 18:57:35 volumio dhcpcd[561]: timed out Nov 20 18:57:35 volumio sh[510]: dhcpcd exited Nov 20 18:57:35 volumio dhcpcd[561]: dhcpcd exited Nov 20 18:57:35 volumio sh[510]: ifup: failed to bring up eth0 Nov 20 18:57:35 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Nov 20 18:57:35 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Nov 20 18:57:35 volumio sudo[1206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Nov 20 18:57:35 volumio sudo[1206]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:35 volumio sudo[1206]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:35 volumio volumio[979]: info: Permissions for /etc/hostapd/hostapd.conf Nov 20 18:57:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Nov 20 18:57:35 volumio volumio[979]: info: Discovery: Restarting Advertising due to device name change Nov 20 18:57:35 volumio volumio[979]: info: Starting Shairport Sync Nov 20 18:57:35 volumio volumio[979]: info: Starting Shairport Sync Nov 20 18:57:35 volumio sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Nov 20 18:57:35 volumio sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:35 volumio volumio[979]: info: Starting Shairport Sync Nov 20 18:57:35 volumio sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 20 18:57:35 volumio sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:35 volumio sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 20 18:57:35 volumio systemd[1]: wireless.service: Killing process 889 (wpa_supplicant) with signal SIGKILL. Nov 20 18:57:35 volumio systemd[1]: wireless.service: Killing process 905 (dhcpcd) with signal SIGKILL. Nov 20 18:57:35 volumio sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:35 volumio systemd[1]: Stopping Wireless Services... Nov 20 18:57:35 volumio sudo[1218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 20 18:57:35 volumio sudo[1218]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:35 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 20 18:57:35 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 20 18:57:35 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:35 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Nov 20 18:57:35 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:35 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:35 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Nov 20 18:57:35 volumio volumio[979]: info: Output device has changed, restarting MPD Nov 20 18:57:35 volumio sudo[1212]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:35 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 20 18:57:35 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 20 18:57:35 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 20 18:57:35 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:35 volumio systemd[1]: wireless.service: Succeeded. Nov 20 18:57:35 volumio systemd[1]: Stopped Wireless Services. Nov 20 18:57:35 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Nov 20 18:57:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:35 volumio sudo[1223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 20 18:57:35 volumio sudo[1223]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:35 volumio sudo[1223]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:35 volumio sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 20 18:57:35 volumio systemd[1]: Starting Wireless Services... Nov 20 18:57:35 volumio sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:35 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:35 volumio sudo[1215]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:35 volumio sudo[1218]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:35 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 20 18:57:36 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 20 18:57:36 volumio systemd[1]: mpd.service: Succeeded. Nov 20 18:57:36 volumio systemd[1]: Stopped Music Player Daemon. Nov 20 18:57:36 volumio systemd[1]: Starting Music Player Daemon... Nov 20 18:57:36 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 20 18:57:36 volumio systemd[1]: mpd.service: Succeeded. Nov 20 18:57:36 volumio systemd[1]: Stopped Music Player Daemon. Nov 20 18:57:36 volumio systemd[1]: Starting Music Player Daemon... Nov 20 18:57:36 volumio volumio[979]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 20 18:57:36 volumio volumio[979]: info: camilladsp service started and running in background, instance 1 Nov 20 18:57:36 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:36 volumio volumio[979]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 20 18:57:36 volumio volumio[979]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 20 18:57:36 volumio volumio[979]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 20 18:57:36 volumio volumio[979]: info: FusionDsp loaded Nov 20 18:57:36 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 18:57:36 volumio sudo[1264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 20 18:57:36 volumio sudo[1264]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:36 volumio volumio[979]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 20 18:57:36 volumio volumio[979]: info: Adding Signal Path Element [object Object] Nov 20 18:57:36 volumio volumio[979]: info: Adding fusiondspeq DSP Signal Path Element Nov 20 18:57:36 volumio volumio[979]: info: FusionDsp - ---- installed callbackRead Nov 20 18:57:36 volumio volumio[979]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 20 18:57:36 volumio sudo[1264]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:36 volumio volumio[979]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 20 18:57:36 volumio volumio[979]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 20 18:57:36 volumio volumio[979]: at onErrorNT (internal/child_process.js:465:16) Nov 20 18:57:36 volumio volumio[979]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 20 18:57:36 volumio volumio[979]: at runNextTicks (internal/process/task_queues.js:62:3) Nov 20 18:57:36 volumio volumio[979]: at listOnTimeout (internal/timers.js:523:9) Nov 20 18:57:36 volumio volumio[979]: at processTimers (internal/timers.js:497:7) { Nov 20 18:57:36 volumio volumio[979]: errno: -2, Nov 20 18:57:36 volumio volumio[979]: code: 'ENOENT', Nov 20 18:57:36 volumio volumio[979]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 20 18:57:36 volumio volumio[979]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 20 18:57:36 volumio volumio[979]: spawnargs: [ Nov 20 18:57:36 volumio volumio[979]: '-p', Nov 20 18:57:36 volumio volumio[979]: 9876, Nov 20 18:57:36 volumio volumio[979]: '-o', Nov 20 18:57:36 volumio volumio[979]: '/tmp/camilladsp.log', Nov 20 18:57:36 volumio volumio[979]: '-l', Nov 20 18:57:36 volumio volumio[979]: 'warn', Nov 20 18:57:36 volumio volumio[979]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 20 18:57:36 volumio volumio[979]: ] Nov 20 18:57:36 volumio volumio[979]: } Nov 20 18:57:36 volumio volumio[979]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 20 18:57:36 volumio sudo[1255]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 20 18:57:36 volumio sudo[1255]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:36 volumio sudo[1255]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:37 volumio wireless.js[1228]: Cleaning previous... Nov 20 18:57:37 volumio sudo[1283]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 20 18:57:37 volumio sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:37 volumio avahi-daemon[616]: Withdrawing address record for 192.168.178.69 on wlan0. Nov 20 18:57:37 volumio avahi-daemon[616]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.69. Nov 20 18:57:37 volumio sudo[1283]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:37 volumio avahi-daemon[616]: Interface wlan0.IPv4 no longer relevant for mDNS. Nov 20 18:57:37 volumio sudo[1285]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Nov 20 18:57:37 volumio sudo[1285]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:38 volumio sudo[1285]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:38 volumio sudo[1288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-20 18:56 Nov 20 18:57:38 volumio sudo[1288]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:38 volumio sudo[1227]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:38 volumio sudo[1288]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:38 volumio sudo[1160]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:38 volumio sudo[1169]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:38 volumio wireless.js[1228]: Stopped aP Nov 20 18:57:38 volumio volumio[979]: Terminated Nov 20 18:57:38 volumio volumio[979]: child_process.js:655 Nov 20 18:57:38 volumio volumio[979]: throw err; Nov 20 18:57:38 volumio volumio[979]: ^ Nov 20 18:57:38 volumio volumio[979]: Error: Command failed: /usr/bin/sudo /bin/journalctl --since="2024-11-20 18:56" > /tmp/crashdump Nov 20 18:57:38 volumio volumio[979]: Terminated Nov 20 18:57:38 volumio volumio[979]: at checkExecSyncError (child_process.js:616:11) Nov 20 18:57:38 volumio volumio[979]: at execSync (child_process.js:652:15) Nov 20 18:57:38 volumio volumio[979]: at Object. (/volumio/crashreport.js:14:18) Nov 20 18:57:38 volumio volumio[979]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 20 18:57:38 volumio volumio[979]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 20 18:57:38 volumio volumio[979]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 20 18:57:38 volumio volumio[979]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 20 18:57:38 volumio volumio[979]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) Nov 20 18:57:38 volumio volumio[979]: at internal/main/run_main_module.js:17:47 { Nov 20 18:57:38 volumio volumio[979]: status: 143, Nov 20 18:57:38 volumio volumio[979]: signal: null, Nov 20 18:57:38 volumio volumio[979]: output: [ Nov 20 18:57:38 volumio volumio[979]: null, Nov 20 18:57:38 volumio volumio[979]: Buffer(0) [Uint8Array] [], Nov 20 18:57:38 volumio volumio[979]: Buffer(11) [Uint8Array] [ Nov 20 18:57:38 volumio volumio[979]: 84, 101, 114, 109, Nov 20 18:57:38 volumio volumio[979]: 105, 110, 97, 116, Nov 20 18:57:38 volumio volumio[979]: 101, 100, 10 Nov 20 18:57:38 volumio volumio[979]: ] Nov 20 18:57:38 volumio volumio[979]: ], Nov 20 18:57:38 volumio volumio[979]: pid: 1287, Nov 20 18:57:38 volumio volumio[979]: stdout: Buffer(0) [Uint8Array] [], Nov 20 18:57:38 volumio volumio[979]: stderr: Buffer(11) [Uint8Array] [ Nov 20 18:57:38 volumio volumio[979]: 84, 101, 114, 109, Nov 20 18:57:38 volumio volumio[979]: 105, 110, 97, 116, Nov 20 18:57:38 volumio volumio[979]: 101, 100, 10 Nov 20 18:57:38 volumio volumio[979]: ] Nov 20 18:57:38 volumio volumio[979]: } Nov 20 18:57:38 volumio sudo[1295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 20 18:57:38 volumio sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:38 volumio volumio[979]: child_process.js:655 Nov 20 18:57:38 volumio volumio[979]: throw err; Nov 20 18:57:38 volumio volumio[979]: ^ Nov 20 18:57:38 volumio volumio[979]: Error: Command failed: /usr/bin/node /volumio/crashreport.js "spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT" Nov 20 18:57:38 volumio volumio[979]: Terminated Nov 20 18:57:38 volumio volumio[979]: child_process.js:655 Nov 20 18:57:38 volumio volumio[979]: throw err; Nov 20 18:57:38 volumio volumio[979]: ^ Nov 20 18:57:38 volumio volumio[979]: Error: Command failed: /usr/bin/sudo /bin/journalctl --since="2024-11-20 18:56" > /tmp/crashdump Nov 20 18:57:38 volumio volumio[979]: Terminated Nov 20 18:57:38 volumio volumio[979]: at checkExecSyncError (child_process.js:616:11) Nov 20 18:57:38 volumio volumio[979]: at execSync (child_process.js:652:15) Nov 20 18:57:38 volumio volumio[979]: at Object. (/volumio/crashreport.js:14:18) Nov 20 18:57:38 volumio volumio[979]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 20 18:57:38 volumio volumio[979]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 20 18:57:38 volumio volumio[979]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 20 18:57:38 volumio volumio[979]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 20 18:57:38 volumio volumio[979]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) Nov 20 18:57:38 volumio volumio[979]: at internal/main/run_main_module.js:17:47 { Nov 20 18:57:38 volumio volumio[979]: status: 143, Nov 20 18:57:38 volumio volumio[979]: signal: null, Nov 20 18:57:38 volumio volumio[979]: output: [ Nov 20 18:57:38 volumio volumio[979]: null, Nov 20 18:57:38 volumio volumio[979]: Buffer(0) [Uint8Array] [], Nov 20 18:57:38 volumio volumio[979]: Buffer(11) [Uint8Array] [ Nov 20 18:57:38 volumio volumio[979]: 84, 101, 114, 109, Nov 20 18:57:38 volumio volumio[979]: 105, 110, 97, 116, Nov 20 18:57:38 volumio volumio[979]: 101, 100, 10 Nov 20 18:57:38 volumio volumio[979]: ] Nov 20 18:57:38 volumio volumio[979]: ], Nov 20 18:57:38 volumio volumio[979]: pid: 1287, Nov 20 18:57:38 volumio volumio[979]: stdout: Buffer(0) [Uint8Array] [], Nov 20 18:57:38 volumio volumio[979]: stderr: Buffer(11) [Uint8Array] [ Nov 20 18:57:38 volumio volumio[979]: 84, 101, 114, 109, Nov 20 18:57:38 volumio volumio[979]: 105, 110, 97, 116, Nov 20 18:57:38 volumio volumio[979]: 101, 100, 10 Nov 20 18:57:38 volumio volumio[979]: ] Nov 20 18:57:38 volumio volumio[979]: } Nov 20 18:57:38 volumio volumio[979]: at checkExecSyncError (child_process.js:616:11) Nov 20 18:57:38 volumio volumio[979]: at execSync (child_process.js:652:15) Nov 20 18:57:38 volumio volumio[979]: at process. (/volumio/index.js:78:3) Nov 20 18:57:38 volumio volumio[979]: at process.emit (events.js:315:20) Nov 20 18:57:38 volumio volumio[979]: at process._fatalException (internal/process/execution.js:163:25) { Nov 20 18:57:38 volumio volumio[979]: status: 1, Nov 20 18:57:38 volumio volumio[979]: signal: null, Nov 20 18:57:38 volumio volumio[979]: output: [ Nov 20 18:57:38 volumio volumio[979]: null, Nov 20 18:57:38 volumio volumio[979]: Buffer(0) [Uint8Array] [], Nov 20 18:57:38 volumio volumio[979]: Buffer(1076) [Uint8Array] [ Nov 20 18:57:38 volumio volumio[979]: 84, 101, 114, 109, 105, 110, 97, 116, 101, 100, 10, 99, Nov 20 18:57:38 volumio volumio[979]: 104, 105, 108, 100, 95, 112, 114, 111, 99, 101, 115, 115, Nov 20 18:57:38 volumio volumio[979]: 46, 106, 115, 58, 54, 53, 53, 10, 32, 32, 32, 32, Nov 20 18:57:38 volumio volumio[979]: 116, 104, 114, 111, 119, 32, 101, 114, 114, 59, 10, 32, Nov 20 18:57:38 volumio volumio[979]: 32, 32, 32, 94, 10, 10, 69, 114, 114, 111, 114, 58, Nov 20 18:57:38 volumio volumio[979]: 32, 67, 111, 109, 109, 97, 110, 100, 32, 102, 97, 105, Nov 20 18:57:38 volumio volumio[979]: 108, 101, 100, 58, 32, 47, 117, 115, 114, 47, 98, 105, Nov 20 18:57:38 volumio volumio[979]: 110, 47, 115, 117, 100, 111, 32, 47, 98, 105, 110, 47, Nov 20 18:57:38 volumio volumio[979]: 106, 111, 117, 114, Nov 20 18:57:38 volumio volumio[979]: ... 976 more items Nov 20 18:57:38 volumio volumio[979]: ] Nov 20 18:57:38 volumio volumio[979]: ], Nov 20 18:57:38 volumio volumio[979]: pid: 1266, Nov 20 18:57:38 volumio volumio[979]: stdout: Buffer(0) [Uint8Array] [], Nov 20 18:57:38 volumio volumio[979]: stderr: Buffer(1076) [Uint8Array] [ Nov 20 18:57:38 volumio volumio[979]: 84, 101, 114, 109, 105, 110, 97, 116, 101, 100, 10, 99, Nov 20 18:57:38 volumio volumio[979]: 104, 105, 108, 100, 95, 112, 114, 111, 99, 101, 115, 115, Nov 20 18:57:38 volumio volumio[979]: 46, 106, 115, 58, 54, 53, 53, 10, 32, 32, 32, 32, Nov 20 18:57:38 volumio volumio[979]: 116, 104, 114, 111, 119, 32, 101, 114, 114, 59, 10, 32, Nov 20 18:57:38 volumio volumio[979]: 32, 32, 32, 94, 10, 10, 69, 114, 114, 111, 114, 58, Nov 20 18:57:38 volumio volumio[979]: 32, 67, 111, 109, 109, 97, 110, 100, 32, 102, 97, 105, Nov 20 18:57:38 volumio volumio[979]: 108, 101, 100, 58, 32, 47, 117, 115, 114, 47, 98, 105, Nov 20 18:57:38 volumio volumio[979]: 110, 47, 115, 117, 100, 111, 32, 47, 98, 105, 110, 47, Nov 20 18:57:38 volumio volumio[979]: 106, 111, 117, 114, Nov 20 18:57:38 volumio volumio[979]: ... 976 more items Nov 20 18:57:38 volumio volumio[979]: ] Nov 20 18:57:38 volumio volumio[979]: } Nov 20 18:57:38 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 20 18:57:38 volumio sudo[1295]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:38 volumio volumio-remote-updater[635]: [2024-11-20 18:57:38] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Nov 20 18:57:38 volumio volumio-remote-updater[635]: [2024-11-20 18:57:38] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Nov 20 18:57:38 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=7/NOTRUNNING Nov 20 18:57:38 volumio sudo[1210]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:38 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 20 18:57:38 volumio sudo[1297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Nov 20 18:57:38 volumio sudo[1297]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:38 volumio sudo[1297]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:38 volumio systemd[1]: Started dynamicswap service. Nov 20 18:57:38 volumio sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 20 18:57:38 volumio sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:38 volumio sudo[1305]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:38 volumio systemd[1]: dynamicswap.service: Succeeded. Nov 20 18:57:38 volumio sudo[1312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Nov 20 18:57:38 volumio sudo[1312]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:38 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 20 18:57:38 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Nov 20 18:57:38 volumio systemd[1]: Started dynamicswap service. Nov 20 18:57:38 volumio systemd[1]: Stopped Volumio Backend Module. Nov 20 18:57:38 volumio systemd[1]: dynamicswap.service: Succeeded. Nov 20 18:57:38 volumio mpd[1269]: Nov 20 18:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 20 18:57:38 volumio systemd[1]: Started Music Player Daemon. Nov 20 18:57:38 volumio mpd_monitor.sh[631]: MPD restarted due to no mpc output. Nov 20 18:57:39 volumio sudo[1312]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:39 volumio wireless.js[1228]: SETTING APPROPRIATE REG DOMAIN: DE Nov 20 18:57:39 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Nov 20 18:57:39 volumio sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 20 18:57:39 volumio sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:39 volumio sudo[1328]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:39 volumio sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Nov 20 18:57:39 volumio sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:39 volumio sudo[1330]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:39 volumio wireless.js[1228]: SUCCESSFULLY SET NEW REGDOMAIN: DE Nov 20 18:57:39 volumio wireless.js[1228]: Start wireless flow Nov 20 18:57:39 volumio wireless.js[1228]: Stopped hotspot (if there).. Nov 20 18:57:39 volumio sudo[1335]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 20 18:57:39 volumio sudo[1335]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:39 volumio sudo[1335]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:39 volumio sudo[1338]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Nov 20 18:57:39 volumio sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:39 volumio sudo[1338]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:39 volumio wireless.js[1228]: DHCP IP Nov 20 18:57:39 volumio wireless.js[1228]: Start ap Nov 20 18:57:39 volumio wpa_supplicant[1340]: Successfully initialized wpa_supplicant Nov 20 18:57:39 volumio sudo[1341]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Nov 20 18:57:39 volumio sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:39 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 20 18:57:39 volumio dhcpcd[1342]: main: control_open: Connection refused Nov 20 18:57:39 volumio dhcpcd[1342]: dev: loaded udev Nov 20 18:57:40 volumio dhcpcd[1342]: wlan0: connected to Access Point `' Nov 20 18:57:40 volumio dhcpcd[1342]: no interfaces have a carrier Nov 20 18:57:40 volumio dhcpcd[1342]: forked to background, child pid 1389 Nov 20 18:57:40 volumio dhcpcd[1389]: eth0: waiting for carrier Nov 20 18:57:40 volumio dhcpcd[1389]: wlan0: waiting for carrier Nov 20 18:57:40 volumio sudo[1341]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:40 volumio wpa_supplicant[1370]: wlan0: Trying to associate with SSID 'FRITZ2_nomap' Nov 20 18:57:40 volumio wpa_supplicant[1370]: wlan0: Associated with 48:5d:35:42:47:96 Nov 20 18:57:40 volumio wpa_supplicant[1370]: wlan0: CTRL-EVENT-CONNECTED - Connection to 48:5d:35:42:47:96 completed [id=0 id_str=] Nov 20 18:57:40 volumio dhcpcd[1389]: wlan0: carrier acquired Nov 20 18:57:40 volumio wpa_supplicant[1370]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Nov 20 18:57:40 volumio dhcpcd[1389]: wlan0: connected to Access Point `FRITZ2_nomap' Nov 20 18:57:40 volumio wpa_supplicant[1370]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Nov 20 18:57:40 volumio dhcpcd[1389]: DUID 00:01:00:01:2e:7c:58:60:b8:27:eb:a9:d9:40 Nov 20 18:57:40 volumio dhcpcd[1389]: wlan0: IAID eb:a9:d9:40 Nov 20 18:57:40 volumio dhcpcd[1389]: wlan0: adding address fe80::29c9:282e:5f82:c183 Nov 20 18:57:40 volumio dhcpcd[1389]: ipv6_addaddr1: Permission denied Nov 20 18:57:40 volumio wireless.js[1228]: trying... Nov 20 18:57:40 volumio sudo[1392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 20 18:57:40 volumio sudo[1392]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:40 volumio sudo[1392]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:41 volumio dhcpcd[1389]: wlan0: soliciting an IPv6 router Nov 20 18:57:41 volumio dhcpcd[1389]: wlan0: rebinding lease of 192.168.178.69 Nov 20 18:57:41 volumio dhcpcd[1389]: wlan0: probing address 192.168.178.69/24 Nov 20 18:57:41 volumio wireless.js[1228]: trying... Nov 20 18:57:41 volumio sudo[1395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 20 18:57:41 volumio sudo[1395]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:41 volumio sudo[1395]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:42 volumio ntpd[755]: Deleting interface #3 wlan0, 192.168.178.69#123, interface stats: received=0, sent=0, dropped=0, active_time=21 secs Nov 20 18:57:42 volumio wireless.js[1228]: trying... Nov 20 18:57:42 volumio sudo[1398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 20 18:57:42 volumio sudo[1398]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:42 volumio sudo[1398]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:43 volumio volumio-remote-updater[635]: [2024-11-20 18:57:43] [info] asio async_connect error: system:111 (Connection refused) Nov 20 18:57:43 volumio volumio-remote-updater[635]: [2024-11-20 18:57:43] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 20 18:57:43 volumio volumio-remote-updater[635]: [2024-11-20 18:57:43] [error] handle_connect error: Underlying Transport Error Nov 20 18:57:43 volumio wireless.js[1228]: trying... Nov 20 18:57:43 volumio sudo[1401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 20 18:57:43 volumio sudo[1401]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:43 volumio sudo[1401]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:44 volumio wireless.js[1228]: trying... Nov 20 18:57:44 volumio sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 20 18:57:44 volumio sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:44 volumio sudo[1404]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:45 volumio wireless.js[1228]: trying... Nov 20 18:57:45 volumio sudo[1407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 20 18:57:45 volumio sudo[1407]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:45 volumio sudo[1407]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:46 volumio dhcpcd[1389]: wlan0: leased 192.168.178.69 for 864000 seconds Nov 20 18:57:46 volumio avahi-daemon[616]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.69. Nov 20 18:57:46 volumio dhcpcd[1389]: wlan0: adding route to 192.168.178.0/24 Nov 20 18:57:46 volumio dhcpcd[1389]: wlan0: adding default route via 192.168.178.1 Nov 20 18:57:46 volumio avahi-daemon[616]: New relevant interface wlan0.IPv4 for mDNS. Nov 20 18:57:46 volumio avahi-daemon[616]: Registering new address record for 192.168.178.69 on wlan0.IPv4. Nov 20 18:57:46 volumio wireless.js[1228]: trying... Nov 20 18:57:46 volumio sudo[1431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 20 18:57:46 volumio sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:46 volumio sudo[1431]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:46 volumio wireless.js[1228]: Connected to: ----FRITZ2_nomap Nov 20 18:57:46 volumio wireless.js[1228]: ---- Nov 20 18:57:46 volumio sudo[1434]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 20 18:57:46 volumio sudo[1434]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:46 volumio sudo[1434]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:46 volumio wireless.js[1228]: ... joined AP, wlan0 IPv4 is 192.168.178.69, ipV6 is undefined Nov 20 18:57:46 volumio wireless.js[1228]: It's done! AP Nov 20 18:57:47 volumio systemd[1]: Started Wireless Services. Nov 20 18:57:47 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 20 18:57:47 volumio systemd[1]: Started Volumio Backend Module. Nov 20 18:57:47 volumio kernel: hwmon hwmon1: Voltage normalised Nov 20 18:57:47 volumio ntpd[755]: Listen normally on 4 wlan0 192.168.178.69:123 Nov 20 18:57:47 volumio ntpd[755]: new interface(s) found: waking up resolver Nov 20 18:57:49 volumio volumio[1439]: info: ------------------------------------------- Nov 20 18:57:49 volumio volumio[1439]: info: ----- Volumio3 ---- Nov 20 18:57:49 volumio volumio[1439]: info: ------------------------------------------- Nov 20 18:57:49 volumio volumio[1439]: info: ----- System startup ---- Nov 20 18:57:49 volumio volumio[1439]: info: ------------------------------------------- Nov 20 18:57:49 volumio volumio[1439]: info: MYVOLUMIO Environment detected Nov 20 18:57:49 volumio volumio[1439]: info: Plugin folders cleanup Nov 20 18:57:49 volumio volumio[1439]: info: Scanning into folder /volumio/app/plugins/ Nov 20 18:57:49 volumio volumio[1439]: info: Scanning category audio_interface Nov 20 18:57:49 volumio volumio[1439]: info: Scanning category miscellanea Nov 20 18:57:49 volumio volumio[1439]: info: Scanning category music_service Nov 20 18:57:49 volumio volumio[1439]: info: Scanning category plugins.json Nov 20 18:57:49 volumio volumio[1439]: info: Scanning category system_controller Nov 20 18:57:49 volumio volumio[1439]: info: Scanning category user_interface Nov 20 18:57:49 volumio volumio[1439]: info: Scanning into folder /data/plugins/ Nov 20 18:57:49 volumio volumio[1439]: info: Scanning category audio_interface Nov 20 18:57:49 volumio volumio[1439]: info: Plugin folders cleanup completed Nov 20 18:57:49 volumio volumio[1439]: info: ------------------------------------------- Nov 20 18:57:49 volumio volumio[1439]: info: ----- Core plugins startup ---- Nov 20 18:57:49 volumio volumio[1439]: info: ------------------------------------------- Nov 20 18:57:49 volumio volumio[1439]: info: Loading plugins from folder /volumio/app/plugins/ Nov 20 18:57:49 volumio volumio[1439]: info: Adding plugin upnp to MyMusic Plugins Nov 20 18:57:49 volumio volumio[1439]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 20 18:57:49 volumio volumio[1439]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 20 18:57:49 volumio volumio[1439]: info: Loading plugins from folder /data/plugins/ Nov 20 18:57:49 volumio volumio[1439]: info: Loading plugin "system"... Nov 20 18:57:49 volumio volumio[1439]: info: Loading plugin "appearance"... Nov 20 18:57:50 volumio volumio-remote-updater[635]: [2024-11-20 18:57:50] [connect] Successful connection Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "network"... Nov 20 18:57:51 volumio volumio[1439]: info: Refreshing Cached IP Addresses Nov 20 18:57:51 volumio sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 20 18:57:51 volumio sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:51 volumio sudo[1464]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:51 volumio sudo[1466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 20 18:57:51 volumio sudo[1466]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:51 volumio sudo[1466]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "services"... Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "alsa_controller"... Nov 20 18:57:51 volumio sudo[1479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 20 18:57:51 volumio sudo[1479]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:51 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "wizard"... Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "networkfs"... Nov 20 18:57:51 volumio volumio[1439]: info: Cannot mount NAS Hardy at system boot, trial number 1 ,retrying in 5 seconds Nov 20 18:57:51 volumio volumio[1439]: info: Starting Udev Watcher for removable devices Nov 20 18:57:51 volumio volumio[1439]: info: Ignoring mount for partition: boot Nov 20 18:57:51 volumio volumio[1439]: info: Ignoring mount for partition: volumio Nov 20 18:57:51 volumio volumio[1439]: info: Ignoring mount for partition: volumio_data Nov 20 18:57:51 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "volumio_command_line_client"... Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "upnp"... Nov 20 18:57:51 volumio volumio[1439]: info: [1732125471332] Starting Upmpd Daemon Nov 20 18:57:51 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "my_music"... Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "mpd"... Nov 20 18:57:51 volumio volumio[1439]: info: Loading plugin "upnp_browser"... Nov 20 18:57:52 volumio sudo[1479]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "alarm-clock"... Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "airplay_emulation"... Nov 20 18:57:52 volumio volumio[1439]: info: Starting Shairport Sync Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "last_100"... Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "webradio"... Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "i2s_dacs"... Nov 20 18:57:52 volumio volumio[1439]: info: I2S DAC not set, start Auto-detection Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "volumiodiscovery"... Nov 20 18:57:52 volumio volumio[1439]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 20 18:57:52 volumio volumio[1439]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 20 18:57:52 volumio volumio[1439]: *** WARNING *** For more information see Nov 20 18:57:52 volumio node[1439]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 20 18:57:52 volumio volumio[1439]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 20 18:57:52 volumio volumio[1439]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 20 18:57:52 volumio volumio[1439]: *** WARNING *** For more information see Nov 20 18:57:52 volumio node[1439]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 20 18:57:52 volumio node[1439]: *** WARNING *** For more information see Nov 20 18:57:52 volumio node[1439]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 20 18:57:52 volumio node[1439]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 20 18:57:52 volumio node[1439]: *** WARNING *** For more information see Nov 20 18:57:52 volumio volumio[1439]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 20 18:57:52 volumio volumio[1439]: info: Discovery: Started advertising with name: Volumio Nov 20 18:57:52 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "outputs"... Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "albumart"... Nov 20 18:57:52 volumio volumio[1439]: info: Plugin example_plugin is not enabled Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "inputs"... Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "updater_comm"... Nov 20 18:57:52 volumio volumio[1439]: info: Plugin mpdemulation is not enabled Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "rest_api"... Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "websocket"... Nov 20 18:57:52 volumio volumio[1439]: info: Starting Socket.io Server version 2.3.0 Nov 20 18:57:52 volumio volumio[1439]: info: Loading plugin "fusiondsp"... Nov 20 18:57:52 volumio volumio[1439]: Forking 3 albumart workers Nov 20 18:57:53 volumio systemd[1]: systemd-timedated.service: Succeeded. Nov 20 18:57:53 volumio volumio[1439]: info: Applying required configuration parameters for plugin fusiondsp Nov 20 18:57:53 volumio volumio[1439]: info: Loading i18n strings for locale de Nov 20 18:57:53 volumio volumio[1439]: Updating browse sources language Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::initPlayerControls Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: Express server listening on port 3000 Nov 20 18:57:53 volumio volumio[1439]: [Metrics] WebUI: 5s 166.54ms Nov 20 18:57:53 volumio volumio[1439]: info: CoreStateMachine::resetVolumioState Nov 20 18:57:53 volumio volumio[1439]: info: CoreStateMachine::getcurrentVolume Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::volumioRetrievevolume Nov 20 18:57:53 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:53 volumio volumio[1439]: info: Volumio Network Manager: Network status updated: 2 Nov 20 18:57:53 volumio volumio-remote-updater[635]: [2024-11-20 18:57:53] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732125470 101 Nov 20 18:57:53 volumio volumio[1439]: 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: 1 Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioGetState Nov 20 18:57:54 volumio volumio[1439]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 18:57:54 volumio volumio[1439]: info: Discovery: Getting this device information Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioGetState Nov 20 18:57:54 volumio volumio[1439]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 18:57:54 volumio volumio[1439]: Starting albumart workers Nov 20 18:57:54 volumio volumio[1439]: Starting albumart workers Nov 20 18:57:54 volumio volumio[1439]: info: Reloading queue from file Nov 20 18:57:54 volumio volumio[1439]: Starting albumart workers Nov 20 18:57:54 volumio volumio[1439]: info: VolumeController:: Volume=100 Mute =false Nov 20 18:57:54 volumio volumio[1439]: info: CoreStateMachine::pushState Nov 20 18:57:54 volumio volumio[1439]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioPushState Nov 20 18:57:54 volumio volumio[1439]: info: CoreStateMachine::updateTrackBlock Nov 20 18:57:54 volumio volumio[1439]: info: CorePlayQueue::getTrackBlock Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioRetrievevolume Nov 20 18:57:54 volumio volumio[1439]: info: CoreStateMachine::setRepeat null single undefined Nov 20 18:57:54 volumio volumio[1439]: info: CoreStateMachine::pushState Nov 20 18:57:54 volumio volumio[1439]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioPushState Nov 20 18:57:54 volumio volumio[1439]: info: CoreStateMachine::setRandom null Nov 20 18:57:54 volumio volumio[1439]: info: CoreStateMachine::pushState Nov 20 18:57:54 volumio volumio[1439]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioPushState Nov 20 18:57:54 volumio volumio[1439]: info: Setting Device type: Raspberry PI Nov 20 18:57:54 volumio volumio[1439]: info: Listing playlists Nov 20 18:57:54 volumio volumio[1439]: info: Listing playlists Nov 20 18:57:54 volumio volumio[1439]: verbose: New Socket.io Connection to 192.168.178.69:3000 from 192.168.178.31 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioGetState Nov 20 18:57:54 volumio volumio[1439]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 20 18:57:54 volumio volumio[1439]: info: Discovery: adding f894648e-c8ed-4d08-be24-5d4e8b32e9a6 Nov 20 18:57:54 volumio volumio[1439]: info: Discovery: Found device Volumio Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioGetState Nov 20 18:57:54 volumio volumio[1439]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:54 volumio volumio[1439]: info: VolumeController:: Volume=100 Mute =false Nov 20 18:57:54 volumio volumio[1439]: info: CoreStateMachine::pushState Nov 20 18:57:54 volumio volumio[1439]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioPushState Nov 20 18:57:54 volumio volumio-remote-updater[635]: No test mode Nov 20 18:57:54 volumio volumio-remote-updater[635]: No alpha test mode Nov 20 18:57:54 volumio volumio[1439]: info: Completed loading Core Plugins Nov 20 18:57:54 volumio volumio[1439]: info: Preparing to generate the ALSA configuration file Nov 20 18:57:54 volumio volumio[1439]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 20 18:57:54 volumio volumio[1439]: info: Reading ALSA contributions from plugins. Nov 20 18:57:54 volumio volumio[1439]: info: Asound.conf file unchanged, so no further update is needed Nov 20 18:57:54 volumio volumio[1439]: info: Output device has changed, restarting MPD Nov 20 18:57:54 volumio volumio[1439]: info: Output device has changed, restarting Shairport Sync Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:54 volumio sudo[1537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:54 volumio sudo[1537]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:54 volumio sudo[1537]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:54 volumio sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 20 18:57:54 volumio sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:54 volumio systemd[1]: Stopping Music Player Daemon... Nov 20 18:57:54 volumio volumio[1439]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 20 18:57:54 volumio systemd[1]: mpd.service: Succeeded. Nov 20 18:57:54 volumio systemd[1]: Stopped Music Player Daemon. Nov 20 18:57:54 volumio volumio[1439]: info: ___________ START PLUGINS ___________ Nov 20 18:57:54 volumio volumio[1439]: info: ControllerMpd::onStart: Initializing MPD Nov 20 18:57:54 volumio volumio[1439]: info: Creating MPD Configuration file Nov 20 18:57:54 volumio systemd[1]: Starting Music Player Daemon... Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 20 18:57:54 volumio volumio[1439]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 20 18:57:55 volumio volumio[1439]: info: [1732125475000] CoreMusicLibrary::Adding element Medienserver Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:55 volumio sudo[1547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 20 18:57:55 volumio sudo[1547]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:55 volumio sudo[1549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 20 18:57:55 volumio sudo[1549]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:55 volumio sudo[1547]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:55 volumio sudo[1545]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 20 18:57:55 volumio sudo[1545]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:55 volumio sudo[1545]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:55 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 20 18:57:55 volumio systemd[1]: mpd.service: Succeeded. Nov 20 18:57:55 volumio systemd[1]: Stopped Music Player Daemon. Nov 20 18:57:55 volumio volumio[1439]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:55 volumio systemd[1]: Starting Music Player Daemon... Nov 20 18:57:55 volumio volumio[1439]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 20 18:57:55 volumio volumio[1439]: info: [1732125475268] CoreMusicLibrary::Adding element Last_100 Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 20 18:57:55 volumio volumio[1439]: info: [1732125475274] CoreMusicLibrary::Adding element Webradio Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 20 18:57:55 volumio volumio[1439]: info: Initializing BBC Radios Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: Loading i18n strings for locale de Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 20 18:57:55 volumio sudo[1559]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: FusionDsp - mixtype--------------------- Hardware Nov 20 18:57:55 volumio sudo[1559]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:55 volumio volumio[1439]: info: Volumio Calling Home Nov 20 18:57:55 volumio sudo[1559]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:55 volumio volumio[1439]: info: Preparing to generate the ALSA configuration file Nov 20 18:57:55 volumio volumio[1439]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 20 18:57:55 volumio volumio[1439]: info: Reading ALSA contributions from plugins. Nov 20 18:57:55 volumio volumio[1439]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 20 18:57:55 volumio volumio[1439]: info: MPD Permissions set Nov 20 18:57:55 volumio volumio[1439]: info: MPD Permissions set Nov 20 18:57:55 volumio volumio[1439]: info: Volumio called home Nov 20 18:57:55 volumio volumio[1439]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:55 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: Starting Shairport Sync Nov 20 18:57:56 volumio volumio[1439]: info: Starting Shairport Sync Nov 20 18:57:56 volumio volumio[1439]: info: Starting Shairport Sync Nov 20 18:57:56 volumio sudo[1607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 20 18:57:56 volumio sudo[1607]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:56 volumio sudo[1609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 20 18:57:56 volumio sudo[1609]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:56 volumio sudo[1612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 20 18:57:56 volumio sudo[1612]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::volumioGetState Nov 20 18:57:56 volumio volumio[1439]: info: CorePlayQueue::getTrack 0 Nov 20 18:57:56 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 20 18:57:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:56 volumio volumio[1439]: info: Asound.conf file unchanged, so no further update is needed Nov 20 18:57:56 volumio volumio[1439]: info: Output device has changed, restarting MPD Nov 20 18:57:56 volumio sudo[1607]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 20 18:57:56 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 20 18:57:56 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 20 18:57:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:56 volumio sudo[1612]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:56 volumio sudo[1609]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:56 volumio volumio[1439]: info: Output device has changed, restarting Shairport Sync Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:56 volumio sudo[1618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 20 18:57:56 volumio sudo[1618]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:56 volumio sudo[1621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 20 18:57:56 volumio sudo[1621]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:56 volumio sudo[1618]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:56 volumio volumio[1439]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 20 18:57:56 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 20 18:57:56 volumio systemd[1]: mpd.service: Succeeded. Nov 20 18:57:56 volumio systemd[1]: Stopped Music Player Daemon. Nov 20 18:57:56 volumio systemd[1]: Starting Music Player Daemon... Nov 20 18:57:56 volumio volumio[1439]: info: Cannot mount NAS Hardy at system boot, trial number 2 ,retrying in 5 seconds Nov 20 18:57:56 volumio volumio[1439]: info: MPD Permissions set Nov 20 18:57:56 volumio volumio[1439]: info: Shairport-Sync Started Nov 20 18:57:56 volumio volumio[1439]: Error adding Membership: Error: addMembership EINVAL Nov 20 18:57:56 volumio volumio[1439]: info: Shairport-Sync Started Nov 20 18:57:56 volumio volumio[1439]: info: Shairport-Sync Started Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:56 volumio volumio[1439]: info: Starting Shairport Sync Nov 20 18:57:56 volumio sudo[1628]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 20 18:57:56 volumio sudo[1628]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:56 volumio sudo[1628]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:56 volumio sudo[1636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 20 18:57:56 volumio sudo[1636]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 20 18:57:56 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 20 18:57:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 20 18:57:56 volumio sudo[1636]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:56 volumio volumio[1439]: info: Shairport-Sync Started Nov 20 18:57:57 volumio volumio[1439]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Nov 20 18:57:57 volumio volumio[1439]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Nov 20 18:57:57 volumio volumio[1439]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Nov 20 18:57:57 volumio volumio[1439]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 20 18:57:57 volumio volumio[1439]: info: camilladsp service started and running in background, instance 1 Nov 20 18:57:57 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 20 18:57:57 volumio volumio[1439]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 20 18:57:57 volumio volumio[1439]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 20 18:57:57 volumio volumio[1439]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 20 18:57:57 volumio volumio[1439]: info: FusionDsp loaded Nov 20 18:57:57 volumio volumio[1439]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 18:57:57 volumio sudo[1653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 20 18:57:57 volumio sudo[1653]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 18:57:57 volumio volumio[1439]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 20 18:57:57 volumio volumio[1439]: info: Adding Signal Path Element [object Object] Nov 20 18:57:57 volumio volumio[1439]: info: Adding fusiondspeq DSP Signal Path Element Nov 20 18:57:57 volumio sudo[1653]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:57 volumio volumio[1439]: info: FusionDsp - ---- installed callbackRead Nov 20 18:57:57 volumio volumio[1439]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 20 18:57:57 volumio volumio[1439]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 20 18:57:57 volumio volumio[1439]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 20 18:57:57 volumio volumio[1439]: at onErrorNT (internal/child_process.js:465:16) Nov 20 18:57:57 volumio volumio[1439]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Nov 20 18:57:57 volumio volumio[1439]: errno: -2, Nov 20 18:57:57 volumio volumio[1439]: code: 'ENOENT', Nov 20 18:57:57 volumio volumio[1439]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 20 18:57:57 volumio volumio[1439]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 20 18:57:57 volumio volumio[1439]: spawnargs: [ Nov 20 18:57:57 volumio volumio[1439]: '-p', Nov 20 18:57:57 volumio volumio[1439]: 9876, Nov 20 18:57:57 volumio volumio[1439]: '-o', Nov 20 18:57:57 volumio volumio[1439]: '/tmp/camilladsp.log', Nov 20 18:57:57 volumio volumio[1439]: '-l', Nov 20 18:57:57 volumio volumio[1439]: 'warn', Nov 20 18:57:57 volumio volumio[1439]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 20 18:57:57 volumio volumio[1439]: ] Nov 20 18:57:57 volumio volumio[1439]: } Nov 20 18:57:57 volumio volumio[1439]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 20 18:57:58 volumio mpd[1638]: Nov 20 18:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 20 18:57:58 volumio systemd[1]: Started Music Player Daemon. Nov 20 18:57:58 volumio sudo[1549]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:58 volumio sudo[1540]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:58 volumio sudo[1621]: pam_unix(sudo:session): session closed for user root Nov 20 18:57:58 volumio sudo[1666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-20 18:56 Nov 20 18:57:58 volumio sudo[1666]: 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"