-- Logs begin at Tue 2024-11-26 12:59:38 KST, end at Tue 2024-11-26 19:03:13 KST. -- Nov 26 19:02:55 music systemd-timedated[1023]: Changed local time to Tue Nov 26 19:02:55 2024 Nov 26 19:02:55 music sudo[1018]: pam_unix(sudo:session): session closed for user root Nov 26 19:02:55 music volumio-time-update[587]: volumio-time-update-util: System time updated successfully. Nov 26 19:02:55 music systemd[1]: Started Volumio Time Update Utility. Nov 26 19:02:55 music systemd[1]: Reached target Multi-User System. Nov 26 19:02:55 music systemd[1]: Reached target Graphical Interface. Nov 26 19:02:55 music systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 26 19:02:55 music systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 26 19:02:55 music systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 26 19:02:55 music systemd[1]: Startup finished in 16.522s (kernel) + 36.246s (userspace) = 52.768s. Nov 26 19:02:55 music volumio[982]: info: ------------------------------------------- Nov 26 19:02:55 music volumio[982]: info: ----- Volumio3 ---- Nov 26 19:02:55 music volumio[982]: info: ------------------------------------------- Nov 26 19:02:55 music volumio[982]: info: ----- System startup ---- Nov 26 19:02:55 music volumio[982]: info: ------------------------------------------- Nov 26 19:02:55 music nmbd[727]: [2024/11/26 19:02:55.655734, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Nov 26 19:02:55 music nmbd[727]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.28 for name WORKGROUP<1d>. Nov 26 19:02:55 music nmbd[727]: This response was from IP 192.168.1.100, reporting an IP address of 192.168.1.100. Nov 26 19:02:57 music sh[482]: timed out Nov 26 19:02:57 music dhcpcd[516]: timed out Nov 26 19:02:57 music sh[482]: dhcpcd exited Nov 26 19:02:57 music dhcpcd[516]: dhcpcd exited Nov 26 19:02:57 music sh[482]: ifup: failed to bring up eth0 Nov 26 19:02:57 music systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Nov 26 19:02:57 music systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Nov 26 19:02:57 music volumio[982]: info: MYVOLUMIO Environment detected Nov 26 19:02:57 music volumio[982]: info: Plugin folders cleanup Nov 26 19:02:57 music volumio[982]: info: Scanning into folder /volumio/app/plugins/ Nov 26 19:02:57 music volumio[982]: info: Scanning category audio_interface Nov 26 19:02:57 music volumio[982]: info: Scanning category miscellanea Nov 26 19:02:57 music volumio[982]: info: Scanning category music_service Nov 26 19:02:57 music volumio[982]: info: Scanning category plugins.json Nov 26 19:02:57 music volumio[982]: info: Scanning category system_controller Nov 26 19:02:57 music volumio[982]: info: Scanning category user_interface Nov 26 19:02:57 music volumio[982]: info: Scanning into folder /data/plugins/ Nov 26 19:02:57 music volumio[982]: info: Scanning category audio_interface Nov 26 19:02:57 music volumio[982]: info: Scanning category music_service Nov 26 19:02:57 music volumio[982]: info: Scanning category user_interface Nov 26 19:02:57 music volumio[982]: info: Plugin folders cleanup completed Nov 26 19:02:57 music volumio[982]: info: ------------------------------------------- Nov 26 19:02:57 music volumio[982]: info: ----- Core plugins startup ---- Nov 26 19:02:57 music volumio[982]: info: ------------------------------------------- Nov 26 19:02:57 music volumio[982]: info: Loading plugins from folder /volumio/app/plugins/ Nov 26 19:02:57 music volumio[982]: info: Adding plugin upnp to MyMusic Plugins Nov 26 19:02:57 music volumio[982]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 26 19:02:57 music volumio[982]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 26 19:02:57 music volumio[982]: info: Loading plugins from folder /data/plugins/ Nov 26 19:02:57 music volumio[982]: info: Loading plugin "system"... Nov 26 19:02:58 music volumio[982]: info: Loading plugin "appearance"... Nov 26 19:02:59 music volumio[982]: info: Loading plugin "network"... Nov 26 19:02:59 music volumio[982]: info: Refreshing Cached IP Addresses Nov 26 19:02:59 music sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 19:02:59 music sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:02:59 music sudo[1045]: pam_unix(sudo:session): session closed for user root Nov 26 19:02:59 music sudo[1047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 19:02:59 music sudo[1047]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:02:59 music volumio[982]: info: Loading plugin "services"... Nov 26 19:02:59 music sudo[1047]: pam_unix(sudo:session): session closed for user root Nov 26 19:02:59 music volumio[982]: info: Loading plugin "alsa_controller"... Nov 26 19:02:59 music sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 26 19:02:59 music sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:02:59 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 19:02:59 music volumio[982]: info: Loading plugin "wizard"... Nov 26 19:02:59 music volumio[982]: info: Loading plugin "networkfs"... Nov 26 19:02:59 music volumio[982]: info: Starting Udev Watcher for removable devices Nov 26 19:02:59 music sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=ezloveu,password=Kwon4824!!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.100/media\\music /mnt/NAS/ezloveu Nov 26 19:02:59 music sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:02:59 music volumio[982]: info: Ignoring mount for partition: boot Nov 26 19:02:59 music volumio[982]: info: Ignoring mount for partition: volumio Nov 26 19:02:59 music volumio[982]: info: Ignoring mount for partition: volumio_data Nov 26 19:02:59 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 19:02:59 music volumio[982]: info: Loading plugin "volumio_command_line_client"... Nov 26 19:02:59 music volumio[982]: info: Loading plugin "upnp"... Nov 26 19:02:59 music volumio[982]: info: [1732615379909] Starting Upmpd Daemon Nov 26 19:02:59 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 19:02:59 music volumio[982]: info: Loading plugin "my_music"... Nov 26 19:02:59 music volumio[982]: info: Loading plugin "mpd"... Nov 26 19:03:00 music kernel: Key type cifs.spnego registered Nov 26 19:03:00 music kernel: Key type cifs.idmap registered Nov 26 19:03:00 music 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 26 19:03:00 music kernel: CIFS: Attempting to mount //192.168.1.100/media/music Nov 26 19:03:00 music sudo[1071]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:00 music volumio[982]: info: Loading plugin "upnp_browser"... Nov 26 19:03:01 music volumio-remote-updater[572]: [2024-11-26 19:03:01] [connect] Successful connection Nov 26 19:03:01 music systemd[1]: systemd-hostnamed.service: Succeeded. Nov 26 19:03:01 music volumio[982]: info: Loading plugin "alarm-clock"... Nov 26 19:03:02 music volumio[982]: info: Loading plugin "airplay_emulation"... Nov 26 19:03:02 music volumio[982]: info: Starting Shairport Sync Nov 26 19:03:02 music volumio[982]: info: Loading plugin "last_100"... Nov 26 19:03:02 music volumio[982]: info: Loading plugin "webradio"... Nov 26 19:03:02 music volumio[982]: info: Loading plugin "i2s_dacs"... Nov 26 19:03:02 music volumio[982]: info: Loading plugin "volumiodiscovery"... Nov 26 19:03:02 music volumio[982]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 19:03:02 music volumio[982]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 19:03:02 music volumio[982]: *** WARNING *** For more information see Nov 26 19:03:02 music node[982]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 19:03:02 music volumio[982]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 19:03:02 music volumio[982]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 19:03:02 music volumio[982]: *** WARNING *** For more information see Nov 26 19:03:02 music node[982]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 19:03:02 music node[982]: *** WARNING *** For more information see Nov 26 19:03:02 music node[982]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 19:03:02 music node[982]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 19:03:02 music node[982]: *** WARNING *** For more information see Nov 26 19:03:02 music volumio[982]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 26 19:03:02 music volumio[982]: info: Discovery: Started advertising with name: Music Nov 26 19:03:02 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 19:03:02 music volumio[982]: info: Loading plugin "ytmusic"... Nov 26 19:03:03 music sudo[1056]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:04 music volumio[982]: info: Loading plugin "now_playing"... Nov 26 19:03:05 music kernel: hwmon hwmon1: Voltage normalised Nov 26 19:03:06 music volumio[982]: info: Loading plugin "outputs"... Nov 26 19:03:06 music volumio[982]: info: Loading plugin "albumart"... Nov 26 19:03:06 music volumio[982]: info: Plugin example_plugin is not enabled Nov 26 19:03:06 music volumio[982]: info: Loading plugin "inputs"... Nov 26 19:03:06 music volumio[982]: info: Loading plugin "updater_comm"... Nov 26 19:03:06 music volumio[982]: info: Plugin mpdemulation is not enabled Nov 26 19:03:06 music volumio[982]: info: Loading plugin "rest_api"... Nov 26 19:03:06 music volumio[982]: info: Loading plugin "websocket"... Nov 26 19:03:06 music volumio[982]: info: Starting Socket.io Server version 2.3.0 Nov 26 19:03:06 music volumio[982]: info: Loading plugin "fusiondsp"... Nov 26 19:03:06 music volumio[982]: Forking 3 albumart workers Nov 26 19:03:07 music volumio[982]: info: Applying required configuration parameters for plugin fusiondsp Nov 26 19:03:07 music volumio[982]: info: Loading plugin "touch_display"... Nov 26 19:03:07 music volumio[982]: Starting albumart workers Nov 26 19:03:07 music volumio[982]: Starting albumart workers Nov 26 19:03:07 music volumio[982]: Starting albumart workers Nov 26 19:03:08 music volumio[982]: info: Applying required configuration parameters for plugin touch_display Nov 26 19:03:08 music volumio[982]: info: Loading i18n strings for locale ko Nov 26 19:03:08 music volumio[982]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Nov 26 19:03:08 music volumio[982]: Updating browse sources language Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::initPlayerControls Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 19:03:08 music volumio[982]: Express server listening on port 3000 Nov 26 19:03:08 music volumio[982]: [Metrics] WebUI: 15s 33.77ms Nov 26 19:03:08 music volumio[982]: info: CoreStateMachine::resetVolumioState Nov 26 19:03:08 music volumio[982]: info: CoreStateMachine::getcurrentVolume Nov 26 19:03:08 music volumio[982]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 19:03:08 music volumio[982]: info: Volumio Network Manager: Network status updated: 2 Nov 26 19:03:09 music volumio[982]: info: CoreStateMachine::pushState Nov 26 19:03:09 music volumio[982]: info: CorePlayQueue::getTrack 0 Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioPushState Nov 26 19:03:09 music volumio[982]: info: CoreStateMachine::updateTrackBlock Nov 26 19:03:09 music volumio[982]: info: CorePlayQueue::getTrackBlock Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 19:03:09 music volumio[982]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 19:03:09 music volumio[982]: info: Executing start script for DAC IQaudIO DAC Plus Nov 26 19:03:09 music volumio[982]: info: Reloading queue from file Nov 26 19:03:09 music volumio[982]: info: Setting Device type: Raspberry PI Nov 26 19:03:09 music volumio[982]: info: CoreStateMachine::setRepeat null single undefined Nov 26 19:03:09 music volumio[982]: info: CoreStateMachine::pushState Nov 26 19:03:09 music volumio[982]: info: CorePlayQueue::getTrack 0 Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioPushState Nov 26 19:03:09 music volumio[982]: info: CoreStateMachine::setRandom true Nov 26 19:03:09 music volumio[982]: info: CoreStateMachine::pushState Nov 26 19:03:09 music volumio[982]: info: CorePlayQueue::getTrack 0 Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioPushState Nov 26 19:03:09 music volumio[982]: info: DAC script executed Nov 26 19:03:09 music volumio[982]: info: Completed loading Core Plugins Nov 26 19:03:09 music volumio[982]: info: Preparing to generate the ALSA configuration file Nov 26 19:03:09 music volumio[982]: info: CoreStateMachine::pushState Nov 26 19:03:09 music volumio[982]: info: CorePlayQueue::getTrack 0 Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioPushState Nov 26 19:03:09 music volumio[982]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 26 19:03:09 music volumio[982]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 26 19:03:09 music volumio[982]: info: Reading ALSA contributions from plugins. Nov 26 19:03:09 music volumio[982]: info: Discovery: adding 007a70af-99fc-452a-9e77-69b9f7536565 Nov 26 19:03:09 music volumio[982]: info: Discovery: Found device Music Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioGetState Nov 26 19:03:09 music volumio[982]: info: CorePlayQueue::getTrack 0 Nov 26 19:03:09 music volumio[982]: info: Asound.conf file unchanged, so no further update is needed Nov 26 19:03:09 music volumio[982]: info: Output device has changed, restarting MPD Nov 26 19:03:09 music volumio[982]: info: Output device has changed, restarting Shairport Sync Nov 26 19:03:09 music sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 19:03:09 music sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:09 music sudo[1181]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:09 music sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 19:03:09 music sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:09 music systemd[1]: Stopping Music Player Daemon... Nov 26 19:03:09 music volumio[982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 19:03:09 music volumio[982]: info: ___________ START PLUGINS ___________ Nov 26 19:03:09 music volumio[982]: info: ControllerMpd::onStart: Initializing MPD Nov 26 19:03:09 music volumio[982]: info: Creating MPD Configuration file Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 19:03:09 music volumio[982]: info: [1732615389525] CoreMusicLibrary::Adding element 미디어 서버 Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 19:03:09 music sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 19:03:09 music sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:09 music sudo[1192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 19:03:09 music sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:09 music sudo[1190]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 19:03:09 music volumio[982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 19:03:09 music systemd[1]: mpd.service: Succeeded. Nov 26 19:03:09 music systemd[1]: Stopped Music Player Daemon. Nov 26 19:03:09 music volumio[982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 19:03:09 music volumio[982]: info: [1732615389658] CoreMusicLibrary::Adding element Last_100 Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 19:03:09 music volumio[982]: info: [1732615389661] CoreMusicLibrary::Adding element Webradio Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 19:03:09 music volumio[982]: info: Initializing BBC Radios Nov 26 19:03:09 music systemd[1]: Starting Music Player Daemon... Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 19:03:09 music volumio[982]: info: [1732615389754] CoreMusicLibrary::Adding element YouTube Music Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 19:03:09 music volumio[982]: Cannot find translation for source YouTube Music Nov 26 19:03:09 music volumio[982]: info: [now-playing] ConfigUpdater: config is up to date. Nov 26 19:03:09 music volumio[982]: info: Loading i18n strings for locale ko Nov 26 19:03:09 music volumio[982]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:09 music volumio[982]: info: FusionDsp - mixtype--------------------- Software Nov 26 19:03:09 music volumio[982]: info: Loading i18n strings for locale ko Nov 26 19:03:09 music volumio[982]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Nov 26 19:03:09 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 19:03:09 music volumio[982]: info: Volumio Calling Home Nov 26 19:03:09 music sudo[1199]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 19:03:09 music sudo[1199]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:09 music sudo[1199]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:09 music volumio[982]: info: Preparing to generate the ALSA configuration file Nov 26 19:03:09 music sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Nov 26 19:03:09 music sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:09 music sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Nov 26 19:03:09 music sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Nov 26 19:03:10 music sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music systemd[1]: Reloading. Nov 26 19:03:10 music volumio[982]: info: [now-playing] App is listening on port 4004. Nov 26 19:03:10 music volumio[982]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Nov 26 19:03:10 music volumio[982]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 26 19:03:10 music volumio[982]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 26 19:03:10 music volumio[982]: info: Reading ALSA contributions from plugins. Nov 26 19:03:10 music volumio[982]: info: touch_display: Backlight interface detected. Nov 26 19:03:10 music sudo[1254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 19:03:10 music sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music sudo[1254]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:10 music sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 19:03:10 music sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music volumio[982]: info: MPD Permissions set Nov 26 19:03:10 music volumio[982]: info: MPD Permissions set Nov 26 19:03:10 music sudo[1256]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:10 music volumio[982]: 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 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:10 music 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 26 19:03:10 music volumio[982]: info: touch_display: Raspberry Pi Foundation touch screen detected. Nov 26 19:03:10 music volumio[982]: info: Volumio called home Nov 26 19:03:10 music sudo[1268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Nov 26 19:03:10 music sudo[1268]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music sudo[1268]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:10 music sudo[1271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/rpi_backlight/brightness Nov 26 19:03:10 music sudo[1271]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music sudo[1271]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:10 music volumio[982]: info: Starting Shairport Sync Nov 26 19:03:10 music volumio[982]: info: Starting Shairport Sync Nov 26 19:03:10 music sudo[1274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 26 19:03:10 music sudo[1274]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music volumio[982]: info: Starting Shairport Sync Nov 26 19:03:10 music sudo[1279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 26 19:03:10 music sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 26 19:03:10 music sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music sudo[1279]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music sudo[1283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 26 19:03:10 music sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:10 music volumio[982]: info: CoreCommandRouter::volumioGetState Nov 26 19:03:10 music volumio[982]: info: CorePlayQueue::getTrack 0 Nov 26 19:03:10 music volumio[982]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Nov 26 19:03:11 music volumio[982]: info: touch_display: File permissions for backlight brightness control set. Nov 26 19:03:11 music volumio[982]: info: Asound.conf file unchanged, so no further update is needed Nov 26 19:03:11 music volumio[982]: info: Output device has changed, restarting MPD Nov 26 19:03:11 music sudo[1286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 19:03:11 music sudo[1286]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:11 music volumio[982]: info: Output device has changed, restarting Shairport Sync Nov 26 19:03:11 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:11 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 19:03:11 music sudo[1286]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:11 music sudo[1288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 19:03:11 music sudo[1288]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:11 music volumio[982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 19:03:11 music volumio[982]: info: MPD Permissions set Nov 26 19:03:11 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:11 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 19:03:11 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:11 music volumio[982]: info: Starting Shairport Sync Nov 26 19:03:11 music kernel: hwmon hwmon1: Undervoltage detected! Nov 26 19:03:11 music sudo[1301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 26 19:03:11 music sudo[1237]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:11 music sudo[1301]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:11 music volumio[982]: info: touch_display: systemctl daemon-reload succeeded. Nov 26 19:03:11 music systemd[1]: Reloading. Nov 26 19:03:11 music sudo[1304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Nov 26 19:03:11 music sudo[1304]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:11 music volumio[982]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 26 19:03:11 music volumio[982]: info: camilladsp service started and running in background, instance 1 Nov 26 19:03:11 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 19:03:12 music volumio[982]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 26 19:03:12 music volumio[982]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 26 19:03:12 music volumio[982]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 26 19:03:12 music volumio[982]: info: FusionDsp loaded Nov 26 19:03:12 music volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 19:03:12 music sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 26 19:03:12 music sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 19:03:12 music volumio[982]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 26 19:03:12 music volumio[982]: info: Adding Signal Path Element [object Object] Nov 26 19:03:12 music volumio[982]: info: Adding fusiondspeq DSP Signal Path Element Nov 26 19:03:12 music volumio[982]: info: FusionDsp - ---- installed callbackRead Nov 26 19:03:12 music volumio[982]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 19:03:12 music volumio[982]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 26 19:03:12 music volumio[982]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 26 19:03:12 music volumio[982]: at onErrorNT (internal/child_process.js:465:16) Nov 26 19:03:12 music volumio[982]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Nov 26 19:03:12 music volumio[982]: errno: -2, Nov 26 19:03:12 music volumio[982]: code: 'ENOENT', Nov 26 19:03:12 music volumio[982]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 26 19:03:12 music volumio[982]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 26 19:03:12 music volumio[982]: spawnargs: [ Nov 26 19:03:12 music volumio[982]: '-p', Nov 26 19:03:12 music volumio[982]: 9876, Nov 26 19:03:12 music volumio[982]: '-o', Nov 26 19:03:12 music volumio[982]: '/tmp/camilladsp.log', Nov 26 19:03:12 music volumio[982]: '-l', Nov 26 19:03:12 music volumio[982]: 'warn', Nov 26 19:03:12 music volumio[982]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 26 19:03:12 music volumio[982]: ] Nov 26 19:03:12 music volumio[982]: } Nov 26 19:03:12 music volumio[982]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 19:03:12 music 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 26 19:03:12 music mpd[1228]: Nov 26 19:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 26 19:03:13 music systemd[1]: Started Music Player Daemon. Nov 26 19:03:13 music sudo[1183]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:13 music sudo[1192]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:13 music sudo[1234]: pam_unix(sudo:session): session closed for user root Nov 26 19:03:13 music sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 19:02 Nov 26 19:03:13 music sudo[1343]: 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"